builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0250 starttime: 1474976200.15 results: success (0) buildid: 20160927021850 builduid: bc7d618d1b0046f7845fd1f8323ecb6d revision: 7b050ca8ec6474c6d7131d0ebd352e8624992016 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.146899) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.147319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.147658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.208394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.208669) ========= 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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-27 04:36:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-09-27 04:36:40 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.454032 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.693526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.693805) ========= 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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.039650 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.753813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:40.754129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7b050ca8ec6474c6d7131d0ebd352e8624992016 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7b050ca8ec6474c6d7131d0ebd352e8624992016 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-27 04:36:40,837 truncating revision to first 12 chars 2016-09-27 04:36:40,837 Setting DEBUG logging. 2016-09-27 04:36:40,837 attempt 1/10 2016-09-27 04:36:40,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7b050ca8ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 04:36:41,140 unpacking tar archive at: mozilla-central-7b050ca8ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:41.368285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:41.371735) ========= script_repo_revision: 7b050ca8ec6474c6d7131d0ebd352e8624992016 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:41.372211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:41.372485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 04:36:41.400944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-27 04:36:41.401352) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:36:41 INFO - MultiFileLogger online at 20160927 04:36:41 in /builds/slave/test 04:36:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:36:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:41 INFO - {'append_to_log': False, 04:36:41 INFO - 'base_work_dir': '/builds/slave/test', 04:36:41 INFO - 'blob_upload_branch': 'Firefox', 04:36:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:41 INFO - 'branch': 'Firefox', 04:36:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:41 INFO - 'config_files': ('talos/mac_config.py',), 04:36:41 INFO - 'default_actions': ('clobber', 04:36:41 INFO - 'read-buildbot-config', 04:36:41 INFO - 'download-and-extract', 04:36:41 INFO - 'populate-webroot', 04:36:41 INFO - 'create-virtualenv', 04:36:41 INFO - 'install', 04:36:41 INFO - 'run-tests'), 04:36:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:41 INFO - 'download_minidump_stackwalk': True, 04:36:41 INFO - 'download_symbols': 'ondemand', 04:36:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:41 INFO - 'installer_path': 'installer.exe', 04:36:41 INFO - 'log_level': 'info', 04:36:41 INFO - 'log_name': 'talos', 04:36:41 INFO - 'log_to_console': True, 04:36:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:36:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:36:41 INFO - 'opt_config_files': (), 04:36:41 INFO - 'pip_index': False, 04:36:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:41 INFO - 'cmd': ('bash', 04:36:41 INFO - '-c', 04:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:41 INFO - 'enabled': True, 04:36:41 INFO - 'halt_on_failure': False, 04:36:41 INFO - 'name': 'check_screen_resolution'},), 04:36:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:41 INFO - 'cmd': ('bash', 04:36:41 INFO - '-c', 04:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:41 INFO - 'enabled': True, 04:36:41 INFO - 'halt_on_failure': False, 04:36:41 INFO - 'name': 'check_screen_resolution'},), 04:36:41 INFO - 'run_cmd_checks_enabled': True, 04:36:41 INFO - 'sps_profile': False, 04:36:41 INFO - 'sps_profile_interval': 0, 04:36:41 INFO - 'suite': 'dromaeojs-e10s', 04:36:41 INFO - 'system_bits': '32', 04:36:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:41 INFO - 'title': 't-yosemite-r7-0250', 04:36:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:41 INFO - 'use_talos_json': True, 04:36:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:41 INFO - 'work_dir': 'build'} 04:36:41 INFO - [mozharness: 2016-09-27 11:36:41.616582Z] Running clobber step. 04:36:41 INFO - Running pre-action listener: _resource_record_pre_action 04:36:41 INFO - Running main action method: clobber 04:36:41 INFO - rmtree: /builds/slave/test/build 04:36:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:43 INFO - Running post-action listener: _resource_record_post_action 04:36:43 INFO - [mozharness: 2016-09-27 11:36:43.789246Z] Finished clobber step (success) 04:36:43 INFO - [mozharness: 2016-09-27 11:36:43.789367Z] Running read-buildbot-config step. 04:36:43 INFO - Running pre-action listener: _resource_record_pre_action 04:36:43 INFO - Running main action method: read_buildbot_config 04:36:43 INFO - Using buildbot properties: 04:36:43 INFO - { 04:36:43 INFO - "project": "", 04:36:43 INFO - "product": "firefox", 04:36:43 INFO - "script_repo_revision": "production", 04:36:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:36:43 INFO - "repository": "", 04:36:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:36:43 INFO - "buildid": "20160927021850", 04:36:43 INFO - "pgo_build": "False", 04:36:43 INFO - "basedir": "/builds/slave/test", 04:36:43 INFO - "buildnumber": 1, 04:36:43 INFO - "slavename": "t-yosemite-r7-0250", 04:36:43 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:36:43 INFO - "platform": "yosemite_r7", 04:36:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:36:43 INFO - "branch": "mozilla-central", 04:36:43 INFO - "repo_path": "mozilla-central", 04:36:43 INFO - "revision": "7b050ca8ec6474c6d7131d0ebd352e8624992016", 04:36:43 INFO - "stage_platform": "macosx64", 04:36:43 INFO - "builduid": "bc7d618d1b0046f7845fd1f8323ecb6d", 04:36:43 INFO - "slavebuilddir": "test" 04:36:43 INFO - } 04:36:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:36:43 INFO - Running post-action listener: _resource_record_post_action 04:36:43 INFO - [mozharness: 2016-09-27 11:36:43.792943Z] Finished read-buildbot-config step (success) 04:36:43 INFO - [mozharness: 2016-09-27 11:36:43.793133Z] Running download-and-extract step. 04:36:43 INFO - Running pre-action listener: _resource_record_pre_action 04:36:43 INFO - Running main action method: download_and_extract 04:36:43 INFO - mkdir: /builds/slave/test/build/tests 04:36:43 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')]} 04:36:43 INFO - trying https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:43 INFO - Downloading https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:36:44 INFO - Downloaded 1199 bytes. 04:36:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:44 INFO - Using the following test package requirements: 04:36:44 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:36:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:36:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:36:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'jsshell-mac.zip'], 04:36:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:36:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:36:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:36:44 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:36:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:36:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:44 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:36:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:36:45 INFO - Expected file size: 16468943 04:36:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:36:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:52 INFO - Fetch https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:36:52 INFO - Expected file size: 16468943 04:36:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:36:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:37:00 INFO - Expected file size: 14414057 04:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:01 INFO - trying https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:37:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:37:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:37:04 INFO - Downloaded 111597583 bytes. 04:37:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:37:04 INFO - mkdir: /builds/slave/test/properties 04:37:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:04 INFO - Contents: 04:37:04 INFO - build_url:https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:37:05 INFO - Running post-action listener: _resource_record_post_action 04:37:05 INFO - Running post-action listener: set_extra_try_arguments 04:37:05 INFO - [mozharness: 2016-09-27 11:37:05.209322Z] Finished download-and-extract step (success) 04:37:05 INFO - [mozharness: 2016-09-27 11:37:05.209465Z] Running populate-webroot step. 04:37:05 INFO - Running pre-action listener: _resource_record_pre_action 04:37:05 INFO - Running main action method: populate_webroot 04:37:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:05 INFO - '--tppagecycles', 04:37:05 INFO - '7'], 04:37:05 INFO - 'tests': ['tsvgm']}}, 04:37:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:37:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:37:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['damp', 'tps']}, 04:37:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'tests': ['damp', 'tps']}, 04:37:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['dromaeo_dom']}, 04:37:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['basic_compositor_video']}, 04:37:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:37:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['a11yr', 04:37:05 INFO - 'ts_paint', 04:37:05 INFO - 'tpaint', 04:37:05 INFO - 'sessionrestore', 04:37:05 INFO - 'sessionrestore_no_auto_restore', 04:37:05 INFO - 'tabpaint']}, 04:37:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['tsvgx', 04:37:05 INFO - 'tsvgr_opacity', 04:37:05 INFO - 'tart', 04:37:05 INFO - 'tscrollx', 04:37:05 INFO - 'cart']}, 04:37:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:37:05 INFO - 'tsvgr_opacity', 04:37:05 INFO - 'tart', 04:37:05 INFO - 'tscrollx', 04:37:05 INFO - 'cart']}, 04:37:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'talos_options': ['--disable-e10s'], 04:37:05 INFO - 'tests': ['tp5o']}, 04:37:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'tests': ['tp5o']}, 04:37:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'talos_options': ['--disable-e10s', 04:37:05 INFO - '--xperf_path', 04:37:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:05 INFO - 'tests': ['tp5n']}, 04:37:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:05 INFO - 'talos_options': ['--xperf_path', 04:37:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:05 INFO - 'tests': ['tp5n']}}, 04:37:05 INFO - 'talos.zip': {'path': '', 04:37:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:05 INFO - Running post-action listener: _resource_record_post_action 04:37:05 INFO - [mozharness: 2016-09-27 11:37:05.228452Z] Finished populate-webroot step (success) 04:37:05 INFO - [mozharness: 2016-09-27 11:37:05.228558Z] Running create-virtualenv step. 04:37:05 INFO - Running pre-action listener: _resource_record_pre_action 04:37:05 INFO - Running main action method: create_virtualenv 04:37:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:05 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 04:37:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:05 INFO - Using real prefix '/tools/python27' 04:37:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:08 INFO - Installing pip.................done. 04:37:08 INFO - Return code: 0 04:37:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:37:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:37:09 INFO - Reading from file tmpfile_stdout 04:37:09 INFO - Output received: 04:37:09 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) 04:37:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:09 INFO - 'HOME': '/Users/cltbld', 04:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:09 INFO - 'LOGNAME': 'cltbld', 04:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:09 INFO - 'MOZ_NO_REMOTE': '1', 04:37:09 INFO - 'NO_EM_RESTART': '1', 04:37:09 INFO - 'PAGER': '/bin/cat', 04:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:09 INFO - 'PWD': '/builds/slave/test', 04:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:09 INFO - 'SHELL': '/bin/bash', 04:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:09 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:09 INFO - 'USER': 'cltbld', 04:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:09 INFO - 'XPC_FLAGS': '0x0', 04:37:09 INFO - 'XPC_SERVICE_NAME': '0', 04:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 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 04:37:09 INFO - Cleaning up... 04:37:09 INFO - Return code: 0 04:37:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:09 INFO - 'HOME': '/Users/cltbld', 04:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:09 INFO - 'LOGNAME': 'cltbld', 04:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:09 INFO - 'MOZ_NO_REMOTE': '1', 04:37:09 INFO - 'NO_EM_RESTART': '1', 04:37:09 INFO - 'PAGER': '/bin/cat', 04:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:09 INFO - 'PWD': '/builds/slave/test', 04:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:09 INFO - 'SHELL': '/bin/bash', 04:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:09 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:09 INFO - 'USER': 'cltbld', 04:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:09 INFO - 'XPC_FLAGS': '0x0', 04:37:09 INFO - 'XPC_SERVICE_NAME': '0', 04:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 INFO - Downloading/unpacking psutil>=3.1.1 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:12 INFO - Installing collected packages: psutil 04:37:12 INFO - Running setup.py install for psutil 04:37:13 INFO - building 'psutil._psutil_osx' extension 04:37:13 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 04:37:13 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 04:37:13 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 04:37:13 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 04:37:13 INFO - building 'psutil._psutil_posix' extension 04:37:13 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 04:37:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:13 INFO - ^ 04:37:13 INFO - 1 warning generated. 04:37:13 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 04:37:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:14 INFO - Successfully installed psutil 04:37:14 INFO - Cleaning up... 04:37:14 INFO - Return code: 0 04:37:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37:14 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')]} 04:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 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')]} 04:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:14 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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:14 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 04:37:14 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 04:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:14 INFO - 'HOME': '/Users/cltbld', 04:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:14 INFO - 'LOGNAME': 'cltbld', 04:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:14 INFO - 'MOZ_NO_REMOTE': '1', 04:37:14 INFO - 'NO_EM_RESTART': '1', 04:37:14 INFO - 'PAGER': '/bin/cat', 04:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:14 INFO - 'PWD': '/builds/slave/test', 04:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:14 INFO - 'SHELL': '/bin/bash', 04:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:14 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:14 INFO - 'USER': 'cltbld', 04:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:14 INFO - 'XPC_FLAGS': '0x0', 04:37:14 INFO - 'XPC_SERVICE_NAME': '0', 04:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:16 INFO - Installing collected packages: mozsystemmonitor 04:37:16 INFO - Running setup.py install for mozsystemmonitor 04:37:17 INFO - Successfully installed mozsystemmonitor 04:37:17 INFO - Cleaning up... 04:37:17 INFO - Return code: 0 04:37:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:17 INFO - 'HOME': '/Users/cltbld', 04:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:17 INFO - 'LOGNAME': 'cltbld', 04:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:17 INFO - 'MOZ_NO_REMOTE': '1', 04:37:17 INFO - 'NO_EM_RESTART': '1', 04:37:17 INFO - 'PAGER': '/bin/cat', 04:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:17 INFO - 'PWD': '/builds/slave/test', 04:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:17 INFO - 'SHELL': '/bin/bash', 04:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:17 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:17 INFO - 'USER': 'cltbld', 04:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:17 INFO - 'XPC_FLAGS': '0x0', 04:37:17 INFO - 'XPC_SERVICE_NAME': '0', 04:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:17 INFO - Downloading/unpacking jsonschema==2.5.1 04:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:19 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 04:37:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:20 INFO - warning: no files found matching '*.txt' 04:37:20 INFO - no previously-included directories found matching 'build' 04:37:20 INFO - no previously-included directories found matching 'dist' 04:37:20 INFO - no previously-included directories found matching '.git*' 04:37:20 INFO - Installing collected packages: jsonschema, functools32 04:37:20 INFO - Running setup.py install for functools32 04:37:20 INFO - warning: no files found matching '*.txt' 04:37:20 INFO - no previously-included directories found matching 'build' 04:37:20 INFO - no previously-included directories found matching 'dist' 04:37:20 INFO - no previously-included directories found matching '.git*' 04:37:20 INFO - Successfully installed jsonschema functools32 04:37:20 INFO - Cleaning up... 04:37:20 INFO - Return code: 0 04:37:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:20 INFO - 'HOME': '/Users/cltbld', 04:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:20 INFO - 'LOGNAME': 'cltbld', 04:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:20 INFO - 'MOZ_NO_REMOTE': '1', 04:37:20 INFO - 'NO_EM_RESTART': '1', 04:37:20 INFO - 'PAGER': '/bin/cat', 04:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:20 INFO - 'PWD': '/builds/slave/test', 04:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:20 INFO - 'SHELL': '/bin/bash', 04:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:20 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:20 INFO - 'USER': 'cltbld', 04:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:20 INFO - 'XPC_FLAGS': '0x0', 04:37:20 INFO - 'XPC_SERVICE_NAME': '0', 04:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:20 INFO - Cleaning up... 04:37:20 INFO - Return code: 0 04:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:20 INFO - 'HOME': '/Users/cltbld', 04:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:20 INFO - 'LOGNAME': 'cltbld', 04:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:20 INFO - 'MOZ_NO_REMOTE': '1', 04:37:20 INFO - 'NO_EM_RESTART': '1', 04:37:20 INFO - 'PAGER': '/bin/cat', 04:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:20 INFO - 'PWD': '/builds/slave/test', 04:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:20 INFO - 'SHELL': '/bin/bash', 04:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:20 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:20 INFO - 'USER': 'cltbld', 04:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:20 INFO - 'XPC_FLAGS': '0x0', 04:37:20 INFO - 'XPC_SERVICE_NAME': '0', 04:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:21 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 04:37:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:24 INFO - Downloading docopt-0.6.1.tar.gz 04:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:24 INFO - Running setup.py install for blobuploader 04:37:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:25 INFO - Running setup.py install for requests 04:37:25 INFO - Running setup.py install for docopt 04:37:25 INFO - Successfully installed blobuploader requests docopt 04:37:25 INFO - Cleaning up... 04:37:25 INFO - Return code: 0 04:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:25 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')]} 04:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:25 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')]} 04:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:25 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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:25 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 04:37:25 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 04:37:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:25 INFO - 'HOME': '/Users/cltbld', 04:37:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:25 INFO - 'LOGNAME': 'cltbld', 04:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:25 INFO - 'MOZ_NO_REMOTE': '1', 04:37:25 INFO - 'NO_EM_RESTART': '1', 04:37:25 INFO - 'PAGER': '/bin/cat', 04:37:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:25 INFO - 'PWD': '/builds/slave/test', 04:37:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:25 INFO - 'SHELL': '/bin/bash', 04:37:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:25 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:25 INFO - 'USER': 'cltbld', 04:37:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:25 INFO - 'XPC_FLAGS': '0x0', 04:37:25 INFO - 'XPC_SERVICE_NAME': '0', 04:37:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-t_qFzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-jQmWTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-mSiXBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-hI4YHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-eHH7Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-HnFmz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-iVQE9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-2xhOUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-CMxUgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:26 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-tTiZx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-elx_iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-3PtSAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-dTn5s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-fam62u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-ABYYzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-pGAPzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:27 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-JsgMqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:27 INFO - Running setup.py install for manifestparser 04:37:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:27 INFO - Running setup.py install for mozcrash 04:37:28 INFO - Running setup.py install for mozdebug 04:37:28 INFO - Running setup.py install for mozdevice 04:37:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Running setup.py install for mozfile 04:37:28 INFO - Running setup.py install for mozhttpd 04:37:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Running setup.py install for mozinfo 04:37:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Running setup.py install for mozInstall 04:37:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:28 INFO - Running setup.py install for mozleak 04:37:29 INFO - Running setup.py install for mozlog 04:37:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Running setup.py install for moznetwork 04:37:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Running setup.py install for mozprocess 04:37:29 INFO - Running setup.py install for mozprofile 04:37:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Running setup.py install for mozrunner 04:37:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:29 INFO - Running setup.py install for mozscreenshot 04:37:30 INFO - Running setup.py install for moztest 04:37:30 INFO - Running setup.py install for mozversion 04:37:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:30 INFO - Cleaning up... 04:37:30 INFO - Return code: 0 04:37:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:30 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')]} 04:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:30 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')]} 04:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:30 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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:30 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 04:37:30 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 04:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:30 INFO - 'HOME': '/Users/cltbld', 04:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:30 INFO - 'LOGNAME': 'cltbld', 04:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:30 INFO - 'MOZ_NO_REMOTE': '1', 04:37:30 INFO - 'NO_EM_RESTART': '1', 04:37:30 INFO - 'PAGER': '/bin/cat', 04:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:30 INFO - 'PWD': '/builds/slave/test', 04:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:30 INFO - 'SHELL': '/bin/bash', 04:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:30 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:30 INFO - 'USER': 'cltbld', 04:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:30 INFO - 'XPC_FLAGS': '0x0', 04:37:30 INFO - 'XPC_SERVICE_NAME': '0', 04:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-TqV3AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:30 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)) 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-AxLSPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-t4Oytk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:30 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)) 04:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:30 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-gOJrsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-EEZkiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-1i5nI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-FpnAWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-2nQolS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-5TyMel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-VqcY7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-kt1RNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-E8T_5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:31 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-lIIH7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:31 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)) 04:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:32 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-eMVASx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:32 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-nkgAp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:32 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)) 04:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:32 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-UeO6ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:32 INFO - Running setup.py (path:/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/pip-zbrCz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:32 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)) 04:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:37:32 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)) 04:37:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:32 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:37:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:34 INFO - Downloading blessings-1.6.tar.gz 04:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:34 INFO - Installing collected packages: blessings 04:37:34 INFO - Running setup.py install for blessings 04:37:35 INFO - Successfully installed blessings 04:37:35 INFO - Cleaning up... 04:37:35 INFO - Return code: 0 04:37:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:35 INFO - Reading from file tmpfile_stdout 04:37:35 INFO - Current package versions: 04:37:35 INFO - blessings == 1.6 04:37:35 INFO - blobuploader == 1.2.4 04:37:35 INFO - docopt == 0.6.1 04:37:35 INFO - functools32 == 3.2.3-2 04:37:35 INFO - jsonschema == 2.5.1 04:37:35 INFO - manifestparser == 1.1 04:37:35 INFO - mozInstall == 1.12 04:37:35 INFO - mozcrash == 0.17 04:37:35 INFO - mozdebug == 0.1 04:37:35 INFO - mozdevice == 0.48 04:37:35 INFO - mozfile == 1.2 04:37:35 INFO - mozhttpd == 0.7 04:37:35 INFO - mozinfo == 0.9 04:37:35 INFO - mozleak == 0.1 04:37:35 INFO - mozlog == 3.4 04:37:35 INFO - moznetwork == 0.27 04:37:35 INFO - mozprocess == 0.23 04:37:35 INFO - mozprofile == 0.28 04:37:35 INFO - mozrunner == 6.12 04:37:35 INFO - mozscreenshot == 0.1 04:37:35 INFO - mozsystemmonitor == 0.3 04:37:35 INFO - moztest == 0.7 04:37:35 INFO - mozversion == 1.4 04:37:35 INFO - psutil == 3.1.1 04:37:35 INFO - requests == 1.2.3 04:37:35 INFO - wsgiref == 0.1.2 04:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:35 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 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:35 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 04:37:35 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 04:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:35 INFO - 'HOME': '/Users/cltbld', 04:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:35 INFO - 'LOGNAME': 'cltbld', 04:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:35 INFO - 'MOZ_NO_REMOTE': '1', 04:37:35 INFO - 'NO_EM_RESTART': '1', 04:37:35 INFO - 'PAGER': '/bin/cat', 04:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:35 INFO - 'PWD': '/builds/slave/test', 04:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:35 INFO - 'SHELL': '/bin/bash', 04:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:35 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:35 INFO - 'USER': 'cltbld', 04:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:35 INFO - 'XPC_FLAGS': '0x0', 04:37:35 INFO - 'XPC_SERVICE_NAME': '0', 04:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 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)) 04:37:35 INFO - Cleaning up... 04:37:35 INFO - Return code: 0 04:37:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11038b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110301570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadc9d7f450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, '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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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 04:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:35 INFO - 'HOME': '/Users/cltbld', 04:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:35 INFO - 'LOGNAME': 'cltbld', 04:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:35 INFO - 'MOZ_NO_REMOTE': '1', 04:37:35 INFO - 'NO_EM_RESTART': '1', 04:37:35 INFO - 'PAGER': '/bin/cat', 04:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:35 INFO - 'PWD': '/builds/slave/test', 04:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:35 INFO - 'SHELL': '/bin/bash', 04:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:37:35 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:35 INFO - 'USER': 'cltbld', 04:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:35 INFO - 'XPC_FLAGS': '0x0', 04:37:35 INFO - 'XPC_SERVICE_NAME': '0', 04:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:36 INFO - Cleaning up... 04:37:36 INFO - Return code: 0 04:37:36 INFO - Running post-action listener: _resource_record_post_action 04:37:36 INFO - Running post-action listener: _start_resource_monitoring 04:37:36 INFO - Starting resource monitoring. 04:37:36 INFO - [mozharness: 2016-09-27 11:37:36.047920Z] Finished create-virtualenv step (success) 04:37:36 INFO - [mozharness: 2016-09-27 11:37:36.048891Z] Running install step. 04:37:36 INFO - Running pre-action listener: _resource_record_pre_action 04:37:36 INFO - Running main action method: install 04:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:36 INFO - Reading from file tmpfile_stdout 04:37:36 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:36 INFO - Reading from file tmpfile_stdout 04:37:36 INFO - Output received: 04:37:36 INFO - Usage: mozinstall [options] installer 04:37:36 INFO - Options: 04:37:36 INFO - -h, --help show this help message and exit 04:37:36 INFO - -d DEST, --destination=DEST 04:37:36 INFO - Directory to install application into. [default: 04:37:36 INFO - "/builds/slave/test"] 04:37:36 INFO - --app=APP Application being installed. [default: firefox] 04:37:36 INFO - mkdir: /builds/slave/test/build/application 04:37:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:37:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:38:10 INFO - Reading from file tmpfile_stdout 04:38:10 INFO - Output received: 04:38:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:38:10 INFO - Running post-action listener: _resource_record_post_action 04:38:10 INFO - [mozharness: 2016-09-27 11:38:10.570584Z] Finished install step (success) 04:38:10 INFO - [mozharness: 2016-09-27 11:38:10.570718Z] Running run-tests step. 04:38:10 INFO - Running pre-action listener: _resource_record_pre_action 04:38:10 INFO - Running main action method: run_tests 04:38:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:38:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:38:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:38:10 INFO - 2016-09-27 04:38:10.585 screenresolution[1645:8751] starting screenresolution argv=screenresolution get 04:38:10 INFO - 2016-09-27 04:38:10.587 screenresolution[1645:8751] Display 0: 1600x1200x32@60 04:38:10 INFO - 2016-09-27 04:38:10.593 screenresolution[1646:8754] starting screenresolution argv=screenresolution list 04:38:10 INFO - Available Modes on Display 0 04:38:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:38:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:38:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:38:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:38:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:38:10 INFO - Intel Iris: 04:38:10 INFO - Chipset Model: Intel Iris 04:38:10 INFO - Type: GPU 04:38:10 INFO - Bus: Built-In 04:38:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:38:10 INFO - Vendor: Intel (0x8086) 04:38:10 INFO - Device ID: 0x0a2e 04:38:10 INFO - Revision ID: 0x0009 04:38:10 INFO - Displays: 04:38:10 INFO - Display: 04:38:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:38:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:38:10 INFO - Display Serial Number: 1600x1200 60 04:38:10 INFO - Main Display: Yes 04:38:10 INFO - Mirror: Off 04:38:10 INFO - Online: Yes 04:38:10 INFO - Rotation: Supported 04:38:10 INFO - Return code: 0 04:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:38:10 INFO - Python 2.7.3 04:38:10 INFO - Return code: 0 04:38:10 INFO - grabbing minidump binary from tooltool 04:38:10 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')]} 04:38:10 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 0x11019fd30>, '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 0x10ffc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110197b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:38:10 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 04:38:10 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 04:38:10 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 04:38:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:38:10 INFO - Return code: 0 04:38:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:38:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:38:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:38:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:38:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 04:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0250 --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 04:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mXZrcPHfkN/Render', 04:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:10 INFO - 'HOME': '/Users/cltbld', 04:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:10 INFO - 'LOGNAME': 'cltbld', 04:38:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:38:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:10 INFO - 'MOZ_NO_REMOTE': '1', 04:38:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:38:10 INFO - 'NO_EM_RESTART': '1', 04:38:10 INFO - 'PAGER': '/bin/cat', 04:38:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:10 INFO - 'PWD': '/builds/slave/test', 04:38:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:10 INFO - 'SHELL': '/bin/bash', 04:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WCiJIGTmeX/Listeners', 04:38:10 INFO - 'TMPDIR': '/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/', 04:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:10 INFO - 'USER': 'cltbld', 04:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:10 INFO - 'XPC_FLAGS': '0x0', 04:38:10 INFO - 'XPC_SERVICE_NAME': '0', 04:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0250', '--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 04:38:11 INFO - mozversion application_buildid: 20160927021850 04:38:11 INFO - mozversion application_changeset: 7b050ca8ec6474c6d7131d0ebd352e8624992016 04:38:11 INFO - mozversion application_display_name: Nightly 04:38:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:38:11 INFO - mozversion application_name: Firefox 04:38:11 INFO - mozversion application_remotingname: firefox 04:38:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:38:11 INFO - mozversion application_vendor: Mozilla 04:38:11 INFO - mozversion application_version: 52.0a1 04:38:11 INFO - mozversion platform_buildid: 20160927021850 04:38:11 INFO - mozversion platform_changeset: 7b050ca8ec6474c6d7131d0ebd352e8624992016 04:38:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:38:11 INFO - mozversion platform_version: 52.0a1 04:38:11 INFO - using testdate: 1474976291 04:38:11 INFO - actual date: 1474976291 04:38:11 INFO - starting webserver on 'localhost:49272' 04:38:11 INFO - SUITE-START | Running 2 tests 04:38:11 INFO - TEST-START | dromaeo_css 04:38:11 INFO - operating with platform_type : mac_ 04:38:11 INFO - Initialising browser for dromaeo_css test... 04:38:11 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpXF0cBm/profile http://localhost:49272/getInfo.html) 04:38:13 INFO - PROCESS | 1656 | 2016-09-27 04:38:13.827 plugin-container[1658:8930] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 04:38:13 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:13 INFO - PROCESS | 1656 | 2016-09-27 04:38:13.829 plugin-container[1658:8930] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 04:38:13 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:13 INFO - PROCESS | 1656 | 2016-09-27 04:38:13.829 plugin-container[1658:8930] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:38:13 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 04:38:13 INFO - PROCESS | 1656 | colorDepth:24 04:38:13 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 04:38:13 INFO - PROCESS | 1656 | __metrics 04:38:13 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 04:38:14 INFO - TEST-INFO | 1656: exit 0 04:38:14 INFO - Browser initialized. 04:38:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:38:14 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpXF0cBm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:17 INFO - PROCESS | 1660 | 2016-09-27 04:38:17.125 plugin-container[1661:9053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8727, name = 'com.apple.tsm.portname' 04:38:17 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:17 INFO - PROCESS | 1660 | 2016-09-27 04:38:17.128 plugin-container[1661:9053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 04:38:17 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:38:17 INFO - PROCESS | 1660 | 2016-09-27 04:38:17.128 plugin-container[1661:9053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:38:26 INFO - PROCESS | 1660 | RSS: Main: 239890432 04:38:26 INFO - PROCESS | 1660 | 04:39:16 INFO - PROCESS | 1660 | 1474976356471 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:41:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 04:41:30 INFO - PROCESS | 1660 | RSS: Main: 255225856 04:41:30 INFO - PROCESS | 1660 | 04:44:33 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 04:44:33 INFO - PROCESS | 1660 | RSS: Main: 265445376 04:44:33 INFO - PROCESS | 1660 | 04:47:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 04:47:36 INFO - PROCESS | 1660 | RSS: Main: 270077952 04:47:36 INFO - PROCESS | 1660 | 04:50:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 04:50:38 INFO - PROCESS | 1660 | RSS: Main: 269815808 04:50:38 INFO - PROCESS | 1660 | 04:53:41 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 04:53:42 INFO - PROCESS | 1660 | RSS: Main: 275988480 04:53:42 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 04:56:45 INFO - PROCESS | 1660 | RSS: Main: 278679552 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | __start_tp_report 04:56:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 04:56:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 04:56:45 INFO - PROCESS | 1660 | |i|pagename|runs| 04:56:45 INFO - PROCESS | 1660 | |0;dojo.html;3095.705907938745;3421.8631254749807;3462.9999999999986;3485.8082805445706;3505.544279243698;5794.333651630064;5903.498202652774;5970.970145149279;6008.609440386372;6025.457708806207;4475.664325175617;4828.855134345967;5487.283794521707;5814.563907706918;5971.37300583439;5284.550813180875;5377.354717433914;5390.326209223847;5394.676319420828;5453.182022696607;5390.380106287788;5462.644928079682;5497.5601951843955;5510.228568000483;5520.254765606652;5277.551408130314;5444.455554444524;5472.644278121949;5482.5613950883835;5557.944420555803;5332.2801421808335;5334.119870221448;5342.91985620216;5371.382291036542;5394.056040192951;4384.561543845622;5247.317848679685;5277.02375060615;5301.045811753883;5338.572914166896;4672.719636821802;5855.828834233171;6024.698765061773;6043.939560604382;6044.667543285118;6136.825445958276;6186.133941248228;6248.625082495065;6321.589096708699;6331.461825744817;5181.766820493087;5314.4951229633125;6322.620642761449;6353.396516647682;6389;4898;4919.016196760662;5756.136579513107;5974;6084.421979911857;6390.744370225232;6415.166028416369;6447.0329450582785;6551.246606640298;6565.67171641416;6278.811635650938;6286.05709143623;6287.874242515124;6291.716872740646;6308.243010838729;5156.252343410185;6197.318294987548;6388.744450221939;6394.392532709385;6416.518761092937;6154.7230374633245;6246.406591373812;6261.96869015652;6279.968600157062;6284.308726040132;5420.891582168335;6213.378662133841;6271.874562508816;6302.779402720883;6331.683415829282;4639.837605683852;5008.949910500921;5053.823116190915;5112.590992720573;5119.923201151985;3982.661473774762;4542.318652202196;4560.315952607069;4579.542045795394;4592.70147440422;5996.280446346466;6072.906876762225;6087.726052327655;6089.177960975212;6120.938790612126;6114.082887566811;6444.323346048691;6452.257990331172;6455.0317452382515;6476.708548115252;5691.459311365414;5754.223179870663;5772.7113644317615;5787.739551720183;5805.651660900359;5509.724513774296;5544.445555444423;5576.96826087167;5601.495865372136;5675.4324567543745;6599.670016499156;6613.570117942319;6633.071370008202;6637.867242655217;6644.069830223772;6228.688565571794;6346.984482482781;6413.518986075969;6425;6439.613623182624;6451.1936007999;6486.05952136928;6510.73957041713;6514.902276465951;6664.033715111379;5396.109641909041;6173.84565385851;6175.722092505938;6248.782072101404;6310.305866354789;6173.660448675366;6284.968575157095;6290;6345.428911397997;6370.74517019314;6145.555794388226;6224.875502489835;6278.497720182283;6280.183576135073;6280.371962803683;4467.195904737048;6092.695365231632;6207.534434917309;6208.81373558794;6269.341719119427;6098.207233059674;6151.630902145886;6213.502919766498;6227.595206311576;6228.4705800005695;6123.404636889863;6241.500679945684;6262.436380725757;6266.968665156827;6308.148399965946;6109.6639684817765;6135.417135372132;6149.985252433298;6219.689015549295;6252.406021427957 04:56:45 INFO - PROCESS | 1660 | |1;ext.html;463.2287241742499;490.81103775046597;520.1132069820956;521.6087934049463;534.0920435260059;39243.80378098109;40960.38559421607;41025.38461923073;43482.13035739283;43528.25886964526;42248.366274505905;42272.577274227326;42853.57146428535;42858.57141428585;42864;9780.902190978088;9925.404475731479;9937.354071985297;9966.850497242547;9985.301028927977;9733.756656083584;9803.852942205873;9810.411375317504;9842.950785246063;9849.852252216222;9798;9804.90195098047;9839.606415743361;9845.60617575296;9848.06443387877;9751.41491510508;9790.902090979142;9796.069373409515;9826.213902887823;9836.508174591241;8650.048494665582;8686.783850260968;9464.290178236592;9525.761650985396;9790.167835733972;40035.19929601421;40271.993200169934;40432.39351409731;40560;40712.592874071175;3285.96714032859;3450.516927630134;3592.0301518590095;3927.8821635350987;3984.362501999666;30549.236269093228;30798.53802192969;30823;31352;31955.680443195502;3273.918152046218;3277.147941535194;3290.588676415448;3352.513885486615;3387.119348969261;313799;315545;316236;317422;318301;32318.35363292721;56372.71813640906;56678.01626943037;56792;56793;32908.83545582257;33825.32349352999;33900;34217.65782342145;34238.82880585581;12059.698507537207;14638.780418293734;14689.853101468849;14736.263186840615;14751.852481475262;12354.38228088592;12453.1905426147;12460.376981150906;12467.501299948082;12499.250044997329;7572.167061623217;7716.6527506262355;7778.49439786412;7791.92208077912;7809.843803123906;3245.8052516849066;3252.495863141217;3281.8851340202978;3292.8847490338203;3302.53764472974;851.0170752780548;924.6717415317465;937.1893312284825;944.1266828183902;998.1515711645188;26131.216063518124;28000.439991200063;28949;30216.5467517983;30514.43939553007;1006.7281833904805;1031.1956673794452;1066.3708412036935;1082.783443311341;1149.4884776274646;14565.708685826436;14634.926825365805;15750.291236894367;15828.44600438979;16261.18694065292;537992;540595;542299;543872;544096.2795186078;56316.43683563194;56458.717706412026;56653.716731416076;56907.43092569104;57273;1294.4369199398293;1344.0524430276632;1360.4558176729388;1360.4762166565943;1364.7004796917424;29647.110586682433;29783.25541861384;30555.847220763753;32824.50763238506;33502.162445939044;55146;59753.103703443616;60137.39862601493;60201.397986019576;60307.69846150741;426861;498369;509373.2501399953;511604;512579;37644.2471150581;41958.1608367837;43335.56664433315;44808.77595612001;45127.32309015433;48168;48590.757046214545;49313.01373972572;49828.50171498384;49990.75004625099;32040.51939220867;40472.79763601163;40624;41271.58728412678;41639;32375;32506;33963.64145434155;37239.62760372362;38868.80565597154;33358.83320583381;36396.45405318975;37550.11848459683;37628.05929851666;38855.02862428462;31915.680843191272;34675.959721208405;34949.12627184341;35201.29597408089;35342.64657353496;23918.52162956766;24819.87590062038;26366;26488.602670959564;26608.60087098734 04:56:45 INFO - PROCESS | 1660 | |2;jquery.html;370.9888703338901;373.6935712715573;378.5192805137476;384.44063887044354;402.91740193260387;18772.55596875234;20317.49206269844;20767.376978690627;20965.790342096574;20977.58044839102;19469.707954380694;19936.70094948577;20215.59568808623;20257.797422025775;20694.275700350492;4997.725125118135;5818.3308919474375;6028.156058151841;6081.087836824468;6088.208532890718;5964.493018093467;6071.058985857199;6074.5747797654185;6080.2399700037495;6085.604435711687;5749.367569567345;5914.9112763308585;5939.4357536034;5942.286925568917;5943.673097979631;5672.6312789668955;5918.230630018092;5979.910301345505;5984.611000284967;5998.220231369915;5083.593312534988;5130.3074084998425;5139.588832893397;5152.974235128838;5163.044836705221;24224.87887560551;24435.87782061096;24539.87730061356;24548.018079276808;24563.89462474193;2309.168699268262;2464.3592665906813;2889.815175777942;3152;3153.243221626816;14796.926015369962;14895.70208595822;15311.310991005432;15708.293126809322;16013.279402426802;1860.9534761630932;1892.9621407571908;1901.2965202874886;1925.8170473804967;1928.0937959159173;68703.92306808029;103972;103984.9203015943;104464;110137;10346.275760696679;10565.154787616972;10796.622118225825;10851.186161037953;11002.50488728009;13219.603411897659;13229;13338;13350.132241404277;13384.866151338556;8447.281981031558;8526.190011948855;8557.272631826365;8595.269402100766;8628.35287353451;8421.284190843848;8507.872381914276;8521;8675.39272250949;8679.6528138875;6421.591903036361;6539.836504087436;6547;6566.540342176002;6573.80278591643;1562.3438155974518;1699.4137022727139;1859.191251805469;1889.2537447708078;1893.6591413545418;816.3306089007076;828.7679449754079;909.354069134868;957.7509847439716;991.2218908157062;13802.37889294984;15905.840941590435;16602.91698541524;18788.402985746092;20067.996600170227;982.8967958364269;1000.309786247487;1026.594495174402;1051.2273478992934;1095.370162156747;11186.216964812385;11512.194146409838;11703.414829258503;11711.355875426932;11757.118216133824;462545;468303;473704;475946;476717;100222;110343;113022.30466543009;115781;129041.35479322543;978.7748817771952;995.5072239241622;1020.78563501664;1021.4024795494719;1025.2464438637596;18981.33565325207;19124.948127853102;19173.808261917202;19203.807961920204;19423;54459;54923;55621;55801.44198558125;56577;80208.39583208186;81311.18688813037;82641;84192;87194;7716.765317549165;7915.168907264884;8036.67853285862;8134.471259368122;8306.377021723274;9216.124468175512;12189.817152742538;12691.365431728193;13040.869591303965;13164.012699047418;11161.888381116085;11289.491972861406;11484.425778710864;11560.826587601025;11607.419629018685;10920.945395272973;11153.944230278797;11192.88807111951;11309.604163854226;11402.885971140182;9355;10364.378137311785;11260.718482038015;11553.884461155281;11702.88297117052;7848.686052557834;8083.393745469231;8121.796955075934;8182.386321026066;8284.875726864222;10757.784844303227;10977.231593788358;10991.890081099087;11209.831852522382;11272.7745445089 04:56:45 INFO - PROCESS | 1660 | |3;mootools.html;1523.0176536134197;1570.1835045776197;1761.5331937036688;1825.607494388706;1863.4689113602626;8058.315043221319;8339.33285337173;8549.230569248766;9189.724308270746;9214.769630759227;8597.828043439144;8873.467591944487;8879.689210877621;9003.90996090039;9025.2328552073;2374.6912901322803;2395.9338094547934;2399.3881560202126;2403.42317843718;2404.5912194926905;1970.5172232802984;2369.597168481362;2386.2244770449674;2410.20463247128;2413.734489206186;1947.464447276996;2377.714674239085;2385.200957679171;2394.365493144318;2397.520495900818;2360.9173678921243;2361.055577768889;2367.633016882386;2380.821438392119;2393.8204634652297;2379.226751305815;2383.189715496722;2395.3053614451787;2395.6646069550275;2395.940101497459;9081.409708369001;9130;9170.633174673005;9219.078092190794;9224.354295199339;5328.5470734987575;5414.402751188409;5487.917681234785;5489;5499.230107784913;3575.0883524701294;3682.2819550187455;3733.5893051764556;3743.5507739071213;3751.662350388478;1078.1698092468835;1096.8245080787115;1097.9780404391947;1112.3381587955155;1119.764849381631;11851;11879.762404751857;11928.880711192864;11953.880461195364;12031.699207519794;4346.869593912188;4478.2610869206865;4581.816727330936;4666.113438446684;4676.672632915664;9186.586603602855;9213.677521286723;9309.487978161265;9312.953435232781;9313;4378.496472905593;4474.798634061475;5245.659032162897;5255.106631872591;5267.2889159962915;4457.910841783211;4605.700629459141;4803.135435621552;4899.804007839646;4960.851174464772;3746.269477451925;3787.450819631193;3879.359905615598;3894.90262743428;3900.3759398496104;1150.0512077536066;1167.9240849344765;1171.4318555500574;1173.9119566032582;1181.710480932177;773.389022672094;853.6926706385697;913.3104506097986;917.5779141594808;940.7957813998094;4976.253561965662;5342.465753424626;5403.594730395236;5728.453317604223;6082.270127584629;874.4010352908278;907.4827348411342;948.9620415183315;955.4649396338073;987.0524296675129;3833.9424908626393;3839.9808000959815;3956.208758248362;3980.9402858957137;4036.798160091984;10172;10565.260431769702;10577.947110264553;10595.258331916692;10596.152307815357;10219.48902554884;10516.158707303397;10548.736281592868;10725.678229653124;10747.516361763739;8306.252437280553;8383.245507904196;8401.075881653012;8492.320614350838;8504.787380315418;5472.713912230543;5754.9424505754405;5877.559183061202;5930.466258036798;6120.1125836752535;8585.914140858511;9738.610455581698;10187.643432479828;10225.948870255601;10248.897511025092;10443.582256709951;10451.58193672275;10458.424786636504;10463.372197668165;10494.47527623631;7057.964710176417;7307.5980821055355;7467.813304667427;7690.154083050748;7810.375169986274;8295.792605184919;8631.050584435832;8646.178613031752;8665.350098742494;8673.002604700288;7561.6597253122645;7676.769696909102;7676.80807979805;7788.493747906368;7809.531428114331;7464.178940316452;7496.25037496246;7526.698932042657;7534;7657.540547567164;5813.302403711582;7031.859362812613;7083.964580177066;7092.787216383516;7118.323759242864;3932.803359832054;4573.565511276423;4920.015996800583;4979.253112033224;5085.847424577269;4346.456692913386;5051.772670229775;5072.923906141485;5099.260607212008;5131.050755610224 04:56:45 INFO - PROCESS | 1660 | |4;prototype.html;303.30845671868144;305.4898319805924;311.2793882162793;317.45081009852953;317.84107946026984;4874.293227482013;5344.243623175377;5371.919421208685;5544.223808666785;5567.608097975506;5324.866878328044;5442.945570544293;5563.415841336652;5662.6602403855795;5692.174634677969;3744.9701332133677;4317.351837697141;4327.7186982846015;4346.8043938022865;4349.1301739652035;4159.52078524794;4305.031367942219;4345.956540434587;4355.36847157162;4369.956300437003;4262.1688770689725;4288.335308027261;4290.570942905716;4316.611504964552;4317.956820431803;3256.5929258842643;3419.401604719164;4292.313229883203;4300.204462174508;4329.870103896888;3749.568799588055;3758.7180961428003;3761.6614504694708;3762.4168253920684;3771.8679846205528;4071.877843664695;4540.502723502061;5026.874328141789;5372.650777699437;5476.726163691839;4840.2255639097575;4847.5394837490385;4860.392450943632;4861.611071114302;4876.317315575822;5586.608937374385;5967.731452084667;5991.5961768100415;6012.458878700894;6019.939800601982;3712.8304584055936;3917.3557848452183;3951.723379363446;3961.801909904493;3993.8832418818074;6255.1234629610935;6262.906056409158;6331.96834015827;6346.9682651586445;6359.713812878432;3565.8395372208315;3690.579127036057;3911.3546264865977;4055.965728739153;4056.7768772717195;3682.926341473209;4012.077222238843;4099.508059032935;4119.958800411958;4141.97929010353;3971.212954170635;4296.398504209413;4616.8614941551805;4846.75766211688;4871.780769865364;5838.591298609056;6057.757689692363;6092.598702298496;6097.695115244309;6104.572679912363;1222.0956492195712;1273.382803839119;1397.475946520055;1399.8950078744135;1401.467442371892;744.5941961630924;826.7262328481379;839.9118092600311;851.4848516647463;857.3312816003527;3925.4700615417123;4294.763787991628;4769.499202583679;4828.782704778293;4843.539863712942;4454.683564546483;4697.271922851964;4986.825461108844;5213.661112027706;5266.182018036892;4381.627561657231;4716.528347165256;4821.9035619287415;4861.173600487926;4880.6583539152625;2498.2879879234692;2579.522788284136;2581.4511293223914;2684.6106964801343;2732.7702533859447;4777.474477807438;5195.922061169085;5294.867628309323;5379.73101344939;5463.399026107125;4716.976415117902;4913.901721965541;5091.490850914879;5411.347340545116;5756.193578362031;6407.615543067431;6451.29035806061;6478.4169424752;6483.481321494175;6486.708098135501;4897.853064408074;6249.500039996698;6251.812445626639;6265.467435268053;6321.367863213642;5958.731857066356;6075.544334174866;6098.207233059674;6112.969435152973;6141.692915354304;6435.292117866938;6459.515536334888;6498.447631951148;6505.902411463737;6524.934750652433;3027.6215473065868;3677.808262284752;4009.438678585059;4065.2479291331197;4086.836526538905;6131.478824299985;6149.142177679583;6176.413240742122;6184.81445556634;6202.937970620416;6037.245344331958;6042.546808989431;6059.72731227087;6063.542811469712;6106.2061931948565;5042.420121686053;5275.419703832498;5548.778048878;5577.518004488126;6059;5896.877124235186;5954.422078149208;5965.135055416853;5975.340973266854;5981;4863.449681732426;4938.44376269975;5269.868253293698;5814.30228372581;5989.850253743692;5425.941941321405;5591.6365436246515;5795.478406943227;5902.911456328245;5941.22764040672 04:56:45 INFO - PROCESS | 1660 | |5;yui.html;636.8981661725218;660.9900851487228;705.9788206353808;746.6266866566716;755.6977209116353;15123.395064197433;15845.207739613003;16056.598585035379;16076.437324693637;16157.434489792844;14536;14595.489157879476;14638;14644.780328295084;14727.410903563845;674.8076798112539;695.1484431571309;846.7375113714737;848.5460278750869;872.5419154943642;858.8969323681135;875.8379699755534;876.5135349880813;876.8640860666607;880.3089574683875;926.6154545863459;932.6316105138466;935.036911980661;936.199549385276;937.2595649436937;922.5110691333604;926.9212116970066;927.0266220468482;927.4667066436792;927.6660402255217;683.71967493328;685.9485538584626;692.560224257595;693.1578132568953;693.5145398221215;15391.384344626202;15417.537473875802;15511;15550.455734049254;15553.144577048259;11874.346910919896;14426.27868606576;14435.35040923161;14449.927750361287;14544.781828272584;11504.654860354203;11643.708907277301;11650.475728592233;11723.882761172365;12049.759004819854;3804.90487737806;3864.0339915021245;3882;3990.760554366718;3993.0217096811175;83808.58095709543;100645.4967725164;104771;107374.46312768386;107555.46222268917;9316.254699624014;11069.72325691848;11147.888521114848;11166.665000050012;11342.221155816878;22759.544809104056;22790;22796.316110516713;22809;22930;7822.921770782333;7877.344713040288;8075.192480751878;8087.989001374828;8256.298214651822;3489;4028.073543085107;4478.798454069574;4505.144022635689;4589.862304130881;3273.5089736539708;3579.2125732338845;3637.054365864841;3729.68297694699;3734.1971476132762;658.6640813185214;684.5995092870627;704.3484776581641;709.9680514376865;715.7351779841492;493.9209726443752;508.6617399429412;596.1028651878895;634.9492040636738;667.3926726678699;9678.95160524193;9737.659181928599;9742.853857192147;9780.168685661798;9794.510274486247;653.1150291355241;681.8636272745471;687.8383579858729;690.1683471416931;690.3510699942038;4476.798544065525;4585.12882552314;4745.928811067837;4756.21522448799;4799.760011999386;94518;95512.56731149038;144455;151247.90016798628;155744;101191;109559.71320860388;110364;126024;128576.71423285834;97077;110762.44618776854;111700;112156.43921780339;115001;8441.95779021101;9106.317026222927;9159.404638698463;9184.632614695338;9209.539523023956;44971.77514112408;58636.41363586309;65636.34363656302;65637.34362656504;66515;91654;97673;98301.50849245708;98802.01197987929;100881;11422.25755325901;11678.70803229892;11825.763484730429;11963.461644226205;11992.100592455427;13021.934890325489;13029.739405212033;13167.53913613019;13242;13493.055486115878;10518.895515970713;11787.174897757075;12231.05300948271;12298.262104273772;12515.874841251834;12060.336681482602;12183.269003859798;12213.816792747939;12291.32397718134;12744.936275318563;11835.230710003822;12075.094367922266;12222.144449888423;12293.323867187033;12443.37783110859;10178.949105254427;10438.68683939483;10480.161587072864;10619.05612802006;10707.839382409114;9236.18837593372;10603.41681207541;10642.201834862572;10691.679249622213;10791.6222932197 04:56:45 INFO - PROCESS | 1660 | __end_tp_report 04:56:45 INFO - PROCESS | 1660 | __start_cc_report 04:56:45 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,366 04:56:45 INFO - PROCESS | 1660 | __end_cc_report 04:56:45 INFO - PROCESS | 1660 | __startTimestamp1474977405412__endTimestamp 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | ------- Summary: start ------- 04:56:45 INFO - PROCESS | 1660 | Number of tests: 6 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5814.18 Median:6109.66 stddev:707.48 (11.6%) stddev-sans-first:676.74 04:56:45 INFO - PROCESS | 1660 | Values: 3095.7 3421.9 3463.0 3485.8 3505.5 5794.3 5903.5 5971.0 6008.6 6025.5 4475.7 4828.9 5487.3 5814.6 5971.4 5284.6 5377.4 5390.3 5394.7 5453.2 5390.4 5462.6 5497.6 5510.2 5520.3 5277.6 5444.5 5472.6 5482.6 5557.9 5332.3 5334.1 5342.9 5371.4 5394.1 4384.6 5247.3 5277.0 5301.0 5338.6 4672.7 5855.8 6024.7 6043.9 6044.7 6136.8 6186.1 6248.6 6321.6 6331.5 5181.8 5314.5 6322.6 6353.4 6389.0 4898.0 4919.0 5756.1 5974.0 6084.4 6390.7 6415.2 6447.0 6551.2 6565.7 6278.8 6286.1 6287.9 6291.7 6308.2 5156.3 6197.3 6388.7 6394.4 6416.5 6154.7 6246.4 6262.0 6280.0 6284.3 5420.9 6213.4 6271.9 6302.8 6331.7 4639.8 5008.9 5053.8 5112.6 5119.9 3982.7 4542.3 4560.3 4579.5 4592.7 5996.3 6072.9 6087.7 6089.2 6120.9 6114.1 6444.3 6452.3 6455.0 6476.7 5691.5 5754.2 5772.7 5787.7 5805.7 5509.7 5544.4 5577.0 5601.5 5675.4 6599.7 6613.6 6633.1 6637.9 6644.1 6228.7 6347.0 6413.5 6425.0 6439.6 6451.2 6486.1 6510.7 6514.9 6664.0 5396.1 6173.8 6175.7 6248.8 6310.3 6173.7 6285.0 6290.0 6345.4 6370.7 6145.6 6224.9 6278.5 6280.2 6280.4 4467.2 6092.7 6207.5 6208.8 6269.3 6098.2 6151.6 6213.5 6227.6 6228.5 6123.4 6241.5 6262.4 6267.0 6308.1 6109.7 6135.4 6150.0 6219.7 6252.4 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:59506.06 Median:40352.19 stddev:122697.63 (304.1%) stddev-sans-first:122961.74 04:56:45 INFO - PROCESS | 1660 | Values: 463.2 490.8 520.1 521.6 534.1 39243.8 40960.4 41025.4 43482.1 43528.3 42248.4 42272.6 42853.6 42858.6 42864.0 9780.9 9925.4 9937.4 9966.9 9985.3 9733.8 9803.9 9810.4 9843.0 9849.9 9798.0 9804.9 9839.6 9845.6 9848.1 9751.4 9790.9 9796.1 9826.2 9836.5 8650.0 8686.8 9464.3 9525.8 9790.2 40035.2 40272.0 40432.4 40560.0 40712.6 3286.0 3450.5 3592.0 3927.9 3984.4 30549.2 30798.5 30823.0 31352.0 31955.7 3273.9 3277.1 3290.6 3352.5 3387.1 313799.0 315545.0 316236.0 317422.0 318301.0 32318.4 56372.7 56678.0 56792.0 56793.0 32908.8 33825.3 33900.0 34217.7 34238.8 12059.7 14638.8 14689.9 14736.3 14751.9 12354.4 12453.2 12460.4 12467.5 12499.3 7572.2 7716.7 7778.5 7791.9 7809.8 3245.8 3252.5 3281.9 3292.9 3302.5 851.0 924.7 937.2 944.1 998.2 26131.2 28000.4 28949.0 30216.5 30514.4 1006.7 1031.2 1066.4 1082.8 1149.5 14565.7 14634.9 15750.3 15828.4 16261.2 537992.0 540595.0 542299.0 543872.0 544096.3 56316.4 56458.7 56653.7 56907.4 57273.0 1294.4 1344.1 1360.5 1360.5 1364.7 29647.1 29783.3 30555.8 32824.5 33502.2 55146.0 59753.1 60137.4 60201.4 60307.7 426861.0 498369.0 509373.3 511604.0 512579.0 37644.2 41958.2 43335.6 44808.8 45127.3 48168.0 48590.8 49313.0 49828.5 49990.8 32040.5 40472.8 40624.0 41271.6 41639.0 32375.0 32506.0 33963.6 37239.6 38868.8 33358.8 36396.5 37550.1 37628.1 38855.0 31915.7 34676.0 34949.1 35201.3 35342.6 23918.5 24819.9 26366.0 26488.6 26608.6 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:30805.13 Median:24330.38 stddev:79258.69 (325.8%) stddev-sans-first:79448.09 04:56:45 INFO - PROCESS | 1660 | Values: 371.0 373.7 378.5 384.4 402.9 18772.6 20317.5 20767.4 20965.8 20977.6 19469.7 19936.7 20215.6 20257.8 20694.3 4997.7 5818.3 6028.2 6081.1 6088.2 5964.5 6071.1 6074.6 6080.2 6085.6 5749.4 5914.9 5939.4 5942.3 5943.7 5672.6 5918.2 5979.9 5984.6 5998.2 5083.6 5130.3 5139.6 5153.0 5163.0 24224.9 24435.9 24539.9 24548.0 24563.9 2309.2 2464.4 2889.8 3152.0 3153.2 14796.9 14895.7 15311.3 15708.3 16013.3 1861.0 1893.0 1901.3 1925.8 1928.1 68703.9 103972.0 103984.9 104464.0 110137.0 10346.3 10565.2 10796.6 10851.2 11002.5 13219.6 13229.0 13338.0 13350.1 13384.9 8447.3 8526.2 8557.3 8595.3 8628.4 8421.3 8507.9 8521.0 8675.4 8679.7 6421.6 6539.8 6547.0 6566.5 6573.8 1562.3 1699.4 1859.2 1889.3 1893.7 816.3 828.8 909.4 957.8 991.2 13802.4 15905.8 16602.9 18788.4 20068.0 982.9 1000.3 1026.6 1051.2 1095.4 11186.2 11512.2 11703.4 11711.4 11757.1 462545.0 468303.0 473704.0 475946.0 476717.0 100222.0 110343.0 113022.3 115781.0 129041.4 978.8 995.5 1020.8 1021.4 1025.2 18981.3 19124.9 19173.8 19203.8 19423.0 54459.0 54923.0 55621.0 55801.4 56577.0 80208.4 81311.2 82641.0 84192.0 87194.0 7716.8 7915.2 8036.7 8134.5 8306.4 9216.1 12189.8 12691.4 13040.9 13164.0 11161.9 11289.5 11484.4 11560.8 11607.4 10920.9 11153.9 11192.9 11309.6 11402.9 9355.0 10364.4 11260.7 11553.9 11702.9 7848.7 8083.4 8121.8 8182.4 8284.9 10757.8 10977.2 10991.9 11209.8 11272.8 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5706.21 Median:4851.47 stddev:3225.69 (66.5%) stddev-sans-first:3219.42 04:56:45 INFO - PROCESS | 1660 | Values: 1523.0 1570.2 1761.5 1825.6 1863.5 8058.3 8339.3 8549.2 9189.7 9214.8 8597.8 8873.5 8879.7 9003.9 9025.2 2374.7 2395.9 2399.4 2403.4 2404.6 1970.5 2369.6 2386.2 2410.2 2413.7 1947.5 2377.7 2385.2 2394.4 2397.5 2360.9 2361.1 2367.6 2380.8 2393.8 2379.2 2383.2 2395.3 2395.7 2395.9 9081.4 9130.0 9170.6 9219.1 9224.4 5328.5 5414.4 5487.9 5489.0 5499.2 3575.1 3682.3 3733.6 3743.6 3751.7 1078.2 1096.8 1098.0 1112.3 1119.8 11851.0 11879.8 11928.9 11953.9 12031.7 4346.9 4478.3 4581.8 4666.1 4676.7 9186.6 9213.7 9309.5 9313.0 9313.0 4378.5 4474.8 5245.7 5255.1 5267.3 4457.9 4605.7 4803.1 4899.8 4960.9 3746.3 3787.5 3879.4 3894.9 3900.4 1150.1 1167.9 1171.4 1173.9 1181.7 773.4 853.7 913.3 917.6 940.8 4976.3 5342.5 5403.6 5728.5 6082.3 874.4 907.5 949.0 955.5 987.1 3833.9 3840.0 3956.2 3980.9 4036.8 10172.0 10565.3 10577.9 10595.3 10596.2 10219.5 10516.2 10548.7 10725.7 10747.5 8306.3 8383.2 8401.1 8492.3 8504.8 5472.7 5754.9 5877.6 5930.5 6120.1 8585.9 9738.6 10187.6 10225.9 10248.9 10443.6 10451.6 10458.4 10463.4 10494.5 7058.0 7307.6 7467.8 7690.2 7810.4 8295.8 8631.1 8646.2 8665.4 8673.0 7561.7 7676.8 7676.8 7788.5 7809.5 7464.2 7496.3 7526.7 7534.0 7657.5 5813.3 7031.9 7084.0 7092.8 7118.3 3932.8 4573.6 4920.0 4979.3 5085.8 4346.5 5051.8 5072.9 5099.3 5131.1 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4693.29 Median:4962.63 stddev:1514.35 (30.5%) stddev-sans-first:1482.32 04:56:45 INFO - PROCESS | 1660 | Values: 303.3 305.5 311.3 317.5 317.8 4874.3 5344.2 5371.9 5544.2 5567.6 5324.9 5442.9 5563.4 5662.7 5692.2 3745.0 4317.4 4327.7 4346.8 4349.1 4159.5 4305.0 4346.0 4355.4 4370.0 4262.2 4288.3 4290.6 4316.6 4318.0 3256.6 3419.4 4292.3 4300.2 4329.9 3749.6 3758.7 3761.7 3762.4 3771.9 4071.9 4540.5 5026.9 5372.7 5476.7 4840.2 4847.5 4860.4 4861.6 4876.3 5586.6 5967.7 5991.6 6012.5 6019.9 3712.8 3917.4 3951.7 3961.8 3993.9 6255.1 6262.9 6332.0 6347.0 6359.7 3565.8 3690.6 3911.4 4056.0 4056.8 3682.9 4012.1 4099.5 4120.0 4142.0 3971.2 4296.4 4616.9 4846.8 4871.8 5838.6 6057.8 6092.6 6097.7 6104.6 1222.1 1273.4 1397.5 1399.9 1401.5 744.6 826.7 839.9 851.5 857.3 3925.5 4294.8 4769.5 4828.8 4843.5 4454.7 4697.3 4986.8 5213.7 5266.2 4381.6 4716.5 4821.9 4861.2 4880.7 2498.3 2579.5 2581.5 2684.6 2732.8 4777.5 5195.9 5294.9 5379.7 5463.4 4717.0 4913.9 5091.5 5411.3 5756.2 6407.6 6451.3 6478.4 6483.5 6486.7 4897.9 6249.5 6251.8 6265.5 6321.4 5958.7 6075.5 6098.2 6113.0 6141.7 6435.3 6459.5 6498.4 6505.9 6524.9 3027.6 3677.8 4009.4 4065.2 4086.8 6131.5 6149.1 6176.4 6184.8 6202.9 6037.2 6042.5 6059.7 6063.5 6106.2 5042.4 5275.4 5548.8 5577.5 6059.0 5896.9 5954.4 5965.1 5975.3 5981.0 4863.4 4938.4 5269.9 5814.3 5989.9 5425.9 5591.6 5795.5 5902.9 5941.2 04:56:45 INFO - PROCESS | 1660 | 04:56:45 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:23578.81 Median:3769.55 stddev:36986.84 (981.2%) stddev-sans-first:37050.49 04:56:45 INFO - PROCESS | 1660 | Values: 636.9 661.0 706.0 746.6 755.7 15123.4 15845.2 16056.6 16076.4 16157.4 14536.0 14595.5 14638.0 14644.8 14727.4 674.8 695.1 846.7 848.5 872.5 858.9 875.8 876.5 876.9 880.3 926.6 932.6 935.0 936.2 937.3 922.5 926.9 927.0 927.5 927.7 683.7 685.9 692.6 693.2 693.5 15391.4 15417.5 15511.0 15550.5 15553.1 11874.3 14426.3 14435.4 14449.9 14544.8 11504.7 11643.7 11650.5 11723.9 12049.8 3804.9 3864.0 3882.0 3990.8 3993.0 83808.6 100645.5 104771.0 107374.5 107555.5 9316.3 11069.7 11147.9 11166.7 11342.2 22759.5 22790.0 22796.3 22809.0 22930.0 7822.9 7877.3 8075.2 8088.0 8256.3 3489.0 4028.1 4478.8 4505.1 4589.9 3273.5 3579.2 3637.1 3729.7 3734.2 658.7 684.6 704.3 710.0 715.7 493.9 508.7 596.1 634.9 667.4 9679.0 9737.7 9742.9 9780.2 9794.5 653.1 681.9 687.8 690.2 690.4 4476.8 4585.1 4745.9 4756.2 4799.8 94518.0 95512.6 144455.0 151247.9 155744.0 101191.0 109559.7 110364.0 126024.0 128576.7 97077.0 110762.4 111700.0 112156.4 115001.0 8442.0 9106.3 9159.4 9184.6 9209.5 44971.8 58636.4 65636.3 65637.3 66515.0 91654.0 97673.0 98301.5 98802.0 100881.0 11422.3 11678.7 11825.8 11963.5 11992.1 13021.9 13029.7 13167.5 13242.0 13493.1 10518.9 11787.2 12231.1 12298.3 12515.9 12060.3 12183.3 12213.8 12291.3 12744.9 11835.2 12075.1 12222.1 12293.3 12443.4 10178.9 10438.7 10480.2 10619.1 10707.8 9236.2 10603.4 10642.2 10691.7 10791.6 04:56:45 INFO - PROCESS | 1660 | -------- Summary: end -------- 04:56:45 INFO - PROCESS | 1660 | 04:56:46 INFO - TEST-INFO | 1660: exit 0 04:56:46 INFO - TEST-OK | dromaeo_css | took 1114872ms 04:56:46 INFO - TEST-START | kraken 04:56:46 INFO - operating with platform_type : mac_ 04:56:46 INFO - Initialising browser for kraken test... 04:56:46 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpFmR6D4/profile http://localhost:49272/getInfo.html) 04:56:48 INFO - PROCESS | 1668 | 2016-09-27 04:56:48.514 plugin-container[1669:11190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4213, name = 'com.apple.tsm.portname' 04:56:48 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:48 INFO - PROCESS | 1668 | 2016-09-27 04:56:48.516 plugin-container[1669:11190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 04:56:48 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:48 INFO - PROCESS | 1668 | 2016-09-27 04:56:48.516 plugin-container[1669:11190] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:56:48 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 04:56:48 INFO - PROCESS | 1668 | colorDepth:24 04:56:48 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 04:56:48 INFO - PROCESS | 1668 | __metrics 04:56:48 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 04:56:49 INFO - TEST-INFO | 1668: exit 0 04:56:49 INFO - Browser initialized. 04:56:49 INFO - Running cycle 1/1 for kraken test... 04:56:49 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/tmpFmR6D4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:51 INFO - PROCESS | 1670 | 2016-09-27 04:56:51.633 plugin-container[1671:11306] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.tsm.portname' 04:56:51 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:51 INFO - PROCESS | 1670 | 2016-09-27 04:56:51.635 plugin-container[1671:11306] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 04:56:51 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:56:51 INFO - PROCESS | 1670 | 2016-09-27 04:56:51.635 plugin-container[1671:11306] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:57:01 INFO - PROCESS | 1670 | RSS: Main: 239517696 04:57:01 INFO - PROCESS | 1670 | 04:57:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:05 INFO - PROCESS | 1670 | RSS: Main: 253026304 04:57:05 INFO - PROCESS | 1670 | 04:57:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 04:57:08 INFO - PROCESS | 1670 | RSS: Main: 260456448 04:57:08 INFO - PROCESS | 1670 | 04:57:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 04:57:12 INFO - PROCESS | 1670 | RSS: Main: 261378048 04:57:12 INFO - PROCESS | 1670 | 04:57:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 04:57:14 INFO - PROCESS | 1670 | RSS: Main: 263569408 04:57:14 INFO - PROCESS | 1670 | 04:57:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:17 INFO - PROCESS | 1670 | RSS: Main: 263958528 04:57:17 INFO - PROCESS | 1670 | 04:57:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:20 INFO - PROCESS | 1670 | RSS: Main: 264392704 04:57:20 INFO - PROCESS | 1670 | 04:57:24 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:25 INFO - PROCESS | 1670 | RSS: Main: 262717440 04:57:25 INFO - PROCESS | 1670 | 04:57:27 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 04:57:28 INFO - PROCESS | 1670 | RSS: Main: 263614464 04:57:28 INFO - PROCESS | 1670 | 04:57:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:30 INFO - PROCESS | 1670 | RSS: Main: 263798784 04:57:30 INFO - PROCESS | 1670 | 04:57:32 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:33 INFO - PROCESS | 1670 | RSS: Main: 263892992 04:57:33 INFO - PROCESS | 1670 | 04:57:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:36 INFO - PROCESS | 1670 | RSS: Main: 263950336 04:57:36 INFO - PROCESS | 1670 | 04:57:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:39 INFO - PROCESS | 1670 | RSS: Main: 264294400 04:57:39 INFO - PROCESS | 1670 | 04:57:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:43 INFO - PROCESS | 1670 | RSS: Main: 264351744 04:57:43 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 04:57:45 INFO - PROCESS | 1670 | RSS: Main: 266018816 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | __start_tp_report 04:57:45 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 04:57:45 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 04:57:45 INFO - PROCESS | 1670 | |i|pagename|runs| 04:57:45 INFO - PROCESS | 1670 | |0;ai-astar;107;117;117;119;118;117;117;117;118;117 04:57:45 INFO - PROCESS | 1670 | |1;audio-beat-detection;146;143;144;148;109;110;110;112;142;130 04:57:45 INFO - PROCESS | 1670 | |2;audio-dft;197;208;204;227;236;198;193;192;194;192 04:57:45 INFO - PROCESS | 1670 | |3;audio-fft;82;59;67;91;86;72;84;51;96;83 04:57:45 INFO - PROCESS | 1670 | |4;audio-oscillator;82;72;85;70;70;71;87;68;71;85 04:57:45 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;86;89;87;135;86;90;88;89;90 04:57:45 INFO - PROCESS | 1670 | |6;imaging-darkroom;170;113;172;117;124;172;118;169;168;100 04:57:45 INFO - PROCESS | 1670 | |7;imaging-desaturate;90;99;92;90;86;112;153;148;91;94 04:57:45 INFO - PROCESS | 1670 | |8;json-parse-financial;57;56;56;58;56;59;58;59;90;51 04:57:45 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;75;84;68;80;77;71;71;73;72;71 04:57:45 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;86;91;91;87;85;88;87;86;89;89 04:57:45 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;138;141;166;162;137;139;154;140;171;138 04:57:45 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;170;177;170;170;172;176;171;168;172;182 04:57:45 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;69;68;69;69;68;70;72;60;78 04:57:45 INFO - PROCESS | 1670 | __end_tp_report 04:57:45 INFO - PROCESS | 1670 | __start_cc_report 04:57:45 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,928 04:57:45 INFO - PROCESS | 1670 | __end_cc_report 04:57:45 INFO - PROCESS | 1670 | __startTimestamp1474977465248__endTimestamp 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | ------- Summary: start ------- 04:57:45 INFO - PROCESS | 1670 | Number of tests: 14 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:116.40 Median:117.00 stddev:3.37 (2.9%) stddev-sans-first:0.73 04:57:45 INFO - PROCESS | 1670 | Values: 107.0 117.0 117.0 119.0 118.0 117.0 117.0 117.0 118.0 117.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:142.50 stddev:17.16 (12.0%) stddev-sans-first:17.12 04:57:45 INFO - PROCESS | 1670 | Values: 146.0 143.0 144.0 148.0 109.0 110.0 110.0 112.0 142.0 130.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:204.10 Median:201.00 stddev:15.50 (7.7%) stddev-sans-first:16.23 04:57:45 INFO - PROCESS | 1670 | Values: 197.0 208.0 204.0 227.0 236.0 198.0 193.0 192.0 194.0 192.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:77.10 Median:83.50 stddev:14.43 (17.3%) stddev-sans-first:15.19 04:57:45 INFO - PROCESS | 1670 | Values: 82.0 59.0 67.0 91.0 86.0 72.0 84.0 51.0 96.0 83.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:77.00 stddev:7.61 (9.9%) stddev-sans-first:7.76 04:57:45 INFO - PROCESS | 1670 | Values: 82.0 72.0 85.0 70.0 70.0 71.0 87.0 68.0 71.0 85.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:89.00 stddev:14.87 (16.7%) stddev-sans-first:15.70 04:57:45 INFO - PROCESS | 1670 | Values: 89.0 86.0 89.0 87.0 135.0 86.0 90.0 88.0 89.0 90.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:142.30 Median:168.50 stddev:30.03 (17.8%) stddev-sans-first:30.14 04:57:45 INFO - PROCESS | 1670 | Values: 170.0 113.0 172.0 117.0 124.0 172.0 118.0 169.0 168.0 100.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:90.50 stddev:24.79 (27.4%) stddev-sans-first:25.66 04:57:45 INFO - PROCESS | 1670 | Values: 90.0 99.0 92.0 90.0 86.0 112.0 153.0 148.0 91.0 94.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:58.00 stddev:10.79 (18.6%) stddev-sans-first:11.39 04:57:45 INFO - PROCESS | 1670 | Values: 57.0 56.0 56.0 58.0 56.0 59.0 58.0 59.0 90.0 51.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:74.00 stddev:4.87 (6.6%) stddev-sans-first:5.16 04:57:45 INFO - PROCESS | 1670 | Values: 75.0 84.0 68.0 80.0 77.0 71.0 71.0 73.0 72.0 71.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.50 stddev:2.08 (2.3%) stddev-sans-first:2.09 04:57:45 INFO - PROCESS | 1670 | Values: 86.0 91.0 91.0 87.0 85.0 88.0 87.0 86.0 89.0 89.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:147.50 stddev:13.32 (9.0%) stddev-sans-first:13.56 04:57:45 INFO - PROCESS | 1670 | Values: 138.0 141.0 166.0 162.0 137.0 139.0 154.0 140.0 171.0 138.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:172.00 stddev:4.26 (2.5%) stddev-sans-first:4.40 04:57:45 INFO - PROCESS | 1670 | Values: 170.0 177.0 170.0 170.0 172.0 176.0 171.0 168.0 172.0 182.0 04:57:45 INFO - PROCESS | 1670 | 04:57:45 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:4.39 (6.4%) stddev-sans-first:4.66 04:57:45 INFO - PROCESS | 1670 | Values: 69.0 69.0 68.0 69.0 69.0 68.0 70.0 72.0 60.0 78.0 04:57:45 INFO - PROCESS | 1670 | -------- Summary: end -------- 04:57:45 INFO - PROCESS | 1670 | 04:57:46 INFO - TEST-INFO | 1670: exit 0 04:57:46 INFO - TEST-OK | kraken | took 60171ms 04:57:46 INFO - SUITE-END | took 1175s 04:57:46 INFO - Completed test suite (00:19:35) 04:57:46 INFO - javascript benchmark 04:57:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7300.776853552049, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.705907938745, 3421.8631254749807, 3462.9999999999986, 3485.8082805445706, 3505.544279243698, 5794.333651630064, 5903.498202652774, 5970.970145149279, 6008.609440386372, 6025.457708806207, 4475.664325175617, 4828.855134345967, 5487.283794521707, 5814.563907706918, 5971.37300583439, 5284.550813180875, 5377.354717433914, 5390.326209223847, 5394.676319420828, 5453.182022696607, 5390.380106287788, 5462.644928079682, 5497.5601951843955, 5510.228568000483, 5520.254765606652, 5277.551408130314, 5444.455554444524, 5472.644278121949, 5482.5613950883835, 5557.944420555803, 5332.2801421808335, 5334.119870221448, 5342.91985620216, 5371.382291036542, 5394.056040192951, 4384.561543845622, 5247.317848679685, 5277.02375060615, 5301.045811753883, 5338.572914166896, 4672.719636821802, 5855.828834233171, 6024.698765061773, 6043.939560604382, 6044.667543285118, 6136.825445958276, 6186.133941248228, 6248.625082495065, 6321.589096708699, 6331.461825744817, 5181.766820493087, 5314.4951229633125, 6322.620642761449, 6353.396516647682, 6389.0, 4898.0, 4919.016196760662, 5756.136579513107, 5974.0, 6084.421979911857, 6390.744370225232, 6415.166028416369, 6447.0329450582785, 6551.246606640298, 6565.67171641416, 6278.811635650938, 6286.05709143623, 6287.874242515124, 6291.716872740646, 6308.243010838729, 5156.252343410185, 6197.318294987548, 6388.744450221939, 6394.392532709385, 6416.518761092937, 6154.7230374633245, 6246.406591373812, 6261.96869015652, 6279.968600157062, 6284.308726040132, 5420.891582168335, 6213.378662133841, 6271.874562508816, 6302.779402720883, 6331.683415829282, 4639.837605683852, 5008.949910500921, 5053.823116190915, 5112.590992720573, 5119.923201151985, 3982.661473774762, 4542.318652202196, 4560.315952607069, 4579.542045795394, 4592.70147440422, 5996.280446346466, 6072.906876762225, 6087.726052327655, 6089.177960975212, 6120.938790612126, 6114.082887566811, 6444.323346048691, 6452.257990331172, 6455.0317452382515, 6476.708548115252, 5691.459311365414, 5754.223179870663, 5772.7113644317615, 5787.739551720183, 5805.651660900359, 5509.724513774296, 5544.445555444423, 5576.96826087167, 5601.495865372136, 5675.4324567543745, 6599.670016499156, 6613.570117942319, 6633.071370008202, 6637.867242655217, 6644.069830223772, 6228.688565571794, 6346.984482482781, 6413.518986075969, 6425.0, 6439.613623182624, 6451.1936007999, 6486.05952136928, 6510.73957041713, 6514.902276465951, 6664.033715111379, 5396.109641909041, 6173.84565385851, 6175.722092505938, 6248.782072101404, 6310.305866354789, 6173.660448675366, 6284.968575157095, 6290.0, 6345.428911397997, 6370.74517019314, 6145.555794388226, 6224.875502489835, 6278.497720182283, 6280.183576135073, 6280.371962803683, 4467.195904737048, 6092.695365231632, 6207.534434917309, 6208.81373558794, 6269.341719119427, 6098.207233059674, 6151.630902145886, 6213.502919766498, 6227.595206311576, 6228.4705800005695, 6123.404636889863, 6241.500679945684, 6262.436380725757, 6266.968665156827, 6308.148399965946, 6109.6639684817765, 6135.417135372132, 6149.985252433298, 6219.689015549295, 6252.406021427957], "value": 5770.996102948839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.2287241742499, 490.81103775046597, 520.1132069820956, 521.6087934049463, 534.0920435260059, 39243.80378098109, 40960.38559421607, 41025.38461923073, 43482.13035739283, 43528.25886964526, 42248.366274505905, 42272.577274227326, 42853.57146428535, 42858.57141428585, 42864.0, 9780.902190978088, 9925.404475731479, 9937.354071985297, 9966.850497242547, 9985.301028927977, 9733.756656083584, 9803.852942205873, 9810.411375317504, 9842.950785246063, 9849.852252216222, 9798.0, 9804.90195098047, 9839.606415743361, 9845.60617575296, 9848.06443387877, 9751.41491510508, 9790.902090979142, 9796.069373409515, 9826.213902887823, 9836.508174591241, 8650.048494665582, 8686.783850260968, 9464.290178236592, 9525.761650985396, 9790.167835733972, 40035.19929601421, 40271.993200169934, 40432.39351409731, 40560.0, 40712.592874071175, 3285.96714032859, 3450.516927630134, 3592.0301518590095, 3927.8821635350987, 3984.362501999666, 30549.236269093228, 30798.53802192969, 30823.0, 31352.0, 31955.680443195502, 3273.918152046218, 3277.147941535194, 3290.588676415448, 3352.513885486615, 3387.119348969261, 313799.0, 315545.0, 316236.0, 317422.0, 318301.0, 32318.35363292721, 56372.71813640906, 56678.01626943037, 56792.0, 56793.0, 32908.83545582257, 33825.32349352999, 33900.0, 34217.65782342145, 34238.82880585581, 12059.698507537207, 14638.780418293734, 14689.853101468849, 14736.263186840615, 14751.852481475262, 12354.38228088592, 12453.1905426147, 12460.376981150906, 12467.501299948082, 12499.250044997329, 7572.167061623217, 7716.6527506262355, 7778.49439786412, 7791.92208077912, 7809.843803123906, 3245.8052516849066, 3252.495863141217, 3281.8851340202978, 3292.8847490338203, 3302.53764472974, 851.0170752780548, 924.6717415317465, 937.1893312284825, 944.1266828183902, 998.1515711645188, 26131.216063518124, 28000.439991200063, 28949.0, 30216.5467517983, 30514.43939553007, 1006.7281833904805, 1031.1956673794452, 1066.3708412036935, 1082.783443311341, 1149.4884776274646, 14565.708685826436, 14634.926825365805, 15750.291236894367, 15828.44600438979, 16261.18694065292, 537992.0, 540595.0, 542299.0, 543872.0, 544096.2795186078, 56316.43683563194, 56458.717706412026, 56653.716731416076, 56907.43092569104, 57273.0, 1294.4369199398293, 1344.0524430276632, 1360.4558176729388, 1360.4762166565943, 1364.7004796917424, 29647.110586682433, 29783.25541861384, 30555.847220763753, 32824.50763238506, 33502.162445939044, 55146.0, 59753.103703443616, 60137.39862601493, 60201.397986019576, 60307.69846150741, 426861.0, 498369.0, 509373.2501399953, 511604.0, 512579.0, 37644.2471150581, 41958.1608367837, 43335.56664433315, 44808.77595612001, 45127.32309015433, 48168.0, 48590.757046214545, 49313.01373972572, 49828.50171498384, 49990.75004625099, 32040.51939220867, 40472.79763601163, 40624.0, 41271.58728412678, 41639.0, 32375.0, 32506.0, 33963.64145434155, 37239.62760372362, 38868.80565597154, 33358.83320583381, 36396.45405318975, 37550.11848459683, 37628.05929851666, 38855.02862428462, 31915.680843191272, 34675.959721208405, 34949.12627184341, 35201.29597408089, 35342.64657353496, 23918.52162956766, 24819.87590062038, 26366.0, 26488.602670959564, 26608.60087098734], "value": 18544.10203422027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9888703338901, 373.6935712715573, 378.5192805137476, 384.44063887044354, 402.91740193260387, 18772.55596875234, 20317.49206269844, 20767.376978690627, 20965.790342096574, 20977.58044839102, 19469.707954380694, 19936.70094948577, 20215.59568808623, 20257.797422025775, 20694.275700350492, 4997.725125118135, 5818.3308919474375, 6028.156058151841, 6081.087836824468, 6088.208532890718, 5964.493018093467, 6071.058985857199, 6074.5747797654185, 6080.2399700037495, 6085.604435711687, 5749.367569567345, 5914.9112763308585, 5939.4357536034, 5942.286925568917, 5943.673097979631, 5672.6312789668955, 5918.230630018092, 5979.910301345505, 5984.611000284967, 5998.220231369915, 5083.593312534988, 5130.3074084998425, 5139.588832893397, 5152.974235128838, 5163.044836705221, 24224.87887560551, 24435.87782061096, 24539.87730061356, 24548.018079276808, 24563.89462474193, 2309.168699268262, 2464.3592665906813, 2889.815175777942, 3152.0, 3153.243221626816, 14796.926015369962, 14895.70208595822, 15311.310991005432, 15708.293126809322, 16013.279402426802, 1860.9534761630932, 1892.9621407571908, 1901.2965202874886, 1925.8170473804967, 1928.0937959159173, 68703.92306808029, 103972.0, 103984.9203015943, 104464.0, 110137.0, 10346.275760696679, 10565.154787616972, 10796.622118225825, 10851.186161037953, 11002.50488728009, 13219.603411897659, 13229.0, 13338.0, 13350.132241404277, 13384.866151338556, 8447.281981031558, 8526.190011948855, 8557.272631826365, 8595.269402100766, 8628.35287353451, 8421.284190843848, 8507.872381914276, 8521.0, 8675.39272250949, 8679.6528138875, 6421.591903036361, 6539.836504087436, 6547.0, 6566.540342176002, 6573.80278591643, 1562.3438155974518, 1699.4137022727139, 1859.191251805469, 1889.2537447708078, 1893.6591413545418, 816.3306089007076, 828.7679449754079, 909.354069134868, 957.7509847439716, 991.2218908157062, 13802.37889294984, 15905.840941590435, 16602.91698541524, 18788.402985746092, 20067.996600170227, 982.8967958364269, 1000.309786247487, 1026.594495174402, 1051.2273478992934, 1095.370162156747, 11186.216964812385, 11512.194146409838, 11703.414829258503, 11711.355875426932, 11757.118216133824, 462545.0, 468303.0, 473704.0, 475946.0, 476717.0, 100222.0, 110343.0, 113022.30466543009, 115781.0, 129041.35479322543, 978.7748817771952, 995.5072239241622, 1020.78563501664, 1021.4024795494719, 1025.2464438637596, 18981.33565325207, 19124.948127853102, 19173.808261917202, 19203.807961920204, 19423.0, 54459.0, 54923.0, 55621.0, 55801.44198558125, 56577.0, 80208.39583208186, 81311.18688813037, 82641.0, 84192.0, 87194.0, 7716.765317549165, 7915.168907264884, 8036.67853285862, 8134.471259368122, 8306.377021723274, 9216.124468175512, 12189.817152742538, 12691.365431728193, 13040.869591303965, 13164.012699047418, 11161.888381116085, 11289.491972861406, 11484.425778710864, 11560.826587601025, 11607.419629018685, 10920.945395272973, 11153.944230278797, 11192.88807111951, 11309.604163854226, 11402.885971140182, 9355.0, 10364.378137311785, 11260.718482038015, 11553.884461155281, 11702.88297117052, 7848.686052557834, 8083.393745469231, 8121.796955075934, 8182.386321026066, 8284.875726864222, 10757.784844303227, 10977.231593788358, 10991.890081099087, 11209.831852522382, 11272.7745445089], "value": 9619.379805871036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.0176536134197, 1570.1835045776197, 1761.5331937036688, 1825.607494388706, 1863.4689113602626, 8058.315043221319, 8339.33285337173, 8549.230569248766, 9189.724308270746, 9214.769630759227, 8597.828043439144, 8873.467591944487, 8879.689210877621, 9003.90996090039, 9025.2328552073, 2374.6912901322803, 2395.9338094547934, 2399.3881560202126, 2403.42317843718, 2404.5912194926905, 1970.5172232802984, 2369.597168481362, 2386.2244770449674, 2410.20463247128, 2413.734489206186, 1947.464447276996, 2377.714674239085, 2385.200957679171, 2394.365493144318, 2397.520495900818, 2360.9173678921243, 2361.055577768889, 2367.633016882386, 2380.821438392119, 2393.8204634652297, 2379.226751305815, 2383.189715496722, 2395.3053614451787, 2395.6646069550275, 2395.940101497459, 9081.409708369001, 9130.0, 9170.633174673005, 9219.078092190794, 9224.354295199339, 5328.5470734987575, 5414.402751188409, 5487.917681234785, 5489.0, 5499.230107784913, 3575.0883524701294, 3682.2819550187455, 3733.5893051764556, 3743.5507739071213, 3751.662350388478, 1078.1698092468835, 1096.8245080787115, 1097.9780404391947, 1112.3381587955155, 1119.764849381631, 11851.0, 11879.762404751857, 11928.880711192864, 11953.880461195364, 12031.699207519794, 4346.869593912188, 4478.2610869206865, 4581.816727330936, 4666.113438446684, 4676.672632915664, 9186.586603602855, 9213.677521286723, 9309.487978161265, 9312.953435232781, 9313.0, 4378.496472905593, 4474.798634061475, 5245.659032162897, 5255.106631872591, 5267.2889159962915, 4457.910841783211, 4605.700629459141, 4803.135435621552, 4899.804007839646, 4960.851174464772, 3746.269477451925, 3787.450819631193, 3879.359905615598, 3894.90262743428, 3900.3759398496104, 1150.0512077536066, 1167.9240849344765, 1171.4318555500574, 1173.9119566032582, 1181.710480932177, 773.389022672094, 853.6926706385697, 913.3104506097986, 917.5779141594808, 940.7957813998094, 4976.253561965662, 5342.465753424626, 5403.594730395236, 5728.453317604223, 6082.270127584629, 874.4010352908278, 907.4827348411342, 948.9620415183315, 955.4649396338073, 987.0524296675129, 3833.9424908626393, 3839.9808000959815, 3956.208758248362, 3980.9402858957137, 4036.798160091984, 10172.0, 10565.260431769702, 10577.947110264553, 10595.258331916692, 10596.152307815357, 10219.48902554884, 10516.158707303397, 10548.736281592868, 10725.678229653124, 10747.516361763739, 8306.252437280553, 8383.245507904196, 8401.075881653012, 8492.320614350838, 8504.787380315418, 5472.713912230543, 5754.9424505754405, 5877.559183061202, 5930.466258036798, 6120.1125836752535, 8585.914140858511, 9738.610455581698, 10187.643432479828, 10225.948870255601, 10248.897511025092, 10443.582256709951, 10451.58193672275, 10458.424786636504, 10463.372197668165, 10494.47527623631, 7057.964710176417, 7307.5980821055355, 7467.813304667427, 7690.154083050748, 7810.375169986274, 8295.792605184919, 8631.050584435832, 8646.178613031752, 8665.350098742494, 8673.002604700288, 7561.6597253122645, 7676.769696909102, 7676.80807979805, 7788.493747906368, 7809.531428114331, 7464.178940316452, 7496.25037496246, 7526.698932042657, 7534.0, 7657.540547567164, 5813.302403711582, 7031.859362812613, 7083.964580177066, 7092.787216383516, 7118.323759242864, 3932.803359832054, 4573.565511276423, 4920.015996800583, 4979.253112033224, 5085.847424577269, 4346.456692913386, 5051.772670229775, 5072.923906141485, 5099.260607212008, 5131.050755610224], "value": 4575.527532691459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.30845671868144, 305.4898319805924, 311.2793882162793, 317.45081009852953, 317.84107946026984, 4874.293227482013, 5344.243623175377, 5371.919421208685, 5544.223808666785, 5567.608097975506, 5324.866878328044, 5442.945570544293, 5563.415841336652, 5662.6602403855795, 5692.174634677969, 3744.9701332133677, 4317.351837697141, 4327.7186982846015, 4346.8043938022865, 4349.1301739652035, 4159.52078524794, 4305.031367942219, 4345.956540434587, 4355.36847157162, 4369.956300437003, 4262.1688770689725, 4288.335308027261, 4290.570942905716, 4316.611504964552, 4317.956820431803, 3256.5929258842643, 3419.401604719164, 4292.313229883203, 4300.204462174508, 4329.870103896888, 3749.568799588055, 3758.7180961428003, 3761.6614504694708, 3762.4168253920684, 3771.8679846205528, 4071.877843664695, 4540.502723502061, 5026.874328141789, 5372.650777699437, 5476.726163691839, 4840.2255639097575, 4847.5394837490385, 4860.392450943632, 4861.611071114302, 4876.317315575822, 5586.608937374385, 5967.731452084667, 5991.5961768100415, 6012.458878700894, 6019.939800601982, 3712.8304584055936, 3917.3557848452183, 3951.723379363446, 3961.801909904493, 3993.8832418818074, 6255.1234629610935, 6262.906056409158, 6331.96834015827, 6346.9682651586445, 6359.713812878432, 3565.8395372208315, 3690.579127036057, 3911.3546264865977, 4055.965728739153, 4056.7768772717195, 3682.926341473209, 4012.077222238843, 4099.508059032935, 4119.958800411958, 4141.97929010353, 3971.212954170635, 4296.398504209413, 4616.8614941551805, 4846.75766211688, 4871.780769865364, 5838.591298609056, 6057.757689692363, 6092.598702298496, 6097.695115244309, 6104.572679912363, 1222.0956492195712, 1273.382803839119, 1397.475946520055, 1399.8950078744135, 1401.467442371892, 744.5941961630924, 826.7262328481379, 839.9118092600311, 851.4848516647463, 857.3312816003527, 3925.4700615417123, 4294.763787991628, 4769.499202583679, 4828.782704778293, 4843.539863712942, 4454.683564546483, 4697.271922851964, 4986.825461108844, 5213.661112027706, 5266.182018036892, 4381.627561657231, 4716.528347165256, 4821.9035619287415, 4861.173600487926, 4880.6583539152625, 2498.2879879234692, 2579.522788284136, 2581.4511293223914, 2684.6106964801343, 2732.7702533859447, 4777.474477807438, 5195.922061169085, 5294.867628309323, 5379.73101344939, 5463.399026107125, 4716.976415117902, 4913.901721965541, 5091.490850914879, 5411.347340545116, 5756.193578362031, 6407.615543067431, 6451.29035806061, 6478.4169424752, 6483.481321494175, 6486.708098135501, 4897.853064408074, 6249.500039996698, 6251.812445626639, 6265.467435268053, 6321.367863213642, 5958.731857066356, 6075.544334174866, 6098.207233059674, 6112.969435152973, 6141.692915354304, 6435.292117866938, 6459.515536334888, 6498.447631951148, 6505.902411463737, 6524.934750652433, 3027.6215473065868, 3677.808262284752, 4009.438678585059, 4065.2479291331197, 4086.836526538905, 6131.478824299985, 6149.142177679583, 6176.413240742122, 6184.81445556634, 6202.937970620416, 6037.245344331958, 6042.546808989431, 6059.72731227087, 6063.542811469712, 6106.2061931948565, 5042.420121686053, 5275.419703832498, 5548.778048878, 5577.518004488126, 6059.0, 5896.877124235186, 5954.422078149208, 5965.135055416853, 5975.340973266854, 5981.0, 4863.449681732426, 4938.44376269975, 5269.868253293698, 5814.30228372581, 5989.850253743692, 5425.941941321405, 5591.6365436246515, 5795.478406943227, 5902.911456328245, 5941.22764040672], "value": 4202.205365795145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.8981661725218, 660.9900851487228, 705.9788206353808, 746.6266866566716, 755.6977209116353, 15123.395064197433, 15845.207739613003, 16056.598585035379, 16076.437324693637, 16157.434489792844, 14536.0, 14595.489157879476, 14638.0, 14644.780328295084, 14727.410903563845, 674.8076798112539, 695.1484431571309, 846.7375113714737, 848.5460278750869, 872.5419154943642, 858.8969323681135, 875.8379699755534, 876.5135349880813, 876.8640860666607, 880.3089574683875, 926.6154545863459, 932.6316105138466, 935.036911980661, 936.199549385276, 937.2595649436937, 922.5110691333604, 926.9212116970066, 927.0266220468482, 927.4667066436792, 927.6660402255217, 683.71967493328, 685.9485538584626, 692.560224257595, 693.1578132568953, 693.5145398221215, 15391.384344626202, 15417.537473875802, 15511.0, 15550.455734049254, 15553.144577048259, 11874.346910919896, 14426.27868606576, 14435.35040923161, 14449.927750361287, 14544.781828272584, 11504.654860354203, 11643.708907277301, 11650.475728592233, 11723.882761172365, 12049.759004819854, 3804.90487737806, 3864.0339915021245, 3882.0, 3990.760554366718, 3993.0217096811175, 83808.58095709543, 100645.4967725164, 104771.0, 107374.46312768386, 107555.46222268917, 9316.254699624014, 11069.72325691848, 11147.888521114848, 11166.665000050012, 11342.221155816878, 22759.544809104056, 22790.0, 22796.316110516713, 22809.0, 22930.0, 7822.921770782333, 7877.344713040288, 8075.192480751878, 8087.989001374828, 8256.298214651822, 3489.0, 4028.073543085107, 4478.798454069574, 4505.144022635689, 4589.862304130881, 3273.5089736539708, 3579.2125732338845, 3637.054365864841, 3729.68297694699, 3734.1971476132762, 658.6640813185214, 684.5995092870627, 704.3484776581641, 709.9680514376865, 715.7351779841492, 493.9209726443752, 508.6617399429412, 596.1028651878895, 634.9492040636738, 667.3926726678699, 9678.95160524193, 9737.659181928599, 9742.853857192147, 9780.168685661798, 9794.510274486247, 653.1150291355241, 681.8636272745471, 687.8383579858729, 690.1683471416931, 690.3510699942038, 4476.798544065525, 4585.12882552314, 4745.928811067837, 4756.21522448799, 4799.760011999386, 94518.0, 95512.56731149038, 144455.0, 151247.90016798628, 155744.0, 101191.0, 109559.71320860388, 110364.0, 126024.0, 128576.71423285834, 97077.0, 110762.44618776854, 111700.0, 112156.43921780339, 115001.0, 8441.95779021101, 9106.317026222927, 9159.404638698463, 9184.632614695338, 9209.539523023956, 44971.77514112408, 58636.41363586309, 65636.34363656302, 65637.34362656504, 66515.0, 91654.0, 97673.0, 98301.50849245708, 98802.01197987929, 100881.0, 11422.25755325901, 11678.70803229892, 11825.763484730429, 11963.461644226205, 11992.100592455427, 13021.934890325489, 13029.739405212033, 13167.53913613019, 13242.0, 13493.055486115878, 10518.895515970713, 11787.174897757075, 12231.05300948271, 12298.262104273772, 12515.874841251834, 12060.336681482602, 12183.269003859798, 12213.816792747939, 12291.32397718134, 12744.936275318563, 11835.230710003822, 12075.094367922266, 12222.144449888423, 12293.323867187033, 12443.37783110859, 10178.949105254427, 10438.68683939483, 10480.161587072864, 10619.05612802006, 10707.839382409114, 9236.18837593372, 10603.41681207541, 10642.201834862572, 10691.679249622213, 10791.6222932197], "value": 7649.805748633295, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 144.0, 148.0, 109.0, 110.0, 110.0, 112.0, 142.0, 130.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 208.0, 204.0, 227.0, 236.0, 198.0, 193.0, 192.0, 194.0, 192.0], "value": 204.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 67.0, 91.0, 86.0, 72.0, 84.0, 51.0, 96.0, 83.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 85.0, 70.0, 70.0, 71.0, 87.0, 68.0, 71.0, 85.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 135.0, 86.0, 90.0, 88.0, 89.0, 90.0], "value": 92.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 113.0, 172.0, 117.0, 124.0, 172.0, 118.0, 169.0, 168.0, 100.0], "value": 142.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 99.0, 92.0, 90.0, 86.0, 112.0, 153.0, 148.0, 91.0, 94.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 58.0, 56.0, 59.0, 58.0, 59.0, 90.0, 51.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 68.0, 80.0, 77.0, 71.0, 71.0, 73.0, 72.0, 71.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 91.0, 87.0, 85.0, 88.0, 87.0, 86.0, 89.0, 89.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 166.0, 162.0, 137.0, 139.0, 154.0, 140.0, 171.0, 138.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 177.0, 170.0, 170.0, 172.0, 176.0, 171.0, 168.0, 172.0, 182.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 68.0, 70.0, 72.0, 60.0, 78.0], "value": 69.2, "unit": "score"}]}]} 04:57:46 INFO - Return code: 0 04:57:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:46 ERROR - # TBPL SUCCESS # 04:57:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:46 INFO - 2016-09-27 04:57:46.568 screenresolution[1675:11689] starting screenresolution argv=screenresolution get 04:57:46 INFO - 2016-09-27 04:57:46.571 screenresolution[1675:11689] Display 0: 1600x1200x32@60 04:57:46 INFO - 2016-09-27 04:57:46.577 screenresolution[1676:11692] starting screenresolution argv=screenresolution list 04:57:46 INFO - Available Modes on Display 0 04:57:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:46 INFO - Intel Iris: 04:57:46 INFO - Chipset Model: Intel Iris 04:57:46 INFO - Type: GPU 04:57:46 INFO - Bus: Built-In 04:57:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:46 INFO - Vendor: Intel (0x8086) 04:57:46 INFO - Device ID: 0x0a2e 04:57:46 INFO - Revision ID: 0x0009 04:57:46 INFO - Displays: 04:57:46 INFO - Display: 04:57:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:46 INFO - Display Serial Number: 1600x1200 60 04:57:46 INFO - Main Display: Yes 04:57:46 INFO - Mirror: Off 04:57:46 INFO - Online: Yes 04:57:46 INFO - Rotation: Supported 04:57:46 INFO - Return code: 0 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - [mozharness: 2016-09-27 11:57:46.824404Z] Finished run-tests step (success) 04:57:46 INFO - Running post-run listener: _resource_record_post_run 04:57:46 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32727552; Write bytes: 710344704; Read time: 200; Write time: 2012 04:57:46 INFO - TinderboxPrint: CPU usage
54.4% 04:57:46 INFO - TinderboxPrint: I/O read bytes / time
32,727,552 / 200 04:57:46 INFO - TinderboxPrint: I/O write bytes / time
710,344,704 / 2,012 04:57:46 INFO - TinderboxPrint: CPU idle
2,206.7 (45.6%) 04:57:46 INFO - TinderboxPrint: CPU system
975.5 (20.1%) 04:57:46 INFO - TinderboxPrint: CPU user
1,659.3 (34.3%) 04:57:46 INFO - TinderboxPrint: Swap in / out
436,305,920 / 0 04:57:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397353472; Write bytes: 391493632; Read time: 29749; Write time: 811 04:57:46 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30749184; Write bytes: 298721792; Read time: 182; Write time: 1152 04:57:47 INFO - Running post-run listener: _upload_blobber_files 04:57:47 INFO - Blob upload gear active. 04:57:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:47 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 04:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:57:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:57:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:48 INFO - (blobuploader) - INFO - Done attempting. 04:57:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:57:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:57:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:49 INFO - (blobuploader) - INFO - Done attempting. 04:57:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:52 INFO - (blobuploader) - INFO - Done attempting. 04:57:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:52 INFO - Return code: 0 04:57:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14847189e0f640adffaf8fcb184ed0fe2edc816d97d2a2f7b716bf2d739f84092569a296c40d6e6d96e4954cd14a307fcf5e67951e6bfe22215fb2d1e0b1f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b895082a35adedcea6e97245c384e54f8415e0280abe4cd2d497682d4fe6ff8329aaafc5d34d7213385716021b86f4297bf0bd9bc790f585cd982c5c41ea144b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32fbc9f1a23e90ecadef2e2c55e14b0567717a814db2ad10d284e6999b09bbb0310c4da09c9d7b3bec2ed4f6cafa4bf8d74d400b62213ebaa1d0e801686b2988"} 04:57:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:52 INFO - Contents: 04:57:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14847189e0f640adffaf8fcb184ed0fe2edc816d97d2a2f7b716bf2d739f84092569a296c40d6e6d96e4954cd14a307fcf5e67951e6bfe22215fb2d1e0b1f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b895082a35adedcea6e97245c384e54f8415e0280abe4cd2d497682d4fe6ff8329aaafc5d34d7213385716021b86f4297bf0bd9bc790f585cd982c5c41ea144b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32fbc9f1a23e90ecadef2e2c55e14b0567717a814db2ad10d284e6999b09bbb0310c4da09c9d7b3bec2ed4f6cafa4bf8d74d400b62213ebaa1d0e801686b2988"} 04:57:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:52 INFO - Copying logs to upload dir... 04:57:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.545721 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-27 04:57:52.985501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:52.988997) ========= 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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14847189e0f640adffaf8fcb184ed0fe2edc816d97d2a2f7b716bf2d739f84092569a296c40d6e6d96e4954cd14a307fcf5e67951e6bfe22215fb2d1e0b1f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b895082a35adedcea6e97245c384e54f8415e0280abe4cd2d497682d4fe6ff8329aaafc5d34d7213385716021b86f4297bf0bd9bc790f585cd982c5c41ea144b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32fbc9f1a23e90ecadef2e2c55e14b0567717a814db2ad10d284e6999b09bbb0310c4da09c9d7b3bec2ed4f6cafa4bf8d74d400b62213ebaa1d0e801686b2988"} build_url:https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/JDgIdQ3OQI-aVtmpcf1QGg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b14847189e0f640adffaf8fcb184ed0fe2edc816d97d2a2f7b716bf2d739f84092569a296c40d6e6d96e4954cd14a307fcf5e67951e6bfe22215fb2d1e0b1f2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b895082a35adedcea6e97245c384e54f8415e0280abe4cd2d497682d4fe6ff8329aaafc5d34d7213385716021b86f4297bf0bd9bc790f585cd982c5c41ea144b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32fbc9f1a23e90ecadef2e2c55e14b0567717a814db2ad10d284e6999b09bbb0310c4da09c9d7b3bec2ed4f6cafa4bf8d74d400b62213ebaa1d0e801686b2988"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:53.022512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:53.022854) ========= 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.mXZrcPHfkN/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.WCiJIGTmeX/Listeners TMPDIR=/var/folders/94/wsdgpk794y1563fy307h6kq400000w/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.005281 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 04:57:53.071532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:57:53.071844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 04:57:53.072174) ========= ========= Total master_lag: 0.18 =========