builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1490116314.71 results: success (0) buildid: 20170321091924 builduid: 36d623071e35492b8224247f468f9041 revision: 4a0aabf1af708c0caf38c02dd0e877ab35734183 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.706911) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.707367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.707635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.793351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.793915) ========= 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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 10:11:54-- 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% 173M=0s 2017-03-21 10:11:54 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.941415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.941720) ========= 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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.029043 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:54.992274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 10:11:54.992614) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a0aabf1af708c0caf38c02dd0e877ab35734183 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a0aabf1af708c0caf38c02dd0e877ab35734183 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 10:11:55,101 truncating revision to first 12 chars 2017-03-21 10:11:55,101 Setting DEBUG logging. 2017-03-21 10:11:55,101 attempt 1/10 2017-03-21 10:11:55,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a0aabf1af70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 10:11:56,371 unpacking tar archive at: mozilla-beta-4a0aabf1af70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.545173 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 10:11:56.827611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:56.831003) ========= script_repo_revision: 4a0aabf1af708c0caf38c02dd0e877ab35734183 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:56.831423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:56.831694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 10:11:56.852365) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-21 10:11:56.852709) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:11:57 INFO - MultiFileLogger online at 20170321 10:11:57 in /builds/slave/test 10:11:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:11:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:57 INFO - {'append_to_log': False, 10:11:57 INFO - 'base_work_dir': '/builds/slave/test', 10:11:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:11:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:57 INFO - 'branch': 'Mozilla-Beta', 10:11:57 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:57 INFO - 'config_files': ('talos/mac_config.py',), 10:11:57 INFO - 'default_actions': ('clobber', 10:11:57 INFO - 'read-buildbot-config', 10:11:57 INFO - 'download-and-extract', 10:11:57 INFO - 'populate-webroot', 10:11:57 INFO - 'create-virtualenv', 10:11:57 INFO - 'install', 10:11:57 INFO - 'run-tests'), 10:11:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:57 INFO - 'download_minidump_stackwalk': True, 10:11:57 INFO - 'download_symbols': 'ondemand', 10:11:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:57 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:57 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:57 INFO - 'installer_path': 'installer.exe', 10:11:57 INFO - 'log_level': 'info', 10:11:57 INFO - 'log_name': 'talos', 10:11:57 INFO - 'log_to_console': True, 10:11:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:11:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:11:57 INFO - 'opt_config_files': (), 10:11:57 INFO - 'pip_index': False, 10:11:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:11:57 INFO - 'cmd': ('bash', 10:11:57 INFO - '-c', 10:11:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:11:57 INFO - 'enabled': True, 10:11:57 INFO - 'halt_on_failure': False, 10:11:57 INFO - 'name': 'check_screen_resolution'},), 10:11:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:11:57 INFO - 'cmd': ('bash', 10:11:57 INFO - '-c', 10:11:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:11:57 INFO - 'enabled': True, 10:11:57 INFO - 'halt_on_failure': False, 10:11:57 INFO - 'name': 'check_screen_resolution'},), 10:11:57 INFO - 'run_cmd_checks_enabled': True, 10:11:57 INFO - 'sps_profile': False, 10:11:57 INFO - 'sps_profile_interval': 0, 10:11:57 INFO - 'suite': 'dromaeojs-e10s', 10:11:57 INFO - 'system_bits': '32', 10:11:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:57 INFO - 'title': 't-yosemite-r7-0014', 10:11:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:57 INFO - 'use_talos_json': True, 10:11:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:57 INFO - 'work_dir': 'build'} 10:11:57 INFO - [mozharness: 2017-03-21 17:11:57.072436Z] Running clobber step. 10:11:57 INFO - Running pre-action listener: _resource_record_pre_action 10:11:57 INFO - Running main action method: clobber 10:11:57 INFO - rmtree: /builds/slave/test/build 10:11:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:59 INFO - Running post-action listener: _resource_record_post_action 10:11:59 INFO - [mozharness: 2017-03-21 17:11:59.598829Z] Finished clobber step (success) 10:11:59 INFO - [mozharness: 2017-03-21 17:11:59.599074Z] Running read-buildbot-config step. 10:11:59 INFO - Running pre-action listener: _resource_record_pre_action 10:11:59 INFO - Running main action method: read_buildbot_config 10:11:59 INFO - Using buildbot properties: 10:11:59 INFO - { 10:11:59 INFO - "project": "", 10:11:59 INFO - "product": "firefox", 10:11:59 INFO - "script_repo_revision": "production", 10:11:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:11:59 INFO - "repository": "", 10:11:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:11:59 INFO - "buildid": "20170321091924", 10:11:59 INFO - "pgo_build": "False", 10:11:59 INFO - "basedir": "/builds/slave/test", 10:11:59 INFO - "buildnumber": 10, 10:11:59 INFO - "slavename": "t-yosemite-r7-0014", 10:11:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:11:59 INFO - "platform": "yosemite_r7", 10:11:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:11:59 INFO - "branch": "mozilla-beta", 10:11:59 INFO - "repo_path": "releases/mozilla-beta", 10:11:59 INFO - "revision": "4a0aabf1af708c0caf38c02dd0e877ab35734183", 10:11:59 INFO - "stage_platform": "macosx64", 10:11:59 INFO - "builduid": "36d623071e35492b8224247f468f9041", 10:11:59 INFO - "slavebuilddir": "test" 10:11:59 INFO - } 10:11:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 10:11:59 INFO - Running post-action listener: _resource_record_post_action 10:11:59 INFO - [mozharness: 2017-03-21 17:11:59.604823Z] Finished read-buildbot-config step (success) 10:11:59 INFO - [mozharness: 2017-03-21 17:11:59.605025Z] Running download-and-extract step. 10:11:59 INFO - Running pre-action listener: _resource_record_pre_action 10:11:59 INFO - Running main action method: download_and_extract 10:11:59 INFO - mkdir: /builds/slave/test/build/tests 10:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:11:59 INFO - trying https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 10:11:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 10:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 10:12:00 INFO - Downloaded 1165 bytes. 10:12:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 10:12:00 INFO - Using the following test package requirements: 10:12:00 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 10:12:00 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 10:12:00 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 10:12:00 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:12:00 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 10:12:00 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 10:12:00 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 10:12:00 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 10:12:00 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 10:12:00 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 10:12:00 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 10:12:00 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 10:12:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 10:12:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 10:12:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 10:12:01 INFO - Expected file size: 16108180 10:12:01 INFO - Obtained file size: 16108180 10:12:08 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:12:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 10:12:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 10:12:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 10:12:09 INFO - Expected file size: 16108180 10:12:09 INFO - Obtained file size: 16108180 10:12:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 10:12:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 10:12:16 INFO - Fetch https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 10:12:17 INFO - Expected file size: 14403663 10:12:17 INFO - Obtained file size: 14403663 10:12: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')]} 10:12:17 INFO - trying https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 10:12:17 INFO - Downloading https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 10:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 10:12:19 INFO - Downloaded 58736840 bytes. 10:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 10:12:19 INFO - mkdir: /builds/slave/test/properties 10:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:19 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:19 INFO - Contents: 10:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - Running post-action listener: set_extra_try_arguments 10:12:20 INFO - [mozharness: 2017-03-21 17:12:20.146841Z] Finished download-and-extract step (success) 10:12:20 INFO - [mozharness: 2017-03-21 17:12:20.146972Z] Running populate-webroot step. 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: populate_webroot 10:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:20 INFO - '--tppagecycles', 10:12:20 INFO - '7'], 10:12:20 INFO - 'tests': ['tsvgm']}}, 10:12:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['damp', 'tps']}, 10:12:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'tests': ['damp', 'tps']}, 10:12:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['dromaeo_dom']}, 10:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['basic_compositor_video']}, 10:12:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:12:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['a11yr', 10:12:20 INFO - 'ts_paint', 10:12:20 INFO - 'tpaint', 10:12:20 INFO - 'sessionrestore', 10:12:20 INFO - 'sessionrestore_no_auto_restore', 10:12:20 INFO - 'tabpaint']}, 10:12:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['tsvgx', 10:12:20 INFO - 'tsvgr_opacity', 10:12:20 INFO - 'tart', 10:12:20 INFO - 'tscrollx', 10:12:20 INFO - 'cart', 10:12:20 INFO - 'tsvg_static']}, 10:12:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:20 INFO - 'tsvgr_opacity', 10:12:20 INFO - 'tart', 10:12:20 INFO - 'tscrollx', 10:12:20 INFO - 'cart', 10:12:20 INFO - 'tsvg_static']}, 10:12:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'talos_options': ['--disable-e10s'], 10:12:20 INFO - 'tests': ['tp5o']}, 10:12:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:12:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'talos_options': ['--disable-e10s', 10:12:20 INFO - '--xperf_path', 10:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:20 INFO - 'tests': ['tp5n']}, 10:12:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:12:20 INFO - 'talos_options': ['--xperf_path', 10:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:20 INFO - 'tests': ['tp5n']}}, 10:12:20 INFO - 'talos.zip': {'path': '', 10:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - [mozharness: 2017-03-21 17:12:20.165999Z] Finished populate-webroot step (success) 10:12:20 INFO - [mozharness: 2017-03-21 17:12:20.166131Z] Running create-virtualenv step. 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: create_virtualenv 10:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:20 INFO - Using real prefix '/tools/python27' 10:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:21 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:23 INFO - Installing pip.................done. 10:12:23 INFO - Return code: 0 10:12:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:12:24 INFO - Reading from file tmpfile_stdout 10:12:24 INFO - Output received: 10:12:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:12:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12: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', 'pip>=1.5'] in /builds/slave/test/build 10:12: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 pip>=1.5 10:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:24 INFO - 'HOME': '/Users/cltbld', 10:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:24 INFO - 'LOGNAME': 'cltbld', 10:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:24 INFO - 'MOZ_NO_REMOTE': '1', 10:12:24 INFO - 'NO_EM_RESTART': '1', 10:12:24 INFO - 'PAGER': '/bin/cat', 10:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:24 INFO - 'PWD': '/builds/slave/test', 10:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:24 INFO - 'SHELL': '/bin/bash', 10:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:24 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:24 INFO - 'USER': 'cltbld', 10:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:24 INFO - 'XPC_FLAGS': '0x0', 10:12:24 INFO - 'XPC_SERVICE_NAME': '0', 10:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:12:24 INFO - Cleaning up... 10:12:24 INFO - Return code: 0 10:12:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', '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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12: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', 'psutil>=3.1.1'] in /builds/slave/test/build 10:12: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 psutil>=3.1.1 10:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:24 INFO - 'HOME': '/Users/cltbld', 10:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:24 INFO - 'LOGNAME': 'cltbld', 10:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:24 INFO - 'MOZ_NO_REMOTE': '1', 10:12:24 INFO - 'NO_EM_RESTART': '1', 10:12:24 INFO - 'PAGER': '/bin/cat', 10:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:24 INFO - 'PWD': '/builds/slave/test', 10:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:24 INFO - 'SHELL': '/bin/bash', 10:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:24 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:24 INFO - 'USER': 'cltbld', 10:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:24 INFO - 'XPC_FLAGS': '0x0', 10:12:24 INFO - 'XPC_SERVICE_NAME': '0', 10:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:24 INFO - Downloading/unpacking psutil>=3.1.1 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:28 INFO - Installing collected packages: psutil 10:12:28 INFO - Running setup.py install for psutil 10:12:28 INFO - building 'psutil._psutil_osx' extension 10:12:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:12:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:12:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:12:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:12:29 INFO - building 'psutil._psutil_posix' extension 10:12:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:12:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:12:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:12:29 INFO - ^ 10:12:29 INFO - 1 warning generated. 10:12:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:12:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:29 INFO - Successfully installed psutil 10:12:29 INFO - Cleaning up... 10:12:29 INFO - Return code: 0 10:12:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:29 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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:29 INFO - 'HOME': '/Users/cltbld', 10:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:29 INFO - 'LOGNAME': 'cltbld', 10:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:29 INFO - 'MOZ_NO_REMOTE': '1', 10:12:29 INFO - 'NO_EM_RESTART': '1', 10:12:29 INFO - 'PAGER': '/bin/cat', 10:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:29 INFO - 'PWD': '/builds/slave/test', 10:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:29 INFO - 'SHELL': '/bin/bash', 10:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:29 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:29 INFO - 'USER': 'cltbld', 10:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:29 INFO - 'XPC_FLAGS': '0x0', 10:12:29 INFO - 'XPC_SERVICE_NAME': '0', 10:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:12:32 INFO - Installing collected packages: mozsystemmonitor 10:12:32 INFO - Running setup.py install for mozsystemmonitor 10:12:32 INFO - Successfully installed mozsystemmonitor 10:12:32 INFO - Cleaning up... 10:12:32 INFO - Return code: 0 10:12:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:12:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:32 INFO - 'HOME': '/Users/cltbld', 10:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:32 INFO - 'LOGNAME': 'cltbld', 10:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:32 INFO - 'MOZ_NO_REMOTE': '1', 10:12:32 INFO - 'NO_EM_RESTART': '1', 10:12:32 INFO - 'PAGER': '/bin/cat', 10:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:32 INFO - 'PWD': '/builds/slave/test', 10:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:32 INFO - 'SHELL': '/bin/bash', 10:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:32 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:32 INFO - 'USER': 'cltbld', 10:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:32 INFO - 'XPC_FLAGS': '0x0', 10:12:32 INFO - 'XPC_SERVICE_NAME': '0', 10:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:32 INFO - Downloading/unpacking jsonschema==2.5.1 10:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:36 INFO - warning: no files found matching '*.txt' 10:12:36 INFO - no previously-included directories found matching 'build' 10:12:36 INFO - no previously-included directories found matching 'dist' 10:12:36 INFO - no previously-included directories found matching '.git*' 10:12:36 INFO - Installing collected packages: jsonschema, functools32 10:12:36 INFO - Running setup.py install for functools32 10:12:36 INFO - warning: no files found matching '*.txt' 10:12:36 INFO - no previously-included directories found matching 'build' 10:12:36 INFO - no previously-included directories found matching 'dist' 10:12:36 INFO - no previously-included directories found matching '.git*' 10:12:36 INFO - Successfully installed jsonschema functools32 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:36 INFO - 'HOME': '/Users/cltbld', 10:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PAGER': '/bin/cat', 10:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:36 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - 'XPC_FLAGS': '0x0', 10:12:36 INFO - 'XPC_SERVICE_NAME': '0', 10:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:12:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:36 INFO - 'HOME': '/Users/cltbld', 10:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PAGER': '/bin/cat', 10:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:36 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - 'XPC_FLAGS': '0x0', 10:12:36 INFO - 'XPC_SERVICE_NAME': '0', 10:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:39 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:40 INFO - Downloading docopt-0.6.1.tar.gz 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:40 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:40 INFO - Running setup.py install for blobuploader 10:12:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:41 INFO - Running setup.py install for requests 10:12:41 INFO - Running setup.py install for docopt 10:12:41 INFO - Successfully installed blobuploader requests docopt 10:12:41 INFO - Cleaning up... 10:12:41 INFO - Return code: 0 10:12:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:41 INFO - 'HOME': '/Users/cltbld', 10:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:41 INFO - 'LOGNAME': 'cltbld', 10:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:41 INFO - 'MOZ_NO_REMOTE': '1', 10:12:41 INFO - 'NO_EM_RESTART': '1', 10:12:41 INFO - 'PAGER': '/bin/cat', 10:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:41 INFO - 'PWD': '/builds/slave/test', 10:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:41 INFO - 'SHELL': '/bin/bash', 10:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:41 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:41 INFO - 'USER': 'cltbld', 10:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:41 INFO - 'XPC_FLAGS': '0x0', 10:12:41 INFO - 'XPC_SERVICE_NAME': '0', 10:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-G8b4wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DsC_4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DlIBrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-L3Cgzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-N4zjGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-N07gaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3eLz5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-HVKvWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-f6jks3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:42 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SF_ukh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KPR_nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-MzkyXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6Fairp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-GjNZdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-rQ8KEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PWHOnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XTgMYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:43 INFO - Running setup.py install for manifestparser 10:12:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:43 INFO - Running setup.py install for mozcrash 10:12:44 INFO - Running setup.py install for mozdebug 10:12:44 INFO - Running setup.py install for mozdevice 10:12:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozfile 10:12:44 INFO - Running setup.py install for mozhttpd 10:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozinfo 10:12:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozInstall 10:12:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozleak 10:12:45 INFO - Running setup.py install for mozlog 10:12:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for moznetwork 10:12:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozprocess 10:12:45 INFO - Running setup.py install for mozprofile 10:12:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozrunner 10:12:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozscreenshot 10:12:46 INFO - Running setup.py install for moztest 10:12:46 INFO - Running setup.py install for mozversion 10:12:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:46 INFO - Cleaning up... 10:12:46 INFO - Return code: 0 10:12:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:46 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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:46 INFO - 'HOME': '/Users/cltbld', 10:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:46 INFO - 'LOGNAME': 'cltbld', 10:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:46 INFO - 'MOZ_NO_REMOTE': '1', 10:12:46 INFO - 'NO_EM_RESTART': '1', 10:12:46 INFO - 'PAGER': '/bin/cat', 10:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:46 INFO - 'PWD': '/builds/slave/test', 10:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:46 INFO - 'SHELL': '/bin/bash', 10:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:46 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:46 INFO - 'USER': 'cltbld', 10:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:46 INFO - 'XPC_FLAGS': '0x0', 10:12:46 INFO - 'XPC_SERVICE_NAME': '0', 10:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-k298vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-W2IdwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-hwOG0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:46 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AkFimP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:47 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)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-RHVzAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BxR7ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KI8Cq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-9S3qMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-y7S9dO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uWrM91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Hl2Gj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-CGiq_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-S0Yf4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-A9V6Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-QDHoC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-pAN_Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-rtxh50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:12:48 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)) 10:12:48 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)) 10:12:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:51 INFO - Downloading blessings-1.6.tar.gz 10:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:51 INFO - Installing collected packages: blessings 10:12:51 INFO - Running setup.py install for blessings 10:12:51 INFO - Successfully installed blessings 10:12:51 INFO - Cleaning up... 10:12:51 INFO - Return code: 0 10:12:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:52 INFO - Reading from file tmpfile_stdout 10:12:52 INFO - Current package versions: 10:12:52 INFO - blessings == 1.6 10:12:52 INFO - blobuploader == 1.2.4 10:12:52 INFO - docopt == 0.6.1 10:12:52 INFO - functools32 == 3.2.3-2 10:12:52 INFO - jsonschema == 2.5.1 10:12:52 INFO - manifestparser == 1.1 10:12:52 INFO - mozInstall == 1.12 10:12:52 INFO - mozcrash == 1.0 10:12:52 INFO - mozdebug == 0.1 10:12:52 INFO - mozdevice == 0.49 10:12:52 INFO - mozfile == 1.2 10:12:52 INFO - mozhttpd == 0.7 10:12:52 INFO - mozinfo == 0.9 10:12:52 INFO - mozleak == 0.1 10:12:52 INFO - mozlog == 3.4 10:12:52 INFO - moznetwork == 0.27 10:12:52 INFO - mozprocess == 0.24 10:12:52 INFO - mozprofile == 0.28 10:12:52 INFO - mozrunner == 6.13 10:12:52 INFO - mozscreenshot == 0.1 10:12:52 INFO - mozsystemmonitor == 0.3 10:12:52 INFO - moztest == 0.8 10:12:52 INFO - mozversion == 1.4 10:12:52 INFO - psutil == 3.1.1 10:12:52 INFO - requests == 1.2.3 10:12:52 INFO - wsgiref == 0.1.2 10:12:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:52 INFO - 'HOME': '/Users/cltbld', 10:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:52 INFO - 'LOGNAME': 'cltbld', 10:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:52 INFO - 'MOZ_NO_REMOTE': '1', 10:12:52 INFO - 'NO_EM_RESTART': '1', 10:12:52 INFO - 'PAGER': '/bin/cat', 10:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:52 INFO - 'PWD': '/builds/slave/test', 10:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:52 INFO - 'SHELL': '/bin/bash', 10:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:52 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:52 INFO - 'USER': 'cltbld', 10:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:52 INFO - 'XPC_FLAGS': '0x0', 10:12:52 INFO - 'XPC_SERVICE_NAME': '0', 10:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:12:52 INFO - Cleaning up... 10:12:52 INFO - Return code: 0 10:12:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 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 0x103534b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103537768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc29b584870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, '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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:12:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:12:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:12:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:12:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:12:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:12:52 INFO - 'HOME': '/Users/cltbld', 10:12:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:12:52 INFO - 'LOGNAME': 'cltbld', 10:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:52 INFO - 'MOZ_NO_REMOTE': '1', 10:12:52 INFO - 'NO_EM_RESTART': '1', 10:12:52 INFO - 'PAGER': '/bin/cat', 10:12:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:52 INFO - 'PWD': '/builds/slave/test', 10:12:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:12:52 INFO - 'SHELL': '/bin/bash', 10:12:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:12:52 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:12:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:12:52 INFO - 'USER': 'cltbld', 10:12:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:12:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:52 INFO - 'XPC_FLAGS': '0x0', 10:12:52 INFO - 'XPC_SERVICE_NAME': '0', 10:12:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:52 INFO - Cleaning up... 10:12:52 INFO - Return code: 0 10:12:52 INFO - Running post-action listener: _resource_record_post_action 10:12:52 INFO - Running post-action listener: _start_resource_monitoring 10:12:52 INFO - Starting resource monitoring. 10:12:53 INFO - [mozharness: 2017-03-21 17:12:53.007085Z] Finished create-virtualenv step (success) 10:12:53 INFO - [mozharness: 2017-03-21 17:12:53.008116Z] Running install step. 10:12:53 INFO - Running pre-action listener: _resource_record_pre_action 10:12:53 INFO - Running main action method: install 10:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:53 INFO - Reading from file tmpfile_stdout 10:12:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:53 INFO - Reading from file tmpfile_stdout 10:12:53 INFO - Output received: 10:12:53 INFO - Usage: mozinstall [options] installer 10:12:53 INFO - Options: 10:12:53 INFO - -h, --help show this help message and exit 10:12:53 INFO - -d DEST, --destination=DEST 10:12:53 INFO - Directory to install application into. [default: 10:12:53 INFO - "/builds/slave/test"] 10:12:53 INFO - --app=APP Application being installed. [default: firefox] 10:12:53 INFO - mkdir: /builds/slave/test/build/application 10:12:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:13:07 INFO - Reading from file tmpfile_stdout 10:13:07 INFO - Output received: 10:13:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:13:07 INFO - Running post-action listener: _resource_record_post_action 10:13:07 INFO - [mozharness: 2017-03-21 17:13:07.943534Z] Finished install step (success) 10:13:07 INFO - [mozharness: 2017-03-21 17:13:07.943681Z] Running run-tests step. 10:13:07 INFO - Running pre-action listener: _resource_record_pre_action 10:13:07 INFO - Running main action method: run_tests 10:13:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:13:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:13:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:13:07 INFO - 2017-03-21 10:13:07.957 screenresolution[1624:7316] starting screenresolution argv=screenresolution get 10:13:07 INFO - 2017-03-21 10:13:07.960 screenresolution[1624:7316] Display 0: 1600x1200x32@60 10:13:07 INFO - 2017-03-21 10:13:07.966 screenresolution[1625:7318] starting screenresolution argv=screenresolution list 10:13:07 INFO - Available Modes on Display 0 10:13:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:13:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:13:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:13:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:13:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:13:08 INFO - Intel Iris: 10:13:08 INFO - Chipset Model: Intel Iris 10:13:08 INFO - Type: GPU 10:13:08 INFO - Bus: Built-In 10:13:08 INFO - VRAM (Dynamic, Max): 1536 MB 10:13:08 INFO - Vendor: Intel (0x8086) 10:13:08 INFO - Device ID: 0x0a2e 10:13:08 INFO - Revision ID: 0x0009 10:13:08 INFO - Displays: 10:13:08 INFO - Display: 10:13:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:13:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:13:08 INFO - Display Serial Number: 1600x1200 60 10:13:08 INFO - Main Display: Yes 10:13:08 INFO - Mirror: Off 10:13:08 INFO - Online: Yes 10:13:08 INFO - Rotation: Supported 10:13:08 INFO - Return code: 0 10:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:08 INFO - Python 2.7.3 10:13:08 INFO - Return code: 0 10:13:08 INFO - grabbing minidump binary from tooltool 10:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:08 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 0x103312d30>, '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 0x103239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103307be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:13:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:13:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:13:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:08 INFO - Return code: 0 10:13:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:13:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:13:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ffgvZAXZqX/Render', 10:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:08 INFO - 'HOME': '/Users/cltbld', 10:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:08 INFO - 'LOGNAME': 'cltbld', 10:13:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:08 INFO - 'MOZ_NO_REMOTE': '1', 10:13:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:08 INFO - 'NO_EM_RESTART': '1', 10:13:08 INFO - 'PAGER': '/bin/cat', 10:13:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:08 INFO - 'PWD': '/builds/slave/test', 10:13:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:08 INFO - 'SHELL': '/bin/bash', 10:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJpKtVpp6q/Listeners', 10:13:08 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 10:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:08 INFO - 'USER': 'cltbld', 10:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:08 INFO - 'XPC_FLAGS': '0x0', 10:13:08 INFO - 'XPC_SERVICE_NAME': '0', 10:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:13:08 INFO - mozversion application_buildid: 20170321091924 10:13:08 INFO - mozversion application_changeset: 4a0aabf1af708c0caf38c02dd0e877ab35734183 10:13:08 INFO - mozversion application_display_name: Firefox 10:13:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:08 INFO - mozversion application_name: Firefox 10:13:08 INFO - mozversion application_remotingname: firefox 10:13:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:08 INFO - mozversion application_vendor: Mozilla 10:13:08 INFO - mozversion application_version: 53.0 10:13:08 INFO - mozversion platform_buildid: 20170321091924 10:13:08 INFO - mozversion platform_changeset: 4a0aabf1af708c0caf38c02dd0e877ab35734183 10:13:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:13:08 INFO - mozversion platform_version: 53.0 10:13:08 INFO - using testdate: 1490116388 10:13:08 INFO - actual date: 1490116388 10:13:08 INFO - starting webserver on 'localhost:49236' 10:13:08 INFO - SUITE-START | Running 2 tests 10:13:08 INFO - TEST-START | dromaeo_css 10:13:08 INFO - operating with platform_type : mac_ 10:13:08 INFO - Initialising browser for dromaeo_css test... 10:13:08 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpYy3ic8/profile http://localhost:49236/getInfo.html) 10:13:11 INFO - PROCESS | 1635 | 2017-03-21 10:13:11.459 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4f, name = 'com.apple.tsm.portname' 10:13:11 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:11 INFO - PROCESS | 1635 | 2017-03-21 10:13:11.459 plugin-container[1638:7490] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:13:11 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:11 INFO - PROCESS | 1635 | 2017-03-21 10:13:11.459 plugin-container[1638:7490] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:13:11 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 10:13:11 INFO - PROCESS | 1635 | colorDepth:24 10:13:11 INFO - PROCESS | 1635 | Browser inner width/height: 1024/663 10:13:11 INFO - PROCESS | 1635 | __metrics 10:13:11 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 10:13:12 INFO - TEST-INFO | 1635: exit 0 10:13:12 INFO - Browser initialized. 10:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:12 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpYy3ic8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:14 INFO - PROCESS | 1639 | 2017-03-21 10:13:14.568 plugin-container[1640:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 10:13:14 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:14 INFO - PROCESS | 1639 | 2017-03-21 10:13:14.568 plugin-container[1640:7627] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 10:13:14 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:13:14 INFO - PROCESS | 1639 | 2017-03-21 10:13:14.569 plugin-container[1640:7627] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:13:24 INFO - PROCESS | 1639 | RSS: Main: 182153216 10:13:24 INFO - PROCESS | 1639 | 10:16:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 10:16:27 INFO - PROCESS | 1639 | RSS: Main: 196423680 10:16:27 INFO - PROCESS | 1639 | 10:19:29 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 10:19:30 INFO - PROCESS | 1639 | RSS: Main: 205316096 10:19:30 INFO - PROCESS | 1639 | 10:22:31 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 10:22:32 INFO - PROCESS | 1639 | RSS: Main: 207052800 10:22:32 INFO - PROCESS | 1639 | 10:25:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 10:25:35 INFO - PROCESS | 1639 | RSS: Main: 210345984 10:25:35 INFO - PROCESS | 1639 | 10:28:38 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 10:28:38 INFO - PROCESS | 1639 | RSS: Main: 211890176 10:28:38 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 10:31:41 INFO - PROCESS | 1639 | RSS: Main: 212353024 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | __start_tp_report 10:31:41 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 10:31:41 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 10:31:41 INFO - PROCESS | 1639 | |i|pagename|runs| 10:31:41 INFO - PROCESS | 1639 | |0;dojo.html;3470.6355832637573;3480.1647604574896;3497.1257185703566;3506.4740288956655;3513.8243087845603;5681.772729090837;5683.119116536938;5762.855928601787;5767.452092051259;5785.82642520725;5935.258092738408;5939.584229103964;5986.760529578812;5993.883180746009;5994.8501287467725;5302.2841916341185;5340.973295133519;5377.569794416438;5401.972990135064;5422.864428389283;5101.979604079181;5337.14605663094;5414.864628384302;5441.83674489764;5452.372977107624;5224.39919409269;5268.104422248227;5333.120035194188;5357.383900851374;5389.245505629215;4231.344141658048;5215.24378965048;5283.709395983219;5343.839684809462;5370;4002.399640053986;5254.185601231815;5276.366835979668;5276.762545685453;5296.894062118736;4729.574338309534;5803.21656576361;5877.617954832922;5911.497522710575;5948.940510594925;6220.751169953196;6251.906221406683;6268.749250029993;6291.779787707408;6335.6198628082;6394.58435201715;6401.391867772554;6404.423601875854;6408.871822563523;6427.807165785034;6100.054491553817;6112.877742445126;6122.724477398483;6128.816135515942;6130.080487926802;6272.529560282997;6316.957701979214;6361.840953976188;6394.392532709385;6422;6243.8126856194385;6300;6303.117563541108;6303.149074874925;6332.556721029576;6391.2330520337855;6398.936010639927;6400.327965563549;6411.070394792729;6417.454516366161;6218.657973811484;6220.471259942865;6226.844328891723;6240;6265.091561723524;6247.812565623039;6276;6293;6303.842403939847;6306.558540902093;4372.672049596293;5042.672226305279;5115.1559992600805;5119.539241468286;5130.87172820675;4489.775511224491;4499.013894449666;4539.773011349419;4652.767361631905;4652.790624421909;6002.159697642333;6064.848378790565;6085.726142323606;6108.267007958984;6129.264488261437;5333.6799792011825;6374.840628984312;6417;6444.548881578338;6452.548321617442;5862.648241105548;5923.111533270044;6029.78895738647;6036.3360030396625;6107.328193898667;4654.418197725285;5576.052071147915;5579.079451890474;5607.775688972477;5621.971890140605;5467.371252306036;6451.000094985285;6514.54398192122;6514.576552524166;6592.24189218246;6226.470749986121;6274.623522588659;6277.686115694289;6370.1718776558755;6399.2640846303275;5514;6506.121673574007;6533.509986751108;6584.012398140126;6588.472922166119;6275.937240627535;6296.5592408530965;6300.936990630218;6302.243730752339;6304.71628776697;6112.868254063078;6152.907706384318;6370.331115232834;6372.458341041063;6385.712642931172;6213.161223234986;6234.875302493834;6235.906461403173;6277.18396608438;6334.524910631629;6272.4982001440685;6296.685165741603;6305.148804911279;6309.148264984352;6326.810195694136;6075.939240607538;6089.056196289582;6228.750849965951;6229.813105606839;6257.874842503215;6148.077788331786;6160.845978850564;6182.629042257479;6190.350013248544;6287.434130928238;6164.291106522807;6183.381661833961;6214;6217.067439884054;6220.471259942956 10:31:41 INFO - PROCESS | 1639 | |1;ext.html;447.8902668846133;493.8098831949698;505.8507740216636;516.8061976758715;520.8151106357243;37264.25471490572;44030.77984610076;44045.119097618066;46606.36877709281;46704.532954670445;44506;45127;45133.7743311283;45195.64413067613;45262;9025.684101056464;9570.947195808456;9766.218702503782;9775;9799.755006124833;7588.696452141908;11484.655460336204;11743.06055515561;11836.940815295955;11994.280343179393;11641.59254426091;11725.120615953794;11778.823317650242;11790.23363481371;11800.704982375424;11848.703782405466;11912.761744765143;11929.761404771856;11943.104267179997;11960.222585531956;11836.112291578165;11908.16642835002;11908.404579771064;11939.701507462383;11967.94016029923;43177.56822431767;43386;43411.78294108509;43506.78246608778;43553.346699799215;4074.5110586729484;4098.2418252623065;4099.531510653373;4170.103427763045;4340.414044104037;30433;30741.077767666782;31004.379912401626;31056.91300804461;33389;2925.429541239459;3183.984080079608;3464.37641224582;3513.859445622172;3515.5605549306338;495277;495636;496833;497665;500562.99437005527;66065;66406;66443.66778166078;66528;66549.33450665529;70308.94536581854;70497.64751176313;70591.64704176446;70740.64629676922;70966.9354959676;15219.315130819139;16351.59121021984;17250.223739931735;17546.210420531108;17870.017149056926;12715.427805748763;12931.159474634118;13550.661233469242;13807.585772426843;13963.162210267417;18305.63388732218;18339.908300458414;18363.17365718546;18383;18407.447776566725;7037.296270372922;7905.288524032865;8064.395170362246;8147.388945829087;8184.468009579358;745.5861996591943;770.3529035610114;888.9466632002101;937.2501998401252;949.8907625623003;31032.379352412827;31833.52249716256;32128.35743285121;32149.196270092965;32553.83723081417;950.9001554836642;1036.4506811389974;1066.8133076711545;1100.3892839474008;1228.4901765767286;15841;16573.41993030238;16588.50234492967;16604.50186494407;16724.331026758795;633414.6658533355;648765;649425;649652;652289;64451.35548644547;65238.67380663161;65251.02123468152;65281.347186528474;65335;1449.0870751426535;1464.1507925403453;1479.7040591881666;1499.737545929458;1500.8799296056288;29656.406871862873;29919.55120673148;31079.84460077685;31132.688673112978;31690.841545792122;52952.73523632357;53154.93690126253;53181.20228196503;53199.20201197063;53301;552023;554030.459695414;556392;558926;559534;42394.36408453814;42595.787021064694;43400;43494.13011739684;43606;48164.27753583769;48304.29340591782;49019;49692.254616180064;50013.74993125011;36882.89351319465;37389;37799.05502362463;39651.81044568668;40307.79846100868;36709.44935826018;37088.81455592705;37338;38283.80858095692;38465.4230186553;37385.252294954495;37897;38139.42790858195;38389.80805095957;38427.42358864675;31300.37399252048;31436.68563314429;32945;33121.171970699965;33121.668783311856;24708.629370559815;25022.74977250204;25087.623685644365;25286.24141275765;25589.872050639628 10:31:41 INFO - PROCESS | 1639 | |2;jquery.html;356.96787289143975;399.1677352719581;402.59338068550755;410.4704930639475;436.07334414369467;16783.24475398607;17551;21252.256171034016;22046.779532204673;22328;22295.554088918212;22856.542869142606;23177.072917083296;23633.645495317585;23835.880820595918;5768.451997060283;6017.48851347636;6049.274087109531;6055.940210463174;6063.333033366326;5589.077802162638;5849.795257166;5886.558508111887;5926.140709597106;6020.879582408349;4980.302757613937;5921.911171332434;5926.3184733755525;5934;5944.464998150165;4970.329005584236;5690.57320700947;5886.058230683092;5951.642901425928;5959.284885813687;4925.211966085445;5810.767569297223;5819.098039803837;5819.67991760453;5843.2695913010875;26194.73805261942;26910.789014494396;27303.863480682667;28063.29841753952;28436.715632843614;3027;3030.3030303030428;3039.680833512494;3044.5128779395413;3046.3754930239247;10526.736831579195;10988.505517251742;11077.944610276978;13354.666133346744;15020.549383518512;1780.7952085510203;1842.6314737052644;1875.7749070111538;1889.5559543507266;1900.9904950475159;152430;154235;156711;157296;158926;12384.256944583354;12386.132970691964;12397.566085187156;12441.751164976831;12568.120231583702;14657.706845863024;15360.001599895972;16487.422940197037;16508.33966641345;16519.09144997037;8954.686585969459;9183.724488265363;9322.673706420379;9367.484788336571;9457.43255404678;9150.862737058816;9153.54232288383;9178.954105229432;9182.081791820765;9280;4934.6545741798445;4989.825356112518;4991.07665081961;4993.850184494471;5028.145215313405;1882.9079134102187;2002.9399118026483;2071.7099606055162;2116.523782149004;2118.9152433902777;1028.9742756431149;1030.3508789462592;1043.1654676258963;1059.86751656043;1113.6603335982604;16881.493555193363;22269.220577279717;22513.662295065587;22698.886505567367;22712.432189195402;1054.0460882900986;1060.2366296266675;1077.789830982951;1101.8843021482628;1103.707517507861;11437.542498299976;11548.826767598493;11666.650000499998;11686.883131168579;11693;805031;807219;810722;828018;830644;122654.77345226433;142665.28667356598;153372.2331388336;160482;160821;1075.8601381820313;1078.347599702169;1100.8733995590449;1101.7521057762099;1103.779244151173;14485.710285794436;19561.70657440168;19815.504612384804;19858;19978.60042799165;55205;57499.71250143723;58412;58669;58729;68727;84854;87876.1212387868;89189;89267.55366223128;8336.541490218096;8461.576921154041;8530.70142545008;8674.517117885654;8983.505907174907;12317.507299707911;13104.017198709944;13187.934060329637;13348.466061357825;13518.459261629818;11354.091672666333;11371.31772093677;11415;11423.657290281304;11518.790526994544;11073.667789966314;11336.319820810448;11353.091752659933;11479.024282936043;11685.357305347947;9671.17794987434;11303.7739245213;11950.641480755592;11984;12051.216670916363;6789.932100679128;8203.42576019673;8563.785905352415;8567.357448191535;8803.647854085764;8588.398812083095;10706.62526811589;11731.061515078603;11772.882271177521;11877.821832672344 10:31:41 INFO - PROCESS | 1639 | |3;mootools.html;1452.404514149199;1452.4262916148127;1499.9175045372501;1502.106246783164;1506.088816266159;7726.072871255443;7974.242446967543;8231.176882311765;8689.000764912029;8697.086805885378;7334.229905859888;8210.671573137082;8217.753467395973;8329.833403331944;8336.958315208416;1939.4278687787137;1997.2809788476136;2421.128393778238;2422.6123820188773;2425.5876500994787;2414.782669559739;2425.7938075263537;2447.6904855902094;2447.7674620910984;2452.19077704358;2028.6956956456577;2372.9762702372927;2391.7129944406697;2416.492536567323;2426.963595546068;2370.2533701883854;2377.227401094651;2383.856968581882;2393.8563686178886;2402.675638788767;2023.9172042956948;2425.3087869957153;2427.8664673442954;2428.2351059416405;2430.1373012580457;8516.914830851736;8583.52790596517;8596.398252122353;8640.654373825102;8651.394402391772;5045.520675535819;5171.974140129275;5179.741012949337;5188.507091826308;5199.4800519948085;3439.3465241604267;3610.277944411102;3654.689351405134;3703.9073473325434;3709.7588656737225;1221.2123180548497;1246.6260121963376;1298.3767791460057;1305.0668771828093;1314.9013823963146;11008.284461509977;11052.889471105267;11070.225084244106;11089.001989820956;11096.778064438666;3668.761530500509;4604.6895026992925;4795.352627395327;4823.710577365369;4841.15279826029;9629;9695.175910047585;9710.223182145412;9744.07431294026;9751.463669498246;4558.88602784933;5246.396664383568;5371.355437347465;5373.785048598091;5385.434529374359;4243.618074373321;4859.538343857328;4870.7808148632685;4907.631927605373;4966.875828104254;3390.983045084808;3956.050547868491;3959.861404850874;4070.043539768152;4082.2856000199845;1310.122218113866;1325.7945018522144;1329.4947919790418;1339.136257114156;1346.1855577375743;926.0970553710079;932.2774849491562;934.4486752815872;938.1837801113076;957.0572985609169;5274.26160337553;5545.72271386429;5635.830925072172;5813.128030795415;5865.032269675541;584.2550747796508;588.0121396054669;589.9439553242435;594.9672767997802;608.5892022884535;3735.495708079429;3788.962110378916;3814.7901865397116;3823;3902.1220225449047;9541.570629321697;9774.218062554979;9967.850482242773;9997.200223982063;10353.327033742933;9970.700878973643;10105.5452504636;10108.949455252676;10126.088652021353;10133.341332813343;7641.3886889048745;7888.329491993245;7993.960030199812;8027.959860200778;8040.2361775631225;5608.6073974821375;5642.3229212493125;5739.827805165852;5786.537077033911;5795.188673585617;9207.539623018689;9369.484678342757;9464.432134071978;9540.141387275178;9582.66460673873;9030.683926062819;9403.717888463358;9474.099960503741;9480.573374198315;9523.285753568649;6735.191776986793;6947.756828510978;7271.818204544717;7420.6289685516585;7433.2195119513835;7787.4548781584745;7942.483738556975;8050.396220283619;8127.593620318842;8175.79560510992;7116.46626503004;7256;7300.853982920418;7320.487565870551;7372.926270737224;5938;6431.485481161402;7154.320339567733;7184.497085203986;7318.048653674989;6385.074164246251;6453.419192272718;6521.804345869631;6522.315156908646;6524.934750652433;5012.521306214602;5017.071841709149;5079.3650793650795;5085.4914508548845;5087.567556757717;4936.8398426370495;5078.187490001582;5146.459621739664;5147.099257629975;5205.505476979833 10:31:41 INFO - PROCESS | 1639 | |4;prototype.html;370.172664095746;374.63285979739857;380.9828557714903;383.1379396358193;384.4195265149625;5444.972775136119;5562.777488900444;5573.41479144689;5607.439256074391;5641.210230567719;5383.919241211385;5554.72226388681;5632;5656.644383824453;5685.403032681571;4151.252774500589;4274.871753847374;4285.228658841407;4405.127820676208;4424.269995450747;4249.3413520904305;4258.276093064186;4260.211860805745;4277.401163837066;4281.35779633056;3779.281936432083;3968.0597655918423;4199.55904630014;4248.638865696419;4264.104538046999;3427.3830710472107;3617.5116359291424;4094.651954583864;4272.786360681954;4280.951166964098;3585.243230816907;3635.5641720047633;3642.981785091084;3657.817109144559;3658.963410365889;5206.349206349207;5496.268675367247;5497.505224529811;5534.529564986981;5538;4800;4939.913219091794;4945.184044632631;4960.925586116211;4967.950320496785;5000.449950505442;5263.578913686934;5985.892609867188;5999.340072592011;6011.16659418877;3664.6152154023976;4006.8380169750735;4070.0463777386726;4081.5306239782212;4092.3452247640535;5064.873378165538;5269.947300526984;6239.344868788802;6311.495080393557;6392.520560957901;3594.4608308753373;3973.3443981743267;4034.1931613677384;4095.385692146202;4099.795010249476;3688.170161713647;4111.157212771374;4150.211459822624;4159.584041595876;4172.874813755592;4892.107892107892;4897.2898929655;4906.411230652345;4910.803567857246;4920.384951881015;4962.503749625009;5413.864653383697;5897.675627840425;6040.697965101727;6094.939050609526;1166.3759888459633;1213.1568559850996;1338.852726200117;1348.6089034179977;1357.1653433138747;832.908889354947;868.70898249086;908.8000639859221;919.990800092004;925.9397989302212;4681.50844161365;5160.7423875302275;5279.096496926675;5387.919181212285;5401.297831281908;5664.915026274609;5851.654119552527;5858.945389829786;6016.488598469092;6028.849278767978;4395.120975804852;5365.490278423544;5365.570754339644;5408.945910540923;5431.402545719968;2791.199676208834;2799.398129402148;2819.4783964966546;3002.8648710808066;3078.7536997040183;5694.092479019575;6039.54703397247;6043.305019922677;6045.486133678599;6101.633901965807;5592.720363981784;5928.258967629046;6269.341719119518;6290.119383286344;6352.523560732963;6339.809805705836;6369.331220221903;6404.48764098871;6409.141349008735;6411.390917862889;5027.597792176544;5889.293284805851;6039.698015099139;6042.072652775731;6197.03945888388;5356.946430535801;5665.858353541194;5950.613210141327;6117.981066248217;6133.815985520441;5772.797952071657;5884.58807883444;6350.015747559136;6410.576702075553;6476.190476190476;4017.718759686794;4082.3672330788777;4098.692598055218;4114;4124.876253712393;5343.465653434625;5907.400743672771;6234.594751341148;6240.563160578716;6250.593711408926;4915.139850526215;4997.800087996439;5942.346341902301;6007.969960150172;6008.849778755566;5526.557875370041;5936.376680448663;5991.400859913973;6033.366496517978;6054.424829641177;4909.9263511048075;5571.916421253765;5819.330776960704;5876.795256972396;5919.7040147991565;5137.6660517066275;5158.845234642967;5748.54011679073;5881.676507792113;5940.8811823764145;4930.704157750546;5661.830145095653;5832.387599302182;5937.91093133612;5942.851428714317 10:31:41 INFO - PROCESS | 1639 | |5;yui.html;749.1796482851282;755.1844008470852;791.3629528229776;870.7387783664901;877.749841295231;14636.536346365358;15039.473618423357;15506.534803955885;16459.423920162797;16909.7463538047;14925.477608283712;15303.770443443329;15348.539543813675;15358.616034599141;16078.678426431494;878.6353663229752;908.3686837647838;910.0626354854511;916.6883259691704;917.2799352508282;885.3448448148356;915.6428992692855;921.6221349246777;930.7347405989294;933.8272419602362;945.6170251048336;961.6730311694023;961.6970654243926;965.9227261819073;966.1932286540712;958.228625956105;959.7072892767703;961.3462845265217;961.543266948201;961.7739831139642;715.5778090926378;721.6896734404204;723.7032816545192;724.5543990445891;726.429752644177;15688.294026768823;15908.522744317688;16191.919040404722;16582.917085414494;16784.992900425892;12293.56972505967;14642.560723178321;14663.900207484374;14859.108453492825;15062.849371506254;11697.883021169764;11801.232919860182;11852.822207666892;11873.16887817853;12349;3407.216340241758;3795.411711184771;3858.614138586147;3871.7870517121546;4003.15933653933;107369;107724;107803.46098269537;108906;110347.9999999992;10984.780304393867;11242.325460472235;11348.489317980711;11429.085673146295;11882;23151.7684823153;23407.297781066256;23636.17273395423;23817.880910595337;23901.043958241822;6655.600663960178;7985.321247693895;8042.959785201154;8134.552599607078;8235.752927412188;4302.65578753699;4361.694681372273;4363.5418281080665;4382.956170438319;4434.091011342667;3811.790351530637;3869.0520822398694;3878.7478813877005;3913.726039177287;3926.371780515104;677.9423748981392;679.3512195852949;680.0750978669006;687.6424259385092;722.9530080544853;702.1503980183933;703.1421665567999;730.9488335816549;737.2443245673228;747.4543583184305;10696.251262411712;10827.891721082846;10868.891311086945;11111.722206944729;11265.71835704114;616.2943429772885;629.7323637454064;636.3922454056365;655.367570294668;664.8271449423185;5096.159133742965;5242.842714718565;5245.291885595472;5254.527092561688;5258.6581872178185;85764.57117714496;110015;110938.3359249612;113015;114136;72266.9159962601;93304;96637;97001.514992426;101705.91470426449;84581.57709211537;84945.57527212324;86884.00303260026;88314;90621;10069.647562335576;10147.289689721943;10191.796164076528;10208.183345332503;10255.07704306616;38745.837624871296;40896;52655.47344526506;57457.12714364182;58289;75843.62078189573;76510.8523372161;78094.609526952;78251.60874195592;78520.21479785358;11778.411079446165;11783.116266279892;12196.878031219574;12343.382830858602;12469;13600.862912730228;13644.386002630104;13660.316984150553;13673.31633418345;14259.714805703621;10417.791644166922;12411.503539858304;12802.423890925116;12826.743465130832;13137.343132843129;12287.1399002069;12307.938460307641;12825.166364186298;12904.225746455242;13218.669533261746;10208.846867297145;11964.102692297938;12296.569620063256;12435.813462798245;12544.059195560187;10193.184545236216;10260.384376937109;10380.27338086357;10542.57829686804;10622.787544248917;9201.53992300369;9501;10484.108850747773;10509.789804204025;10629.627963021258 10:31:41 INFO - PROCESS | 1639 | __end_tp_report 10:31:41 INFO - PROCESS | 1639 | __start_cc_report 10:31:41 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,381 10:31:41 INFO - PROCESS | 1639 | __end_cc_report 10:31:41 INFO - PROCESS | 1639 | __startTimestamp1490117501576__endTimestamp 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | ------- Summary: start ------- 10:31:41 INFO - PROCESS | 1639 | Number of tests: 6 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5855.92 Median:6152.91 stddev:685.82 (11.1%) stddev-sans-first:661.90 10:31:41 INFO - PROCESS | 1639 | Values: 3470.6 3480.2 3497.1 3506.5 3513.8 5681.8 5683.1 5762.9 5767.5 5785.8 5935.3 5939.6 5986.8 5993.9 5994.9 5302.3 5341.0 5377.6 5402.0 5422.9 5102.0 5337.1 5414.9 5441.8 5452.4 5224.4 5268.1 5333.1 5357.4 5389.2 4231.3 5215.2 5283.7 5343.8 5370.0 4002.4 5254.2 5276.4 5276.8 5296.9 4729.6 5803.2 5877.6 5911.5 5948.9 6220.8 6251.9 6268.7 6291.8 6335.6 6394.6 6401.4 6404.4 6408.9 6427.8 6100.1 6112.9 6122.7 6128.8 6130.1 6272.5 6317.0 6361.8 6394.4 6422.0 6243.8 6300.0 6303.1 6303.1 6332.6 6391.2 6398.9 6400.3 6411.1 6417.5 6218.7 6220.5 6226.8 6240.0 6265.1 6247.8 6276.0 6293.0 6303.8 6306.6 4372.7 5042.7 5115.2 5119.5 5130.9 4489.8 4499.0 4539.8 4652.8 4652.8 6002.2 6064.8 6085.7 6108.3 6129.3 5333.7 6374.8 6417.0 6444.5 6452.5 5862.6 5923.1 6029.8 6036.3 6107.3 4654.4 5576.1 5579.1 5607.8 5622.0 5467.4 6451.0 6514.5 6514.6 6592.2 6226.5 6274.6 6277.7 6370.2 6399.3 5514.0 6506.1 6533.5 6584.0 6588.5 6275.9 6296.6 6300.9 6302.2 6304.7 6112.9 6152.9 6370.3 6372.5 6385.7 6213.2 6234.9 6235.9 6277.2 6334.5 6272.5 6296.7 6305.1 6309.1 6326.8 6075.9 6089.1 6228.8 6229.8 6257.9 6148.1 6160.8 6182.6 6190.4 6287.4 6164.3 6183.4 6214.0 6217.1 6220.5 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:71822.95 Median:38446.42 stddev:151938.39 (395.2%) stddev-sans-first:152270.11 10:31:41 INFO - PROCESS | 1639 | Values: 447.9 493.8 505.9 516.8 520.8 37264.3 44030.8 44045.1 46606.4 46704.5 44506.0 45127.0 45133.8 45195.6 45262.0 9025.7 9570.9 9766.2 9775.0 9799.8 7588.7 11484.7 11743.1 11836.9 11994.3 11641.6 11725.1 11778.8 11790.2 11800.7 11848.7 11912.8 11929.8 11943.1 11960.2 11836.1 11908.2 11908.4 11939.7 11967.9 43177.6 43386.0 43411.8 43506.8 43553.3 4074.5 4098.2 4099.5 4170.1 4340.4 30433.0 30741.1 31004.4 31056.9 33389.0 2925.4 3184.0 3464.4 3513.9 3515.6 495277.0 495636.0 496833.0 497665.0 500563.0 66065.0 66406.0 66443.7 66528.0 66549.3 70308.9 70497.6 70591.6 70740.6 70966.9 15219.3 16351.6 17250.2 17546.2 17870.0 12715.4 12931.2 13550.7 13807.6 13963.2 18305.6 18339.9 18363.2 18383.0 18407.4 7037.3 7905.3 8064.4 8147.4 8184.5 745.6 770.4 888.9 937.3 949.9 31032.4 31833.5 32128.4 32149.2 32553.8 950.9 1036.5 1066.8 1100.4 1228.5 15841.0 16573.4 16588.5 16604.5 16724.3 633414.7 648765.0 649425.0 649652.0 652289.0 64451.4 65238.7 65251.0 65281.3 65335.0 1449.1 1464.2 1479.7 1499.7 1500.9 29656.4 29919.6 31079.8 31132.7 31690.8 52952.7 53154.9 53181.2 53199.2 53301.0 552023.0 554030.5 556392.0 558926.0 559534.0 42394.4 42595.8 43400.0 43494.1 43606.0 48164.3 48304.3 49019.0 49692.3 50013.7 36882.9 37389.0 37799.1 39651.8 40307.8 36709.4 37088.8 37338.0 38283.8 38465.4 37385.3 37897.0 38139.4 38389.8 38427.4 31300.4 31436.7 32945.0 33121.2 33121.7 24708.6 25022.7 25087.6 25286.2 25589.9 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:43408.00 Median:22420.83 stddev:135773.88 (605.6%) stddev-sans-first:136116.28 10:31:41 INFO - PROCESS | 1639 | Values: 357.0 399.2 402.6 410.5 436.1 16783.2 17551.0 21252.3 22046.8 22328.0 22295.6 22856.5 23177.1 23633.6 23835.9 5768.5 6017.5 6049.3 6055.9 6063.3 5589.1 5849.8 5886.6 5926.1 6020.9 4980.3 5921.9 5926.3 5934.0 5944.5 4970.3 5690.6 5886.1 5951.6 5959.3 4925.2 5810.8 5819.1 5819.7 5843.3 26194.7 26910.8 27303.9 28063.3 28436.7 3027.0 3030.3 3039.7 3044.5 3046.4 10526.7 10988.5 11077.9 13354.7 15020.5 1780.8 1842.6 1875.8 1889.6 1901.0 152430.0 154235.0 156711.0 157296.0 158926.0 12384.3 12386.1 12397.6 12441.8 12568.1 14657.7 15360.0 16487.4 16508.3 16519.1 8954.7 9183.7 9322.7 9367.5 9457.4 9150.9 9153.5 9179.0 9182.1 9280.0 4934.7 4989.8 4991.1 4993.9 5028.1 1882.9 2002.9 2071.7 2116.5 2118.9 1029.0 1030.4 1043.2 1059.9 1113.7 16881.5 22269.2 22513.7 22698.9 22712.4 1054.0 1060.2 1077.8 1101.9 1103.7 11437.5 11548.8 11666.7 11686.9 11693.0 805031.0 807219.0 810722.0 828018.0 830644.0 122654.8 142665.3 153372.2 160482.0 160821.0 1075.9 1078.3 1100.9 1101.8 1103.8 14485.7 19561.7 19815.5 19858.0 19978.6 55205.0 57499.7 58412.0 58669.0 58729.0 68727.0 84854.0 87876.1 89189.0 89267.6 8336.5 8461.6 8530.7 8674.5 8983.5 12317.5 13104.0 13187.9 13348.5 13518.5 11354.1 11371.3 11415.0 11423.7 11518.8 11073.7 11336.3 11353.1 11479.0 11685.4 9671.2 11303.8 11950.6 11984.0 12051.2 6789.9 8203.4 8563.8 8567.4 8803.6 8588.4 10706.6 11731.1 11772.9 11877.8 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5501.49 Median:5225.95 stddev:3003.48 (57.5%) stddev-sans-first:2996.49 10:31:41 INFO - PROCESS | 1639 | Values: 1452.4 1452.4 1499.9 1502.1 1506.1 7726.1 7974.2 8231.2 8689.0 8697.1 7334.2 8210.7 8217.8 8329.8 8337.0 1939.4 1997.3 2421.1 2422.6 2425.6 2414.8 2425.8 2447.7 2447.8 2452.2 2028.7 2373.0 2391.7 2416.5 2427.0 2370.3 2377.2 2383.9 2393.9 2402.7 2023.9 2425.3 2427.9 2428.2 2430.1 8516.9 8583.5 8596.4 8640.7 8651.4 5045.5 5172.0 5179.7 5188.5 5199.5 3439.3 3610.3 3654.7 3703.9 3709.8 1221.2 1246.6 1298.4 1305.1 1314.9 11008.3 11052.9 11070.2 11089.0 11096.8 3668.8 4604.7 4795.4 4823.7 4841.2 9629.0 9695.2 9710.2 9744.1 9751.5 4558.9 5246.4 5371.4 5373.8 5385.4 4243.6 4859.5 4870.8 4907.6 4966.9 3391.0 3956.1 3959.9 4070.0 4082.3 1310.1 1325.8 1329.5 1339.1 1346.2 926.1 932.3 934.4 938.2 957.1 5274.3 5545.7 5635.8 5813.1 5865.0 584.3 588.0 589.9 595.0 608.6 3735.5 3789.0 3814.8 3823.0 3902.1 9541.6 9774.2 9967.9 9997.2 10353.3 9970.7 10105.5 10108.9 10126.1 10133.3 7641.4 7888.3 7994.0 8028.0 8040.2 5608.6 5642.3 5739.8 5786.5 5795.2 9207.5 9369.5 9464.4 9540.1 9582.7 9030.7 9403.7 9474.1 9480.6 9523.3 6735.2 6947.8 7271.8 7420.6 7433.2 7787.5 7942.5 8050.4 8127.6 8175.8 7116.5 7256.0 7300.9 7320.5 7372.9 5938.0 6431.5 7154.3 7184.5 7318.0 6385.1 6453.4 6521.8 6522.3 6524.9 5012.5 5017.1 5079.4 5085.5 5087.6 4936.8 5078.2 5146.5 5147.1 5205.5 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4786.49 Median:5374.74 stddev:1490.82 (27.7%) stddev-sans-first:1457.68 10:31:41 INFO - PROCESS | 1639 | Values: 370.2 374.6 381.0 383.1 384.4 5445.0 5562.8 5573.4 5607.4 5641.2 5383.9 5554.7 5632.0 5656.6 5685.4 4151.3 4274.9 4285.2 4405.1 4424.3 4249.3 4258.3 4260.2 4277.4 4281.4 3779.3 3968.1 4199.6 4248.6 4264.1 3427.4 3617.5 4094.7 4272.8 4281.0 3585.2 3635.6 3643.0 3657.8 3659.0 5206.3 5496.3 5497.5 5534.5 5538.0 4800.0 4939.9 4945.2 4960.9 4968.0 5000.4 5263.6 5985.9 5999.3 6011.2 3664.6 4006.8 4070.0 4081.5 4092.3 5064.9 5269.9 6239.3 6311.5 6392.5 3594.5 3973.3 4034.2 4095.4 4099.8 3688.2 4111.2 4150.2 4159.6 4172.9 4892.1 4897.3 4906.4 4910.8 4920.4 4962.5 5413.9 5897.7 6040.7 6094.9 1166.4 1213.2 1338.9 1348.6 1357.2 832.9 868.7 908.8 920.0 925.9 4681.5 5160.7 5279.1 5387.9 5401.3 5664.9 5851.7 5858.9 6016.5 6028.8 4395.1 5365.5 5365.6 5408.9 5431.4 2791.2 2799.4 2819.5 3002.9 3078.8 5694.1 6039.5 6043.3 6045.5 6101.6 5592.7 5928.3 6269.3 6290.1 6352.5 6339.8 6369.3 6404.5 6409.1 6411.4 5027.6 5889.3 6039.7 6042.1 6197.0 5356.9 5665.9 5950.6 6118.0 6133.8 5772.8 5884.6 6350.0 6410.6 6476.2 4017.7 4082.4 4098.7 4114.0 4124.9 5343.5 5907.4 6234.6 6240.6 6250.6 4915.1 4997.8 5942.3 6008.0 6008.8 5526.6 5936.4 5991.4 6033.4 6054.4 4909.9 5571.9 5819.3 5876.8 5919.7 5137.7 5158.8 5748.5 5881.7 5940.9 4930.7 5661.8 5832.4 5937.9 5942.9 10:31:41 INFO - PROCESS | 1639 | 10:31:41 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21300.63 Median:3835.20 stddev:31181.11 (813.0%) stddev-sans-first:31230.40 10:31:41 INFO - PROCESS | 1639 | Values: 749.2 755.2 791.4 870.7 877.7 14636.5 15039.5 15506.5 16459.4 16909.7 14925.5 15303.8 15348.5 15358.6 16078.7 878.6 908.4 910.1 916.7 917.3 885.3 915.6 921.6 930.7 933.8 945.6 961.7 961.7 965.9 966.2 958.2 959.7 961.3 961.5 961.8 715.6 721.7 723.7 724.6 726.4 15688.3 15908.5 16191.9 16582.9 16785.0 12293.6 14642.6 14663.9 14859.1 15062.8 11697.9 11801.2 11852.8 11873.2 12349.0 3407.2 3795.4 3858.6 3871.8 4003.2 107369.0 107724.0 107803.5 108906.0 110348.0 10984.8 11242.3 11348.5 11429.1 11882.0 23151.8 23407.3 23636.2 23817.9 23901.0 6655.6 7985.3 8043.0 8134.6 8235.8 4302.7 4361.7 4363.5 4383.0 4434.1 3811.8 3869.1 3878.7 3913.7 3926.4 677.9 679.4 680.1 687.6 723.0 702.2 703.1 730.9 737.2 747.5 10696.3 10827.9 10868.9 11111.7 11265.7 616.3 629.7 636.4 655.4 664.8 5096.2 5242.8 5245.3 5254.5 5258.7 85764.6 110015.0 110938.3 113015.0 114136.0 72266.9 93304.0 96637.0 97001.5 101705.9 84581.6 84945.6 86884.0 88314.0 90621.0 10069.6 10147.3 10191.8 10208.2 10255.1 38745.8 40896.0 52655.5 57457.1 58289.0 75843.6 76510.9 78094.6 78251.6 78520.2 11778.4 11783.1 12196.9 12343.4 12469.0 13600.9 13644.4 13660.3 13673.3 14259.7 10417.8 12411.5 12802.4 12826.7 13137.3 12287.1 12307.9 12825.2 12904.2 13218.7 10208.8 11964.1 12296.6 12435.8 12544.1 10193.2 10260.4 10380.3 10542.6 10622.8 9201.5 9501.0 10484.1 10509.8 10629.6 10:31:41 INFO - PROCESS | 1639 | -------- Summary: end -------- 10:31:41 INFO - PROCESS | 1639 | 10:31:42 INFO - TEST-INFO | 1639: exit 0 10:31:42 INFO - TEST-OK | dromaeo_css | took 1113598ms 10:31:42 INFO - TEST-START | kraken 10:31:42 INFO - operating with platform_type : mac_ 10:31:42 INFO - Initialising browser for kraken test... 10:31:42 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmprlnrlf/profile http://localhost:49236/getInfo.html) 10:31:44 INFO - PROCESS | 1651 | 2017-03-21 10:31:44.861 plugin-container[1653:9839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 10:31:44 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:31:44 INFO - PROCESS | 1651 | 2017-03-21 10:31:44.862 plugin-container[1653:9839] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 10:31:44 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:31:44 INFO - PROCESS | 1651 | 2017-03-21 10:31:44.862 plugin-container[1653:9839] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:31:44 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 10:31:44 INFO - PROCESS | 1651 | colorDepth:24 10:31:44 INFO - PROCESS | 1651 | Browser inner width/height: 1024/663 10:31:44 INFO - PROCESS | 1651 | __metrics 10:31:45 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 10:31:45 INFO - TEST-INFO | 1651: exit 0 10:31:45 INFO - Browser initialized. 10:31:45 INFO - Running cycle 1/1 for kraken test... 10:31:45 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmprlnrlf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:31:47 INFO - PROCESS | 1654 | 2017-03-21 10:31:47.934 plugin-container[1655:9963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863b, name = 'com.apple.tsm.portname' 10:31:47 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:31:47 INFO - PROCESS | 1654 | 2017-03-21 10:31:47.935 plugin-container[1655:9963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461f, name = 'com.apple.CFPasteboardClient' 10:31:47 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:31:47 INFO - PROCESS | 1654 | 2017-03-21 10:31:47.935 plugin-container[1655:9963] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:31:57 INFO - PROCESS | 1654 | RSS: Main: 182099968 10:31:57 INFO - PROCESS | 1654 | 10:32:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:01 INFO - PROCESS | 1654 | RSS: Main: 192897024 10:32:01 INFO - PROCESS | 1654 | 10:32:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 10:32:04 INFO - PROCESS | 1654 | RSS: Main: 201437184 10:32:04 INFO - PROCESS | 1654 | 10:32:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 10:32:08 INFO - PROCESS | 1654 | RSS: Main: 202395648 10:32:08 INFO - PROCESS | 1654 | 10:32:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 10:32:11 INFO - PROCESS | 1654 | RSS: Main: 203026432 10:32:11 INFO - PROCESS | 1654 | 10:32:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:13 INFO - PROCESS | 1654 | RSS: Main: 202924032 10:32:13 INFO - PROCESS | 1654 | 10:32:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:17 INFO - PROCESS | 1654 | RSS: Main: 206942208 10:32:17 INFO - PROCESS | 1654 | 10:32:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:20 INFO - PROCESS | 1654 | RSS: Main: 207097856 10:32:20 INFO - PROCESS | 1654 | 10:32:23 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 10:32:24 INFO - PROCESS | 1654 | RSS: Main: 206569472 10:32:24 INFO - PROCESS | 1654 | 10:32:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:26 INFO - PROCESS | 1654 | RSS: Main: 205516800 10:32:26 INFO - PROCESS | 1654 | 10:32:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:29 INFO - PROCESS | 1654 | RSS: Main: 205672448 10:32:29 INFO - PROCESS | 1654 | 10:32:31 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:31 INFO - PROCESS | 1654 | RSS: Main: 205533184 10:32:31 INFO - PROCESS | 1654 | 10:32:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:35 INFO - PROCESS | 1654 | RSS: Main: 205565952 10:32:35 INFO - PROCESS | 1654 | 10:32:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:39 INFO - PROCESS | 1654 | RSS: Main: 205946880 10:32:39 INFO - PROCESS | 1654 | 10:32:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 10:32:41 INFO - PROCESS | 1654 | RSS: Main: 207605760 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | __start_tp_report 10:32:41 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 10:32:41 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 10:32:41 INFO - PROCESS | 1654 | |i|pagename|runs| 10:32:41 INFO - PROCESS | 1654 | |0;ai-astar;114;120;153;174;132;117;116;120;117;116 10:32:41 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;110;109;143;109;108;109;103;132;110 10:32:41 INFO - PROCESS | 1654 | |2;audio-dft;228;188;281;284;198;196;194;199;193;197 10:32:41 INFO - PROCESS | 1654 | |3;audio-fft;81;58;61;103;65;59;59;58;71;59 10:32:41 INFO - PROCESS | 1654 | |4;audio-oscillator;83;79;103;90;100;101;113;60;81;110 10:32:41 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;86;91;87;90;87;89;90;92;87 10:32:41 INFO - PROCESS | 1654 | |6;imaging-darkroom;109;173;98;101;97;110;97;101;97;98 10:32:41 INFO - PROCESS | 1654 | |7;imaging-desaturate;91;95;92;93;91;92;93;97;141;91 10:32:41 INFO - PROCESS | 1654 | |8;json-parse-financial;59;58;58;57;58;61;61;62;61;61 10:32:41 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;68;70;76;73;72;69;71;70;73;73 10:32:41 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;80;83;84;84;84;88;84;87;90;91 10:32:41 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;149;178;168;157;153;133;133;155;180;150 10:32:41 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;170;166;169;161;194;230;205;164;193;226 10:32:41 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;67;64;64;67;65;65;62;66;67;64 10:32:41 INFO - PROCESS | 1654 | __end_tp_report 10:32:41 INFO - PROCESS | 1654 | __start_cc_report 10:32:41 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,957 10:32:41 INFO - PROCESS | 1654 | __end_cc_report 10:32:41 INFO - PROCESS | 1654 | __startTimestamp1490117561178__endTimestamp 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | ------- Summary: start ------- 10:32:41 INFO - PROCESS | 1654 | Number of tests: 14 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:127.90 Median:120.00 stddev:20.03 (16.7%) stddev-sans-first:20.60 10:32:41 INFO - PROCESS | 1654 | Values: 114.0 120.0 153.0 174.0 132.0 117.0 116.0 120.0 117.0 116.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:110.00 stddev:16.19 (14.7%) stddev-sans-first:13.34 10:32:41 INFO - PROCESS | 1654 | Values: 147.0 110.0 109.0 143.0 109.0 108.0 109.0 103.0 132.0 110.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:215.80 Median:198.50 stddev:36.76 (18.5%) stddev-sans-first:38.73 10:32:41 INFO - PROCESS | 1654 | Values: 228.0 188.0 281.0 284.0 198.0 196.0 194.0 199.0 193.0 197.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:67.40 Median:60.00 stddev:14.53 (24.2%) stddev-sans-first:14.56 10:32:41 INFO - PROCESS | 1654 | Values: 81.0 58.0 61.0 103.0 65.0 59.0 59.0 58.0 71.0 59.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:69.50 stddev:16.43 (23.6%) stddev-sans-first:17.10 10:32:41 INFO - PROCESS | 1654 | Values: 83.0 79.0 103.0 90.0 100.0 101.0 113.0 60.0 81.0 110.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.50 stddev:1.99 (2.2%) stddev-sans-first:2.11 10:32:41 INFO - PROCESS | 1654 | Values: 89.0 86.0 91.0 87.0 90.0 87.0 89.0 90.0 92.0 87.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:97.00 stddev:23.31 (24.0%) stddev-sans-first:24.72 10:32:41 INFO - PROCESS | 1654 | Values: 109.0 173.0 98.0 101.0 97.0 110.0 97.0 101.0 97.0 98.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:92.50 stddev:15.37 (16.6%) stddev-sans-first:16.12 10:32:41 INFO - PROCESS | 1654 | Values: 91.0 95.0 92.0 93.0 91.0 92.0 93.0 97.0 141.0 91.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:61.00 stddev:1.78 (2.9%) stddev-sans-first:1.87 10:32:41 INFO - PROCESS | 1654 | Values: 59.0 58.0 58.0 57.0 58.0 61.0 61.0 62.0 61.0 61.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:2.37 (3.3%) stddev-sans-first:2.15 10:32:41 INFO - PROCESS | 1654 | Values: 68.0 70.0 76.0 73.0 72.0 69.0 71.0 70.0 73.0 73.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:3.41 (4.0%) stddev-sans-first:2.98 10:32:41 INFO - PROCESS | 1654 | Values: 80.0 83.0 84.0 84.0 84.0 88.0 84.0 87.0 90.0 91.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:156.00 stddev:16.18 (10.4%) stddev-sans-first:16.99 10:32:41 INFO - PROCESS | 1654 | Values: 149.0 178.0 168.0 157.0 153.0 133.0 133.0 155.0 180.0 150.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.80 Median:193.50 stddev:25.89 (13.4%) stddev-sans-first:26.64 10:32:41 INFO - PROCESS | 1654 | Values: 170.0 166.0 169.0 161.0 194.0 230.0 205.0 164.0 193.0 226.0 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.66 (2.5%) stddev-sans-first:1.62 10:32:41 INFO - PROCESS | 1654 | Values: 67.0 64.0 64.0 67.0 65.0 65.0 62.0 66.0 67.0 64.0 10:32:41 INFO - PROCESS | 1654 | -------- Summary: end -------- 10:32:41 INFO - PROCESS | 1654 | 10:32:41 INFO - TEST-INFO | 1654: exit 0 10:32:42 INFO - TEST-OK | kraken | took 59857ms 10:32:42 INFO - SUITE-END | took 1173s 10:32:42 INFO - Completed test suite (00:19:33) 10:32:42 INFO - javascript benchmark 10:32:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7574.664747351471, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3470.6355832637573, 3480.1647604574896, 3497.1257185703566, 3506.4740288956655, 3513.8243087845603, 5681.772729090837, 5683.119116536938, 5762.855928601787, 5767.452092051259, 5785.82642520725, 5935.258092738408, 5939.584229103964, 5986.760529578812, 5993.883180746009, 5994.8501287467725, 5302.2841916341185, 5340.973295133519, 5377.569794416438, 5401.972990135064, 5422.864428389283, 5101.979604079181, 5337.14605663094, 5414.864628384302, 5441.83674489764, 5452.372977107624, 5224.39919409269, 5268.104422248227, 5333.120035194188, 5357.383900851374, 5389.245505629215, 4231.344141658048, 5215.24378965048, 5283.709395983219, 5343.839684809462, 5370.0, 4002.399640053986, 5254.185601231815, 5276.366835979668, 5276.762545685453, 5296.894062118736, 4729.574338309534, 5803.21656576361, 5877.617954832922, 5911.497522710575, 5948.940510594925, 6220.751169953196, 6251.906221406683, 6268.749250029993, 6291.779787707408, 6335.6198628082, 6394.58435201715, 6401.391867772554, 6404.423601875854, 6408.871822563523, 6427.807165785034, 6100.054491553817, 6112.877742445126, 6122.724477398483, 6128.816135515942, 6130.080487926802, 6272.529560282997, 6316.957701979214, 6361.840953976188, 6394.392532709385, 6422.0, 6243.8126856194385, 6300.0, 6303.117563541108, 6303.149074874925, 6332.556721029576, 6391.2330520337855, 6398.936010639927, 6400.327965563549, 6411.070394792729, 6417.454516366161, 6218.657973811484, 6220.471259942865, 6226.844328891723, 6240.0, 6265.091561723524, 6247.812565623039, 6276.0, 6293.0, 6303.842403939847, 6306.558540902093, 4372.672049596293, 5042.672226305279, 5115.1559992600805, 5119.539241468286, 5130.87172820675, 4489.775511224491, 4499.013894449666, 4539.773011349419, 4652.767361631905, 4652.790624421909, 6002.159697642333, 6064.848378790565, 6085.726142323606, 6108.267007958984, 6129.264488261437, 5333.6799792011825, 6374.840628984312, 6417.0, 6444.548881578338, 6452.548321617442, 5862.648241105548, 5923.111533270044, 6029.78895738647, 6036.3360030396625, 6107.328193898667, 4654.418197725285, 5576.052071147915, 5579.079451890474, 5607.775688972477, 5621.971890140605, 5467.371252306036, 6451.000094985285, 6514.54398192122, 6514.576552524166, 6592.24189218246, 6226.470749986121, 6274.623522588659, 6277.686115694289, 6370.1718776558755, 6399.2640846303275, 5514.0, 6506.121673574007, 6533.509986751108, 6584.012398140126, 6588.472922166119, 6275.937240627535, 6296.5592408530965, 6300.936990630218, 6302.243730752339, 6304.71628776697, 6112.868254063078, 6152.907706384318, 6370.331115232834, 6372.458341041063, 6385.712642931172, 6213.161223234986, 6234.875302493834, 6235.906461403173, 6277.18396608438, 6334.524910631629, 6272.4982001440685, 6296.685165741603, 6305.148804911279, 6309.148264984352, 6326.810195694136, 6075.939240607538, 6089.056196289582, 6228.750849965951, 6229.813105606839, 6257.874842503215, 6148.077788331786, 6160.845978850564, 6182.629042257479, 6190.350013248544, 6287.434130928238, 6164.291106522807, 6183.381661833961, 6214.0, 6217.067439884054, 6220.471259942956], "value": 5813.373265426528, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.8902668846133, 493.8098831949698, 505.8507740216636, 516.8061976758715, 520.8151106357243, 37264.25471490572, 44030.77984610076, 44045.119097618066, 46606.36877709281, 46704.532954670445, 44506.0, 45127.0, 45133.7743311283, 45195.64413067613, 45262.0, 9025.684101056464, 9570.947195808456, 9766.218702503782, 9775.0, 9799.755006124833, 7588.696452141908, 11484.655460336204, 11743.06055515561, 11836.940815295955, 11994.280343179393, 11641.59254426091, 11725.120615953794, 11778.823317650242, 11790.23363481371, 11800.704982375424, 11848.703782405466, 11912.761744765143, 11929.761404771856, 11943.104267179997, 11960.222585531956, 11836.112291578165, 11908.16642835002, 11908.404579771064, 11939.701507462383, 11967.94016029923, 43177.56822431767, 43386.0, 43411.78294108509, 43506.78246608778, 43553.346699799215, 4074.5110586729484, 4098.2418252623065, 4099.531510653373, 4170.103427763045, 4340.414044104037, 30433.0, 30741.077767666782, 31004.379912401626, 31056.91300804461, 33389.0, 2925.429541239459, 3183.984080079608, 3464.37641224582, 3513.859445622172, 3515.5605549306338, 495277.0, 495636.0, 496833.0, 497665.0, 500562.99437005527, 66065.0, 66406.0, 66443.66778166078, 66528.0, 66549.33450665529, 70308.94536581854, 70497.64751176313, 70591.64704176446, 70740.64629676922, 70966.9354959676, 15219.315130819139, 16351.59121021984, 17250.223739931735, 17546.210420531108, 17870.017149056926, 12715.427805748763, 12931.159474634118, 13550.661233469242, 13807.585772426843, 13963.162210267417, 18305.63388732218, 18339.908300458414, 18363.17365718546, 18383.0, 18407.447776566725, 7037.296270372922, 7905.288524032865, 8064.395170362246, 8147.388945829087, 8184.468009579358, 745.5861996591943, 770.3529035610114, 888.9466632002101, 937.2501998401252, 949.8907625623003, 31032.379352412827, 31833.52249716256, 32128.35743285121, 32149.196270092965, 32553.83723081417, 950.9001554836642, 1036.4506811389974, 1066.8133076711545, 1100.3892839474008, 1228.4901765767286, 15841.0, 16573.41993030238, 16588.50234492967, 16604.50186494407, 16724.331026758795, 633414.6658533355, 648765.0, 649425.0, 649652.0, 652289.0, 64451.35548644547, 65238.67380663161, 65251.02123468152, 65281.347186528474, 65335.0, 1449.0870751426535, 1464.1507925403453, 1479.7040591881666, 1499.737545929458, 1500.8799296056288, 29656.406871862873, 29919.55120673148, 31079.84460077685, 31132.688673112978, 31690.841545792122, 52952.73523632357, 53154.93690126253, 53181.20228196503, 53199.20201197063, 53301.0, 552023.0, 554030.459695414, 556392.0, 558926.0, 559534.0, 42394.36408453814, 42595.787021064694, 43400.0, 43494.13011739684, 43606.0, 48164.27753583769, 48304.29340591782, 49019.0, 49692.254616180064, 50013.74993125011, 36882.89351319465, 37389.0, 37799.05502362463, 39651.81044568668, 40307.79846100868, 36709.44935826018, 37088.81455592705, 37338.0, 38283.80858095692, 38465.4230186553, 37385.252294954495, 37897.0, 38139.42790858195, 38389.80805095957, 38427.42358864675, 31300.37399252048, 31436.68563314429, 32945.0, 33121.171970699965, 33121.668783311856, 24708.629370559815, 25022.74977250204, 25087.623685644365, 25286.24141275765, 25589.872050639628], "value": 21275.55124938158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.96787289143975, 399.1677352719581, 402.59338068550755, 410.4704930639475, 436.07334414369467, 16783.24475398607, 17551.0, 21252.256171034016, 22046.779532204673, 22328.0, 22295.554088918212, 22856.542869142606, 23177.072917083296, 23633.645495317585, 23835.880820595918, 5768.451997060283, 6017.48851347636, 6049.274087109531, 6055.940210463174, 6063.333033366326, 5589.077802162638, 5849.795257166, 5886.558508111887, 5926.140709597106, 6020.879582408349, 4980.302757613937, 5921.911171332434, 5926.3184733755525, 5934.0, 5944.464998150165, 4970.329005584236, 5690.57320700947, 5886.058230683092, 5951.642901425928, 5959.284885813687, 4925.211966085445, 5810.767569297223, 5819.098039803837, 5819.67991760453, 5843.2695913010875, 26194.73805261942, 26910.789014494396, 27303.863480682667, 28063.29841753952, 28436.715632843614, 3027.0, 3030.3030303030428, 3039.680833512494, 3044.5128779395413, 3046.3754930239247, 10526.736831579195, 10988.505517251742, 11077.944610276978, 13354.666133346744, 15020.549383518512, 1780.7952085510203, 1842.6314737052644, 1875.7749070111538, 1889.5559543507266, 1900.9904950475159, 152430.0, 154235.0, 156711.0, 157296.0, 158926.0, 12384.256944583354, 12386.132970691964, 12397.566085187156, 12441.751164976831, 12568.120231583702, 14657.706845863024, 15360.001599895972, 16487.422940197037, 16508.33966641345, 16519.09144997037, 8954.686585969459, 9183.724488265363, 9322.673706420379, 9367.484788336571, 9457.43255404678, 9150.862737058816, 9153.54232288383, 9178.954105229432, 9182.081791820765, 9280.0, 4934.6545741798445, 4989.825356112518, 4991.07665081961, 4993.850184494471, 5028.145215313405, 1882.9079134102187, 2002.9399118026483, 2071.7099606055162, 2116.523782149004, 2118.9152433902777, 1028.9742756431149, 1030.3508789462592, 1043.1654676258963, 1059.86751656043, 1113.6603335982604, 16881.493555193363, 22269.220577279717, 22513.662295065587, 22698.886505567367, 22712.432189195402, 1054.0460882900986, 1060.2366296266675, 1077.789830982951, 1101.8843021482628, 1103.707517507861, 11437.542498299976, 11548.826767598493, 11666.650000499998, 11686.883131168579, 11693.0, 805031.0, 807219.0, 810722.0, 828018.0, 830644.0, 122654.77345226433, 142665.28667356598, 153372.2331388336, 160482.0, 160821.0, 1075.8601381820313, 1078.347599702169, 1100.8733995590449, 1101.7521057762099, 1103.779244151173, 14485.710285794436, 19561.70657440168, 19815.504612384804, 19858.0, 19978.60042799165, 55205.0, 57499.71250143723, 58412.0, 58669.0, 58729.0, 68727.0, 84854.0, 87876.1212387868, 89189.0, 89267.55366223128, 8336.541490218096, 8461.576921154041, 8530.70142545008, 8674.517117885654, 8983.505907174907, 12317.507299707911, 13104.017198709944, 13187.934060329637, 13348.466061357825, 13518.459261629818, 11354.091672666333, 11371.31772093677, 11415.0, 11423.657290281304, 11518.790526994544, 11073.667789966314, 11336.319820810448, 11353.091752659933, 11479.024282936043, 11685.357305347947, 9671.17794987434, 11303.7739245213, 11950.641480755592, 11984.0, 12051.216670916363, 6789.932100679128, 8203.42576019673, 8563.785905352415, 8567.357448191535, 8803.647854085764, 8588.398812083095, 10706.62526811589, 11731.061515078603, 11772.882271177521, 11877.821832672344], "value": 10316.871842823719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.404514149199, 1452.4262916148127, 1499.9175045372501, 1502.106246783164, 1506.088816266159, 7726.072871255443, 7974.242446967543, 8231.176882311765, 8689.000764912029, 8697.086805885378, 7334.229905859888, 8210.671573137082, 8217.753467395973, 8329.833403331944, 8336.958315208416, 1939.4278687787137, 1997.2809788476136, 2421.128393778238, 2422.6123820188773, 2425.5876500994787, 2414.782669559739, 2425.7938075263537, 2447.6904855902094, 2447.7674620910984, 2452.19077704358, 2028.6956956456577, 2372.9762702372927, 2391.7129944406697, 2416.492536567323, 2426.963595546068, 2370.2533701883854, 2377.227401094651, 2383.856968581882, 2393.8563686178886, 2402.675638788767, 2023.9172042956948, 2425.3087869957153, 2427.8664673442954, 2428.2351059416405, 2430.1373012580457, 8516.914830851736, 8583.52790596517, 8596.398252122353, 8640.654373825102, 8651.394402391772, 5045.520675535819, 5171.974140129275, 5179.741012949337, 5188.507091826308, 5199.4800519948085, 3439.3465241604267, 3610.277944411102, 3654.689351405134, 3703.9073473325434, 3709.7588656737225, 1221.2123180548497, 1246.6260121963376, 1298.3767791460057, 1305.0668771828093, 1314.9013823963146, 11008.284461509977, 11052.889471105267, 11070.225084244106, 11089.001989820956, 11096.778064438666, 3668.761530500509, 4604.6895026992925, 4795.352627395327, 4823.710577365369, 4841.15279826029, 9629.0, 9695.175910047585, 9710.223182145412, 9744.07431294026, 9751.463669498246, 4558.88602784933, 5246.396664383568, 5371.355437347465, 5373.785048598091, 5385.434529374359, 4243.618074373321, 4859.538343857328, 4870.7808148632685, 4907.631927605373, 4966.875828104254, 3390.983045084808, 3956.050547868491, 3959.861404850874, 4070.043539768152, 4082.2856000199845, 1310.122218113866, 1325.7945018522144, 1329.4947919790418, 1339.136257114156, 1346.1855577375743, 926.0970553710079, 932.2774849491562, 934.4486752815872, 938.1837801113076, 957.0572985609169, 5274.26160337553, 5545.72271386429, 5635.830925072172, 5813.128030795415, 5865.032269675541, 584.2550747796508, 588.0121396054669, 589.9439553242435, 594.9672767997802, 608.5892022884535, 3735.495708079429, 3788.962110378916, 3814.7901865397116, 3823.0, 3902.1220225449047, 9541.570629321697, 9774.218062554979, 9967.850482242773, 9997.200223982063, 10353.327033742933, 9970.700878973643, 10105.5452504636, 10108.949455252676, 10126.088652021353, 10133.341332813343, 7641.3886889048745, 7888.329491993245, 7993.960030199812, 8027.959860200778, 8040.2361775631225, 5608.6073974821375, 5642.3229212493125, 5739.827805165852, 5786.537077033911, 5795.188673585617, 9207.539623018689, 9369.484678342757, 9464.432134071978, 9540.141387275178, 9582.66460673873, 9030.683926062819, 9403.717888463358, 9474.099960503741, 9480.573374198315, 9523.285753568649, 6735.191776986793, 6947.756828510978, 7271.818204544717, 7420.6289685516585, 7433.2195119513835, 7787.4548781584745, 7942.483738556975, 8050.396220283619, 8127.593620318842, 8175.79560510992, 7116.46626503004, 7256.0, 7300.853982920418, 7320.487565870551, 7372.926270737224, 5938.0, 6431.485481161402, 7154.320339567733, 7184.497085203986, 7318.048653674989, 6385.074164246251, 6453.419192272718, 6521.804345869631, 6522.315156908646, 6524.934750652433, 5012.521306214602, 5017.071841709149, 5079.3650793650795, 5085.4914508548845, 5087.567556757717, 4936.8398426370495, 5078.187490001582, 5146.459621739664, 5147.099257629975, 5205.505476979833], "value": 4442.582766021811, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.172664095746, 374.63285979739857, 380.9828557714903, 383.1379396358193, 384.4195265149625, 5444.972775136119, 5562.777488900444, 5573.41479144689, 5607.439256074391, 5641.210230567719, 5383.919241211385, 5554.72226388681, 5632.0, 5656.644383824453, 5685.403032681571, 4151.252774500589, 4274.871753847374, 4285.228658841407, 4405.127820676208, 4424.269995450747, 4249.3413520904305, 4258.276093064186, 4260.211860805745, 4277.401163837066, 4281.35779633056, 3779.281936432083, 3968.0597655918423, 4199.55904630014, 4248.638865696419, 4264.104538046999, 3427.3830710472107, 3617.5116359291424, 4094.651954583864, 4272.786360681954, 4280.951166964098, 3585.243230816907, 3635.5641720047633, 3642.981785091084, 3657.817109144559, 3658.963410365889, 5206.349206349207, 5496.268675367247, 5497.505224529811, 5534.529564986981, 5538.0, 4800.0, 4939.913219091794, 4945.184044632631, 4960.925586116211, 4967.950320496785, 5000.449950505442, 5263.578913686934, 5985.892609867188, 5999.340072592011, 6011.16659418877, 3664.6152154023976, 4006.8380169750735, 4070.0463777386726, 4081.5306239782212, 4092.3452247640535, 5064.873378165538, 5269.947300526984, 6239.344868788802, 6311.495080393557, 6392.520560957901, 3594.4608308753373, 3973.3443981743267, 4034.1931613677384, 4095.385692146202, 4099.795010249476, 3688.170161713647, 4111.157212771374, 4150.211459822624, 4159.584041595876, 4172.874813755592, 4892.107892107892, 4897.2898929655, 4906.411230652345, 4910.803567857246, 4920.384951881015, 4962.503749625009, 5413.864653383697, 5897.675627840425, 6040.697965101727, 6094.939050609526, 1166.3759888459633, 1213.1568559850996, 1338.852726200117, 1348.6089034179977, 1357.1653433138747, 832.908889354947, 868.70898249086, 908.8000639859221, 919.990800092004, 925.9397989302212, 4681.50844161365, 5160.7423875302275, 5279.096496926675, 5387.919181212285, 5401.297831281908, 5664.915026274609, 5851.654119552527, 5858.945389829786, 6016.488598469092, 6028.849278767978, 4395.120975804852, 5365.490278423544, 5365.570754339644, 5408.945910540923, 5431.402545719968, 2791.199676208834, 2799.398129402148, 2819.4783964966546, 3002.8648710808066, 3078.7536997040183, 5694.092479019575, 6039.54703397247, 6043.305019922677, 6045.486133678599, 6101.633901965807, 5592.720363981784, 5928.258967629046, 6269.341719119518, 6290.119383286344, 6352.523560732963, 6339.809805705836, 6369.331220221903, 6404.48764098871, 6409.141349008735, 6411.390917862889, 5027.597792176544, 5889.293284805851, 6039.698015099139, 6042.072652775731, 6197.03945888388, 5356.946430535801, 5665.858353541194, 5950.613210141327, 6117.981066248217, 6133.815985520441, 5772.797952071657, 5884.58807883444, 6350.015747559136, 6410.576702075553, 6476.190476190476, 4017.718759686794, 4082.3672330788777, 4098.692598055218, 4114.0, 4124.876253712393, 5343.465653434625, 5907.400743672771, 6234.594751341148, 6240.563160578716, 6250.593711408926, 4915.139850526215, 4997.800087996439, 5942.346341902301, 6007.969960150172, 6008.849778755566, 5526.557875370041, 5936.376680448663, 5991.400859913973, 6033.366496517978, 6054.424829641177, 4909.9263511048075, 5571.916421253765, 5819.330776960704, 5876.795256972396, 5919.7040147991565, 5137.6660517066275, 5158.845234642967, 5748.54011679073, 5881.676507792113, 5940.8811823764145, 4930.704157750546, 5661.830145095653, 5832.387599302182, 5937.91093133612, 5942.851428714317], "value": 4318.231664383413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.1796482851282, 755.1844008470852, 791.3629528229776, 870.7387783664901, 877.749841295231, 14636.536346365358, 15039.473618423357, 15506.534803955885, 16459.423920162797, 16909.7463538047, 14925.477608283712, 15303.770443443329, 15348.539543813675, 15358.616034599141, 16078.678426431494, 878.6353663229752, 908.3686837647838, 910.0626354854511, 916.6883259691704, 917.2799352508282, 885.3448448148356, 915.6428992692855, 921.6221349246777, 930.7347405989294, 933.8272419602362, 945.6170251048336, 961.6730311694023, 961.6970654243926, 965.9227261819073, 966.1932286540712, 958.228625956105, 959.7072892767703, 961.3462845265217, 961.543266948201, 961.7739831139642, 715.5778090926378, 721.6896734404204, 723.7032816545192, 724.5543990445891, 726.429752644177, 15688.294026768823, 15908.522744317688, 16191.919040404722, 16582.917085414494, 16784.992900425892, 12293.56972505967, 14642.560723178321, 14663.900207484374, 14859.108453492825, 15062.849371506254, 11697.883021169764, 11801.232919860182, 11852.822207666892, 11873.16887817853, 12349.0, 3407.216340241758, 3795.411711184771, 3858.614138586147, 3871.7870517121546, 4003.15933653933, 107369.0, 107724.0, 107803.46098269537, 108906.0, 110347.9999999992, 10984.780304393867, 11242.325460472235, 11348.489317980711, 11429.085673146295, 11882.0, 23151.7684823153, 23407.297781066256, 23636.17273395423, 23817.880910595337, 23901.043958241822, 6655.600663960178, 7985.321247693895, 8042.959785201154, 8134.552599607078, 8235.752927412188, 4302.65578753699, 4361.694681372273, 4363.5418281080665, 4382.956170438319, 4434.091011342667, 3811.790351530637, 3869.0520822398694, 3878.7478813877005, 3913.726039177287, 3926.371780515104, 677.9423748981392, 679.3512195852949, 680.0750978669006, 687.6424259385092, 722.9530080544853, 702.1503980183933, 703.1421665567999, 730.9488335816549, 737.2443245673228, 747.4543583184305, 10696.251262411712, 10827.891721082846, 10868.891311086945, 11111.722206944729, 11265.71835704114, 616.2943429772885, 629.7323637454064, 636.3922454056365, 655.367570294668, 664.8271449423185, 5096.159133742965, 5242.842714718565, 5245.291885595472, 5254.527092561688, 5258.6581872178185, 85764.57117714496, 110015.0, 110938.3359249612, 113015.0, 114136.0, 72266.9159962601, 93304.0, 96637.0, 97001.514992426, 101705.91470426449, 84581.57709211537, 84945.57527212324, 86884.00303260026, 88314.0, 90621.0, 10069.647562335576, 10147.289689721943, 10191.796164076528, 10208.183345332503, 10255.07704306616, 38745.837624871296, 40896.0, 52655.47344526506, 57457.12714364182, 58289.0, 75843.62078189573, 76510.8523372161, 78094.609526952, 78251.60874195592, 78520.21479785358, 11778.411079446165, 11783.116266279892, 12196.878031219574, 12343.382830858602, 12469.0, 13600.862912730228, 13644.386002630104, 13660.316984150553, 13673.31633418345, 14259.714805703621, 10417.791644166922, 12411.503539858304, 12802.423890925116, 12826.743465130832, 13137.343132843129, 12287.1399002069, 12307.938460307641, 12825.166364186298, 12904.225746455242, 13218.669533261746, 10208.846867297145, 11964.102692297938, 12296.569620063256, 12435.813462798245, 12544.059195560187, 10193.184545236216, 10260.384376937109, 10380.27338086357, 10542.57829686804, 10622.787544248917, 9201.53992300369, 9501.0, 10484.108850747773, 10509.789804204025, 10629.627963021258], "value": 7714.968381921757, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 153.0, 174.0, 132.0, 117.0, 116.0, 120.0, 117.0, 116.0], "value": 127.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 109.0, 143.0, 109.0, 108.0, 109.0, 103.0, 132.0, 110.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 188.0, 281.0, 284.0, 198.0, 196.0, 194.0, 199.0, 193.0, 197.0], "value": 215.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 61.0, 103.0, 65.0, 59.0, 59.0, 58.0, 71.0, 59.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 103.0, 90.0, 100.0, 101.0, 113.0, 60.0, 81.0, 110.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 87.0, 90.0, 87.0, 89.0, 90.0, 92.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 173.0, 98.0, 101.0, 97.0, 110.0, 97.0, 101.0, 97.0, 98.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 92.0, 93.0, 91.0, 92.0, 93.0, 97.0, 141.0, 91.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 57.0, 58.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 76.0, 73.0, 72.0, 69.0, 71.0, 70.0, 73.0, 73.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 84.0, 84.0, 84.0, 88.0, 84.0, 87.0, 90.0, 91.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 178.0, 168.0, 157.0, 153.0, 133.0, 133.0, 155.0, 180.0, 150.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 169.0, 161.0, 194.0, 230.0, 205.0, 164.0, 193.0, 226.0], "value": 187.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 67.0, 65.0, 65.0, 62.0, 66.0, 67.0, 64.0], "value": 65.1, "unit": "score"}]}]} 10:32:42 INFO - Return code: 0 10:32:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:32:42 ERROR - # TBPL SUCCESS # 10:32:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:32:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:32:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:32:42 INFO - 2017-03-21 10:32:42.527 screenresolution[1659:10339] starting screenresolution argv=screenresolution get 10:32:42 INFO - 2017-03-21 10:32:42.529 screenresolution[1659:10339] Display 0: 1600x1200x32@60 10:32:42 INFO - 2017-03-21 10:32:42.535 screenresolution[1660:10342] starting screenresolution argv=screenresolution list 10:32:42 INFO - Available Modes on Display 0 10:32:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:32:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:32:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:32:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:32:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:32:42 INFO - Intel Iris: 10:32:42 INFO - Chipset Model: Intel Iris 10:32:42 INFO - Type: GPU 10:32:42 INFO - Bus: Built-In 10:32:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:32:42 INFO - Vendor: Intel (0x8086) 10:32:42 INFO - Device ID: 0x0a2e 10:32:42 INFO - Revision ID: 0x0009 10:32:42 INFO - Displays: 10:32:42 INFO - Display: 10:32:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:32:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:32:42 INFO - Display Serial Number: 1600x1200 60 10:32:42 INFO - Main Display: Yes 10:32:42 INFO - Mirror: Off 10:32:42 INFO - Online: Yes 10:32:42 INFO - Rotation: Supported 10:32:42 INFO - Return code: 0 10:32:42 INFO - Running post-action listener: _resource_record_post_action 10:32:42 INFO - [mozharness: 2017-03-21 17:32:42.769872Z] Finished run-tests step (success) 10:32:42 INFO - Running post-run listener: _resource_record_post_run 10:32:42 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 41822208; Write bytes: 424371200; Read time: 414; Write time: 1434 10:32:42 INFO - TinderboxPrint: CPU usage
54.3% 10:32:42 INFO - TinderboxPrint: I/O read bytes / time
41,822,208 / 414 10:32:42 INFO - TinderboxPrint: I/O write bytes / time
424,371,200 / 1,434 10:32:42 INFO - TinderboxPrint: CPU idle
2,174.3 (45.7%) 10:32:42 INFO - TinderboxPrint: CPU system
957.0 (20.1%) 10:32:42 INFO - TinderboxPrint: CPU user
1,626.4 (34.2%) 10:32:42 INFO - TinderboxPrint: Swap in / out
162,582,528 / 0 10:32:42 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 110029312; Write bytes: 102264832; Read time: 9988; Write time: 190 10:32:42 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 40839168; Write bytes: 301618176; Read time: 399; Write time: 1187 10:32:43 INFO - Running post-run listener: _upload_blobber_files 10:32:43 INFO - Blob upload gear active. 10:32:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32: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 10:32: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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:32: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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:32:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:32:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:45 INFO - (blobuploader) - INFO - Done attempting. 10:32:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:32:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:32:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:46 INFO - (blobuploader) - INFO - Done attempting. 10:32:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:32:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:32:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:47 INFO - (blobuploader) - INFO - Done attempting. 10:32:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:49 INFO - (blobuploader) - INFO - Done attempting. 10:32:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:49 INFO - Return code: 0 10:32:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bcb42d041f22b72a02cc287a7caddda09e5de6a92f30ae634f5cee9d8d47547ee3cc8c92779e33ff5ad6e985530c06770fb4ca1d47d73c1d6a27ae6aa89889d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e678eb95bd0921e2226787f3cd70e6c42493995e468c3409594e0749eb30b68c98a86c12757010c2bcf950b7b649b98b1587170eddf2969b5be5e63b33745ce4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20933973b0c8df76a2d74eae3d9c07fbe520ff7a4a60bba1fe9d2d1161883995baf73c3e65b6d0a61102851c033597062f2887910cd03d8dfa45b3d2fd112b21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3147b13bb2a2cca7cbeb24c7a72dd94218e20f5aa6fd6663b6c8fa5eb12ac7caba37550f3c8f97420ae25a54dbfcea612e1f26f71abfa888f8afc5bd90a70874"} 10:32:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:49 INFO - Contents: 10:32:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bcb42d041f22b72a02cc287a7caddda09e5de6a92f30ae634f5cee9d8d47547ee3cc8c92779e33ff5ad6e985530c06770fb4ca1d47d73c1d6a27ae6aa89889d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e678eb95bd0921e2226787f3cd70e6c42493995e468c3409594e0749eb30b68c98a86c12757010c2bcf950b7b649b98b1587170eddf2969b5be5e63b33745ce4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20933973b0c8df76a2d74eae3d9c07fbe520ff7a4a60bba1fe9d2d1161883995baf73c3e65b6d0a61102851c033597062f2887910cd03d8dfa45b3d2fd112b21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3147b13bb2a2cca7cbeb24c7a72dd94218e20f5aa6fd6663b6c8fa5eb12ac7caba37550f3c8f97420ae25a54dbfcea612e1f26f71abfa888f8afc5bd90a70874"} 10:32:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:49 INFO - Copying logs to upload dir... 10:32:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.388277 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-21 10:32:49.312225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 10:32:49.315418) ========= 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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bcb42d041f22b72a02cc287a7caddda09e5de6a92f30ae634f5cee9d8d47547ee3cc8c92779e33ff5ad6e985530c06770fb4ca1d47d73c1d6a27ae6aa89889d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e678eb95bd0921e2226787f3cd70e6c42493995e468c3409594e0749eb30b68c98a86c12757010c2bcf950b7b649b98b1587170eddf2969b5be5e63b33745ce4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20933973b0c8df76a2d74eae3d9c07fbe520ff7a4a60bba1fe9d2d1161883995baf73c3e65b6d0a61102851c033597062f2887910cd03d8dfa45b3d2fd112b21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3147b13bb2a2cca7cbeb24c7a72dd94218e20f5aa6fd6663b6c8fa5eb12ac7caba37550f3c8f97420ae25a54dbfcea612e1f26f71abfa888f8afc5bd90a70874"} build_url:https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/OpvxXV8ARsqKSsIVUUZr1w/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5bcb42d041f22b72a02cc287a7caddda09e5de6a92f30ae634f5cee9d8d47547ee3cc8c92779e33ff5ad6e985530c06770fb4ca1d47d73c1d6a27ae6aa89889d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e678eb95bd0921e2226787f3cd70e6c42493995e468c3409594e0749eb30b68c98a86c12757010c2bcf950b7b649b98b1587170eddf2969b5be5e63b33745ce4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20933973b0c8df76a2d74eae3d9c07fbe520ff7a4a60bba1fe9d2d1161883995baf73c3e65b6d0a61102851c033597062f2887910cd03d8dfa45b3d2fd112b21", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3147b13bb2a2cca7cbeb24c7a72dd94218e20f5aa6fd6663b6c8fa5eb12ac7caba37550f3c8f97420ae25a54dbfcea612e1f26f71abfa888f8afc5bd90a70874"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 10:32:49.350253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:32:49.350588) ========= 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.ffgvZAXZqX/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.KJpKtVpp6q/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 10:32:49.398762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 10:32:49.399100) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 10:32:49.399410) ========= ========= Total master_lag: 0.47 =========