builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0206 starttime: 1474601601.99 results: success (0) buildid: 20160922181301 builduid: ee896b42b8024fc0b0a30f713c843b25 revision: 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:21.997670) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:21.998227) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:21.998503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:22.025134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:22.025501) ========= 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.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-22 20:33:22-- 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% 150M=0s 2016-09-22 20:33:22 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.605639 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:22.675058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:22.675390) ========= 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.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.026924 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:22.724966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-22 20:33:22.725317) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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-22 20:33:22,810 truncating revision to first 12 chars 2016-09-22 20:33:22,810 Setting DEBUG logging. 2016-09-22 20:33:22,810 attempt 1/10 2016-09-22 20:33:22,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3b9eb7fee10b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 20:33:25,115 unpacking tar archive at: autoland-3b9eb7fee10b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.563254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-22 20:33:25.309274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:25.309601) ========= script_repo_revision: 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:25.310059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:25.310332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 20:33:25.329464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-22 20:33:25.329880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:33:25 INFO - MultiFileLogger online at 20160922 20:33:25 in /builds/slave/test 20:33:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 20:33:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:33:25 INFO - {'append_to_log': False, 20:33:25 INFO - 'base_work_dir': '/builds/slave/test', 20:33:25 INFO - 'blob_upload_branch': 'Autoland', 20:33:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:33:25 INFO - 'branch': 'Autoland', 20:33:25 INFO - 'buildbot_json_path': 'buildprops.json', 20:33:25 INFO - 'config_files': ('talos/mac_config.py',), 20:33:25 INFO - 'default_actions': ('clobber', 20:33:25 INFO - 'read-buildbot-config', 20:33:25 INFO - 'download-and-extract', 20:33:25 INFO - 'populate-webroot', 20:33:25 INFO - 'create-virtualenv', 20:33:25 INFO - 'install', 20:33:25 INFO - 'run-tests'), 20:33:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:33:25 INFO - 'download_minidump_stackwalk': True, 20:33:25 INFO - 'download_symbols': 'ondemand', 20:33:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:33:25 INFO - 'tooltool.py': '/tools/tooltool.py', 20:33:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:33:25 INFO - '/tools/misc-python/virtualenv.py')}, 20:33:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:33:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:33:25 INFO - 'installer_path': 'installer.exe', 20:33:25 INFO - 'log_level': 'info', 20:33:25 INFO - 'log_name': 'talos', 20:33:25 INFO - 'log_to_console': True, 20:33:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:33:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:33:25 INFO - 'opt_config_files': (), 20:33:25 INFO - 'pip_index': False, 20:33:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:33:25 INFO - 'cmd': ('bash', 20:33:25 INFO - '-c', 20:33:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:33:25 INFO - 'enabled': True, 20:33:25 INFO - 'halt_on_failure': False, 20:33:25 INFO - 'name': 'check_screen_resolution'},), 20:33:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:33:25 INFO - 'cmd': ('bash', 20:33:25 INFO - '-c', 20:33:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:33:25 INFO - 'enabled': True, 20:33:25 INFO - 'halt_on_failure': False, 20:33:25 INFO - 'name': 'check_screen_resolution'},), 20:33:25 INFO - 'run_cmd_checks_enabled': True, 20:33:25 INFO - 'sps_profile': False, 20:33:25 INFO - 'sps_profile_interval': 0, 20:33:25 INFO - 'suite': 'dromaeojs-e10s', 20:33:25 INFO - 'system_bits': '32', 20:33:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:33:25 INFO - 'title': 't-yosemite-r7-0206', 20:33:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:33:25 INFO - 'use_talos_json': True, 20:33:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:33:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:33:25 INFO - 'work_dir': 'build'} 20:33:25 INFO - [mozharness: 2016-09-23 03:33:25.516501Z] Running clobber step. 20:33:25 INFO - Running pre-action listener: _resource_record_pre_action 20:33:25 INFO - Running main action method: clobber 20:33:25 INFO - rmtree: /builds/slave/test/build 20:33:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:33:27 INFO - Running post-action listener: _resource_record_post_action 20:33:27 INFO - [mozharness: 2016-09-23 03:33:27.671710Z] Finished clobber step (success) 20:33:27 INFO - [mozharness: 2016-09-23 03:33:27.671866Z] Running read-buildbot-config step. 20:33:27 INFO - Running pre-action listener: _resource_record_pre_action 20:33:27 INFO - Running main action method: read_buildbot_config 20:33:27 INFO - Using buildbot properties: 20:33:27 INFO - { 20:33:27 INFO - "project": "", 20:33:27 INFO - "product": "firefox", 20:33:27 INFO - "script_repo_revision": "production", 20:33:27 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 20:33:27 INFO - "repository": "", 20:33:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 20:33:27 INFO - "buildid": "20160922181301", 20:33:27 INFO - "pgo_build": "False", 20:33:27 INFO - "basedir": "/builds/slave/test", 20:33:27 INFO - "buildnumber": 155, 20:33:27 INFO - "slavename": "t-yosemite-r7-0206", 20:33:27 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:33:27 INFO - "platform": "yosemite_r7", 20:33:27 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 20:33:27 INFO - "branch": "autoland", 20:33:27 INFO - "repo_path": "integration/autoland", 20:33:27 INFO - "revision": "3b9eb7fee10b7ceca0373c3fa886ddb5165b2797", 20:33:27 INFO - "stage_platform": "macosx64", 20:33:27 INFO - "builduid": "ee896b42b8024fc0b0a30f713c843b25", 20:33:27 INFO - "slavebuilddir": "test" 20:33:27 INFO - } 20:33:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:33:27 INFO - Running post-action listener: _resource_record_post_action 20:33:27 INFO - [mozharness: 2016-09-23 03:33:27.676816Z] Finished read-buildbot-config step (success) 20:33:27 INFO - [mozharness: 2016-09-23 03:33:27.676990Z] Running download-and-extract step. 20:33:27 INFO - Running pre-action listener: _resource_record_pre_action 20:33:27 INFO - Running main action method: download_and_extract 20:33:27 INFO - mkdir: /builds/slave/test/build/tests 20:33:27 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')]} 20:33:27 INFO - trying https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:33:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/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 20:33:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/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 20:33:29 INFO - Downloaded 1199 bytes. 20:33:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:33:29 INFO - Using the following test package requirements: 20:33:29 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:33:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:33:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:33:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'jsshell-mac.zip'], 20:33:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:33:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:33:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:33:29 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:33:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:33:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:33:29 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:33:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:33:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:33:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:33:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:33:29 INFO - Expected file size: 16433068 20:33:36 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 20:33:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:33:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:33:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:33:37 INFO - Expected file size: 16433068 20:33:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:33:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:33:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:33:45 INFO - Expected file size: 14414059 20:33:47 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')]} 20:33:47 INFO - trying https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:33:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:33:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/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 20:33:54 INFO - Downloaded 111427657 bytes. 20:33:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:33:54 INFO - mkdir: /builds/slave/test/properties 20:33:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:33:54 INFO - Writing to file /builds/slave/test/properties/build_url 20:33:54 INFO - Contents: 20:33:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:33:54 INFO - Running post-action listener: _resource_record_post_action 20:33:54 INFO - Running post-action listener: set_extra_try_arguments 20:33:54 INFO - [mozharness: 2016-09-23 03:33:54.694169Z] Finished download-and-extract step (success) 20:33:54 INFO - [mozharness: 2016-09-23 03:33:54.694287Z] Running populate-webroot step. 20:33:54 INFO - Running pre-action listener: _resource_record_pre_action 20:33:54 INFO - Running main action method: populate_webroot 20:33:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:33:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:33:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:33:54 INFO - '--tppagecycles', 20:33:54 INFO - '7'], 20:33:54 INFO - 'tests': ['tsvgm']}}, 20:33:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:33:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:33:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:33:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:33:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:33:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['damp', 'tps']}, 20:33:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'tests': ['damp', 'tps']}, 20:33:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['dromaeo_dom']}, 20:33:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:33:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['basic_compositor_video']}, 20:33:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:33:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'other-e10s': {'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['a11yr', 20:33:54 INFO - 'ts_paint', 20:33:54 INFO - 'tpaint', 20:33:54 INFO - 'sessionrestore', 20:33:54 INFO - 'sessionrestore_no_auto_restore', 20:33:54 INFO - 'tabpaint']}, 20:33:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['tsvgx', 20:33:54 INFO - 'tsvgr_opacity', 20:33:54 INFO - 'tart', 20:33:54 INFO - 'tscrollx', 20:33:54 INFO - 'cart']}, 20:33:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:33:54 INFO - 'tsvgr_opacity', 20:33:54 INFO - 'tart', 20:33:54 INFO - 'tscrollx', 20:33:54 INFO - 'cart']}, 20:33:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'talos_options': ['--disable-e10s'], 20:33:54 INFO - 'tests': ['tp5o']}, 20:33:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'tests': ['tp5o']}, 20:33:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'talos_options': ['--disable-e10s', 20:33:54 INFO - '--xperf_path', 20:33:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:54 INFO - 'tests': ['tp5n']}, 20:33:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:33:54 INFO - 'talos_options': ['--xperf_path', 20:33:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:33:54 INFO - 'tests': ['tp5n']}}, 20:33:54 INFO - 'talos.zip': {'path': '', 20:33:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:33:54 INFO - Running post-action listener: _resource_record_post_action 20:33:54 INFO - [mozharness: 2016-09-23 03:33:54.712686Z] Finished populate-webroot step (success) 20:33:54 INFO - [mozharness: 2016-09-23 03:33:54.712831Z] Running create-virtualenv step. 20:33:54 INFO - Running pre-action listener: _resource_record_pre_action 20:33:54 INFO - Running main action method: create_virtualenv 20:33:54 INFO - Creating virtualenv /builds/slave/test/build/venv 20:33:54 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 20:33:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:33:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:33:54 INFO - Using real prefix '/tools/python27' 20:33:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:33:55 INFO - Installing distribute.............................................................................................................................................................................................done. 20:33:58 INFO - Installing pip.................done. 20:33:58 INFO - Return code: 0 20:33:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:33:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:33:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:33:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:33:58 INFO - 'HOME': '/Users/cltbld', 20:33:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:33:58 INFO - 'LOGNAME': 'cltbld', 20:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:58 INFO - 'MOZ_NO_REMOTE': '1', 20:33:58 INFO - 'NO_EM_RESTART': '1', 20:33:58 INFO - 'PAGER': '/bin/cat', 20:33:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:58 INFO - 'PWD': '/builds/slave/test', 20:33:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:33:58 INFO - 'SHELL': '/bin/bash', 20:33:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:33:58 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:33:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:33:58 INFO - 'USER': 'cltbld', 20:33:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:33:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:58 INFO - 'XPC_FLAGS': '0x0', 20:33:58 INFO - 'XPC_SERVICE_NAME': '0', 20:33:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:58 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 20:33:58 INFO - Cleaning up... 20:33:58 INFO - Return code: 0 20:33:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:33:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:33:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:33:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:33:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:33:58 INFO - 'HOME': '/Users/cltbld', 20:33:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:33:58 INFO - 'LOGNAME': 'cltbld', 20:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:58 INFO - 'MOZ_NO_REMOTE': '1', 20:33:58 INFO - 'NO_EM_RESTART': '1', 20:33:58 INFO - 'PAGER': '/bin/cat', 20:33:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:58 INFO - 'PWD': '/builds/slave/test', 20:33:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:33:58 INFO - 'SHELL': '/bin/bash', 20:33:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:33:58 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:33:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:33:58 INFO - 'USER': 'cltbld', 20:33:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:33:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:58 INFO - 'XPC_FLAGS': '0x0', 20:33:58 INFO - 'XPC_SERVICE_NAME': '0', 20:33:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:33:58 INFO - Downloading/unpacking psutil>=3.1.1 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:33:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:33:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:34:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:02 INFO - Installing collected packages: psutil 20:34:02 INFO - Running setup.py install for psutil 20:34:02 INFO - building 'psutil._psutil_osx' extension 20:34:02 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 20:34:03 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 20:34:03 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 20:34:03 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 20:34:03 INFO - building 'psutil._psutil_posix' extension 20:34:03 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 20:34:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:34:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:34:03 INFO - ^ 20:34:03 INFO - 1 warning generated. 20:34:03 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 20:34:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:34:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:34:03 INFO - Successfully installed psutil 20:34:03 INFO - Cleaning up... 20:34:04 INFO - Return code: 0 20:34:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:34:04 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')]} 20:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:04 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')]} 20:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:04 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:04 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 20:34:04 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 20:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:04 INFO - 'HOME': '/Users/cltbld', 20:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:04 INFO - 'LOGNAME': 'cltbld', 20:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:04 INFO - 'MOZ_NO_REMOTE': '1', 20:34:04 INFO - 'NO_EM_RESTART': '1', 20:34:04 INFO - 'PAGER': '/bin/cat', 20:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:04 INFO - 'PWD': '/builds/slave/test', 20:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:04 INFO - 'SHELL': '/bin/bash', 20:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:04 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:04 INFO - 'USER': 'cltbld', 20:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:04 INFO - 'XPC_FLAGS': '0x0', 20:34:04 INFO - 'XPC_SERVICE_NAME': '0', 20:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:34:04 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 20:34:04 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 20:34:04 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 20:34:04 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 20:34:04 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 20:34:04 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 20:34:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:34:06 INFO - Installing collected packages: mozsystemmonitor 20:34:06 INFO - Running setup.py install for mozsystemmonitor 20:34:06 INFO - Successfully installed mozsystemmonitor 20:34:06 INFO - Cleaning up... 20:34:07 INFO - Return code: 0 20:34:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:07 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:07 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 20:34:07 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 20:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:07 INFO - 'HOME': '/Users/cltbld', 20:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:07 INFO - 'LOGNAME': 'cltbld', 20:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:07 INFO - 'MOZ_NO_REMOTE': '1', 20:34:07 INFO - 'NO_EM_RESTART': '1', 20:34:07 INFO - 'PAGER': '/bin/cat', 20:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:07 INFO - 'PWD': '/builds/slave/test', 20:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:07 INFO - 'SHELL': '/bin/bash', 20:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:07 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:07 INFO - 'USER': 'cltbld', 20:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:07 INFO - 'XPC_FLAGS': '0x0', 20:34:07 INFO - 'XPC_SERVICE_NAME': '0', 20:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:07 INFO - Downloading/unpacking jsonschema==2.5.1 20:34:07 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 20:34:07 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 20:34:07 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 20:34:07 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 20:34:07 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 20:34:07 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 20:34:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:34:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:34:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:34:10 INFO - warning: no files found matching '*.txt' 20:34:10 INFO - no previously-included directories found matching 'build' 20:34:10 INFO - no previously-included directories found matching 'dist' 20:34:10 INFO - no previously-included directories found matching '.git*' 20:34:10 INFO - Installing collected packages: jsonschema, functools32 20:34:10 INFO - Running setup.py install for functools32 20:34:10 INFO - warning: no files found matching '*.txt' 20:34:10 INFO - no previously-included directories found matching 'build' 20:34:10 INFO - no previously-included directories found matching 'dist' 20:34:10 INFO - no previously-included directories found matching '.git*' 20:34:10 INFO - Successfully installed jsonschema functools32 20:34:10 INFO - Cleaning up... 20:34:10 INFO - Return code: 0 20:34:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:10 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:10 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 20:34:10 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 20:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:10 INFO - 'HOME': '/Users/cltbld', 20:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:10 INFO - 'LOGNAME': 'cltbld', 20:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:10 INFO - 'MOZ_NO_REMOTE': '1', 20:34:10 INFO - 'NO_EM_RESTART': '1', 20:34:10 INFO - 'PAGER': '/bin/cat', 20:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:10 INFO - 'PWD': '/builds/slave/test', 20:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:10 INFO - 'SHELL': '/bin/bash', 20:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:10 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:10 INFO - 'USER': 'cltbld', 20:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:10 INFO - 'XPC_FLAGS': '0x0', 20:34:10 INFO - 'XPC_SERVICE_NAME': '0', 20:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:34:10 INFO - Cleaning up... 20:34:10 INFO - Return code: 0 20:34:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:10 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:10 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 20:34:10 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 20:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:10 INFO - 'HOME': '/Users/cltbld', 20:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:10 INFO - 'LOGNAME': 'cltbld', 20:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:10 INFO - 'MOZ_NO_REMOTE': '1', 20:34:10 INFO - 'NO_EM_RESTART': '1', 20:34:10 INFO - 'PAGER': '/bin/cat', 20:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:10 INFO - 'PWD': '/builds/slave/test', 20:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:10 INFO - 'SHELL': '/bin/bash', 20:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:10 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:10 INFO - 'USER': 'cltbld', 20:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:10 INFO - 'XPC_FLAGS': '0x0', 20:34:10 INFO - 'XPC_SERVICE_NAME': '0', 20:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:11 INFO - Downloading/unpacking blobuploader==1.2.4 20:34:11 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 20:34:11 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 20:34:11 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 20:34:11 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 20:34:11 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 20:34:11 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 20:34:13 INFO - Downloading blobuploader-1.2.4.tar.gz 20:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:34:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:34:13 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 20:34:13 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 20:34:13 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 20:34:13 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 20:34:13 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 20:34:13 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 20:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:34:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34: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 20:34:14 INFO - Downloading docopt-0.6.1.tar.gz 20:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:34:15 INFO - Installing collected packages: blobuploader, requests, docopt 20:34:15 INFO - Running setup.py install for blobuploader 20:34:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:34:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:34:15 INFO - Running setup.py install for requests 20:34:15 INFO - Running setup.py install for docopt 20:34:15 INFO - Successfully installed blobuploader requests docopt 20:34:15 INFO - Cleaning up... 20:34:15 INFO - Return code: 0 20:34:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34:15 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')]} 20:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:15 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')]} 20:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:15 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:15 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 20:34:15 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 20:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:15 INFO - 'HOME': '/Users/cltbld', 20:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:15 INFO - 'LOGNAME': 'cltbld', 20:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:15 INFO - 'MOZ_NO_REMOTE': '1', 20:34:15 INFO - 'NO_EM_RESTART': '1', 20:34:15 INFO - 'PAGER': '/bin/cat', 20:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:15 INFO - 'PWD': '/builds/slave/test', 20:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:15 INFO - 'SHELL': '/bin/bash', 20:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:15 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:15 INFO - 'USER': 'cltbld', 20:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:15 INFO - 'XPC_FLAGS': '0x0', 20:34:15 INFO - 'XPC_SERVICE_NAME': '0', 20:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-qF4MvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-87nocb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-H_vuP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-xDt7Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Ap_sn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-5bf92w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ZCfeMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:16 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-sBDkuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-_8v8y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-qfc_Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ra38GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-hpkodp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-Gv6b2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-R5NVMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-13jhhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-trygCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:17 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-XRJkkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:34:18 INFO - Running setup.py install for manifestparser 20:34:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:34:18 INFO - Running setup.py install for mozcrash 20:34:18 INFO - Running setup.py install for mozdebug 20:34:18 INFO - Running setup.py install for mozdevice 20:34:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:34:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:34:18 INFO - Running setup.py install for mozfile 20:34:18 INFO - Running setup.py install for mozhttpd 20:34:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:34:18 INFO - Running setup.py install for mozinfo 20:34:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Running setup.py install for mozInstall 20:34:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Running setup.py install for mozleak 20:34:19 INFO - Running setup.py install for mozlog 20:34:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Running setup.py install for moznetwork 20:34:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Running setup.py install for mozprocess 20:34:19 INFO - Running setup.py install for mozprofile 20:34:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:34:19 INFO - Running setup.py install for mozrunner 20:34:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:34:20 INFO - Running setup.py install for mozscreenshot 20:34:20 INFO - Running setup.py install for moztest 20:34:20 INFO - Running setup.py install for mozversion 20:34:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:34:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:34:20 INFO - Cleaning up... 20:34:20 INFO - Return code: 0 20:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:20 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:20 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 20:34:20 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 20:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:20 INFO - 'HOME': '/Users/cltbld', 20:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:20 INFO - 'LOGNAME': 'cltbld', 20:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:20 INFO - 'MOZ_NO_REMOTE': '1', 20:34:20 INFO - 'NO_EM_RESTART': '1', 20:34:20 INFO - 'PAGER': '/bin/cat', 20:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:20 INFO - 'PWD': '/builds/slave/test', 20:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:20 INFO - 'SHELL': '/bin/bash', 20:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:20 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:20 INFO - 'USER': 'cltbld', 20:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:20 INFO - 'XPC_FLAGS': '0x0', 20:34:20 INFO - 'XPC_SERVICE_NAME': '0', 20:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:34:20 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-HZl2Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:34:20 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)) 20:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:34:20 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-qmwbKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-STnFW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-jMYDxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-wgd4Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-8rJqnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-9Tf5h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-HchsRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-1OppoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ViotM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:34:21 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)) 20:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:34:21 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-UGwJh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ye9dtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-p94DvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-0ikVAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ADaano-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-ofv5hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:34:22 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)) 20:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:34:22 INFO - Running setup.py (path:/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/pip-5QSmnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:34:22 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)) 20:34:22 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)) 20:34:22 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)) 20:34:22 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)) 20:34:22 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)) 20:34:22 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)) 20:34:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:34:25 INFO - Downloading blessings-1.6.tar.gz 20:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:34:25 INFO - Installing collected packages: blessings 20:34:25 INFO - Running setup.py install for blessings 20:34:25 INFO - Successfully installed blessings 20:34:25 INFO - Cleaning up... 20:34:25 INFO - Return code: 0 20:34:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:25 INFO - Reading from file tmpfile_stdout 20:34:25 INFO - Current package versions: 20:34:25 INFO - blessings == 1.6 20:34:25 INFO - blobuploader == 1.2.4 20:34:25 INFO - docopt == 0.6.1 20:34:25 INFO - functools32 == 3.2.3-2 20:34:25 INFO - jsonschema == 2.5.1 20:34:25 INFO - manifestparser == 1.1 20:34:25 INFO - mozInstall == 1.12 20:34:25 INFO - mozcrash == 0.17 20:34:25 INFO - mozdebug == 0.1 20:34:25 INFO - mozdevice == 0.48 20:34:25 INFO - mozfile == 1.2 20:34:25 INFO - mozhttpd == 0.7 20:34:25 INFO - mozinfo == 0.9 20:34:25 INFO - mozleak == 0.1 20:34:25 INFO - mozlog == 3.4 20:34:25 INFO - moznetwork == 0.27 20:34:25 INFO - mozprocess == 0.23 20:34:25 INFO - mozprofile == 0.28 20:34:25 INFO - mozrunner == 6.12 20:34:25 INFO - mozscreenshot == 0.1 20:34:25 INFO - mozsystemmonitor == 0.3 20:34:25 INFO - moztest == 0.7 20:34:25 INFO - mozversion == 1.4 20:34:25 INFO - psutil == 3.1.1 20:34:25 INFO - requests == 1.2.3 20:34:25 INFO - wsgiref == 0.1.2 20:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:25 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 20:34:25 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 20:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:25 INFO - 'HOME': '/Users/cltbld', 20:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PAGER': '/bin/cat', 20:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:25 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:25 INFO - 'XPC_FLAGS': '0x0', 20:34:25 INFO - 'XPC_SERVICE_NAME': '0', 20:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 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)) 20:34:25 INFO - Cleaning up... 20:34:25 INFO - Return code: 0 20:34:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:34: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')]} 20:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34: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')]} 20:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:34:25 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 0x10a60b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a581570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feffb4c87e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, '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.xXiYfx3wSW/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.jE962DHFbJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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 20:34:25 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 20:34:25 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 20:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:34:25 INFO - 'HOME': '/Users/cltbld', 20:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:34:25 INFO - 'LOGNAME': 'cltbld', 20:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:34:25 INFO - 'MOZ_NO_REMOTE': '1', 20:34:25 INFO - 'NO_EM_RESTART': '1', 20:34:25 INFO - 'PAGER': '/bin/cat', 20:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:34:25 INFO - 'PWD': '/builds/slave/test', 20:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:34:25 INFO - 'SHELL': '/bin/bash', 20:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:34:25 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:34:25 INFO - 'USER': 'cltbld', 20:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:34:26 INFO - 'XPC_FLAGS': '0x0', 20:34:26 INFO - 'XPC_SERVICE_NAME': '0', 20:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:34:26 INFO - Cleaning up... 20:34:26 INFO - Return code: 0 20:34:26 INFO - Running post-action listener: _resource_record_post_action 20:34:26 INFO - Running post-action listener: _start_resource_monitoring 20:34:26 INFO - Starting resource monitoring. 20:34:26 INFO - [mozharness: 2016-09-23 03:34:26.283978Z] Finished create-virtualenv step (success) 20:34:26 INFO - [mozharness: 2016-09-23 03:34:26.284958Z] Running install step. 20:34:26 INFO - Running pre-action listener: _resource_record_pre_action 20:34:26 INFO - Running main action method: install 20:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:34:26 INFO - Reading from file tmpfile_stdout 20:34:26 INFO - Detecting whether we're running mozinstall >=1.0... 20:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:34:26 INFO - Reading from file tmpfile_stdout 20:34:26 INFO - Output received: 20:34:26 INFO - Usage: mozinstall [options] installer 20:34:26 INFO - Options: 20:34:26 INFO - -h, --help show this help message and exit 20:34:26 INFO - -d DEST, --destination=DEST 20:34:26 INFO - Directory to install application into. [default: 20:34:26 INFO - "/builds/slave/test"] 20:34:26 INFO - --app=APP Application being installed. [default: firefox] 20:34:26 INFO - mkdir: /builds/slave/test/build/application 20:34:26 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'] 20:34:26 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 20:35:01 INFO - Reading from file tmpfile_stdout 20:35:01 INFO - Output received: 20:35:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:35:01 INFO - Running post-action listener: _resource_record_post_action 20:35:01 INFO - [mozharness: 2016-09-23 03:35:01.297472Z] Finished install step (success) 20:35:01 INFO - [mozharness: 2016-09-23 03:35:01.297595Z] Running run-tests step. 20:35:01 INFO - Running pre-action listener: _resource_record_pre_action 20:35:01 INFO - Running main action method: run_tests 20:35:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:35:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:35:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:35:01 INFO - 2016-09-22 20:35:01.310 screenresolution[1654:8355] starting screenresolution argv=screenresolution get 20:35:01 INFO - 2016-09-22 20:35:01.313 screenresolution[1654:8355] Display 0: 1600x1200x32@60 20:35:01 INFO - 2016-09-22 20:35:01.318 screenresolution[1655:8357] starting screenresolution argv=screenresolution list 20:35:01 INFO - Available Modes on Display 0 20:35:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:35:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:35:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:35:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:35:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:35:01 INFO - Intel Iris: 20:35:01 INFO - Chipset Model: Intel Iris 20:35:01 INFO - Type: GPU 20:35:01 INFO - Bus: Built-In 20:35:01 INFO - VRAM (Dynamic, Max): 1536 MB 20:35:01 INFO - Vendor: Intel (0x8086) 20:35:01 INFO - Device ID: 0x0a2e 20:35:01 INFO - Revision ID: 0x0009 20:35:01 INFO - Displays: 20:35:01 INFO - Display: 20:35:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:35:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:35:01 INFO - Display Serial Number: 1600x1200 60 20:35:01 INFO - Main Display: Yes 20:35:01 INFO - Mirror: Off 20:35:01 INFO - Online: Yes 20:35:01 INFO - Rotation: Supported 20:35:01 INFO - Return code: 0 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:35:01 INFO - Python 2.7.3 20:35:01 INFO - Return code: 0 20:35:01 INFO - grabbing minidump binary from tooltool 20:35: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')]} 20:35:01 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 0x10a41fd30>, '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 0x10a245db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a417b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:35:01 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 20:35:01 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 20:35:01 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 20:35:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:35:01 INFO - Return code: 0 20:35:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:35:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:35:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 20:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0206 --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 20:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXiYfx3wSW/Render', 20:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:35:01 INFO - 'HOME': '/Users/cltbld', 20:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:35:01 INFO - 'LOGNAME': 'cltbld', 20:35:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:35:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:01 INFO - 'MOZ_NO_REMOTE': '1', 20:35:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:35:01 INFO - 'NO_EM_RESTART': '1', 20:35:01 INFO - 'PAGER': '/bin/cat', 20:35:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:01 INFO - 'PWD': '/builds/slave/test', 20:35:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:35:01 INFO - 'SHELL': '/bin/bash', 20:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jE962DHFbJ/Listeners', 20:35:01 INFO - 'TMPDIR': '/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/', 20:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:35:01 INFO - 'USER': 'cltbld', 20:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:01 INFO - 'XPC_FLAGS': '0x0', 20:35:01 INFO - 'XPC_SERVICE_NAME': '0', 20:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:35:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0206', '--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 20:35:01 INFO - mozversion application_buildid: 20160922181301 20:35:01 INFO - mozversion application_changeset: 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 20:35:01 INFO - mozversion application_display_name: Nightly 20:35:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:35:01 INFO - mozversion application_name: Firefox 20:35:01 INFO - mozversion application_remotingname: firefox 20:35:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:35:01 INFO - mozversion application_vendor: Mozilla 20:35:01 INFO - mozversion application_version: 52.0a1 20:35:01 INFO - mozversion platform_buildid: 20160922181301 20:35:01 INFO - mozversion platform_changeset: 3b9eb7fee10b7ceca0373c3fa886ddb5165b2797 20:35:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:35:01 INFO - mozversion platform_version: 52.0a1 20:35:01 INFO - using testdate: 1474601701 20:35:01 INFO - actual date: 1474601701 20:35:01 INFO - starting webserver on 'localhost:49272' 20:35:01 INFO - SUITE-START | Running 2 tests 20:35:01 INFO - TEST-START | dromaeo_css 20:35:01 INFO - operating with platform_type : mac_ 20:35:01 INFO - Initialising browser for dromaeo_css test... 20:35:01 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpESzb4B/profile http://localhost:49272/getInfo.html) 20:35:04 INFO - PROCESS | 1665 | 2016-09-22 20:35:04.777 plugin-container[1668:8533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 20:35:04 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:35:04 INFO - PROCESS | 1665 | 2016-09-22 20:35:04.780 plugin-container[1668:8533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 20:35:04 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:35:04 INFO - PROCESS | 1665 | 2016-09-22 20:35:04.780 plugin-container[1668:8533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:35:04 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 20:35:04 INFO - PROCESS | 1665 | colorDepth:24 20:35:04 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 20:35:04 INFO - PROCESS | 1665 | __metrics 20:35:04 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 20:35:05 INFO - TEST-INFO | 1665: exit 0 20:35:05 INFO - Browser initialized. 20:35:05 INFO - Running cycle 1/1 for dromaeo_css test... 20:35:05 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpESzb4B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:35:07 INFO - PROCESS | 1669 | 2016-09-22 20:35:07.840 plugin-container[1670:8646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4613, name = 'com.apple.tsm.portname' 20:35:07 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:35:07 INFO - PROCESS | 1669 | 2016-09-22 20:35:07.842 plugin-container[1670:8646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 20:35:07 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:35:07 INFO - PROCESS | 1669 | 2016-09-22 20:35:07.842 plugin-container[1670:8646] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:35:17 INFO - PROCESS | 1669 | RSS: Main: 239620096 20:35:17 INFO - PROCESS | 1669 | 20:36:07 INFO - PROCESS | 1669 | 1474601767201 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] 20:38:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 20:38:20 INFO - PROCESS | 1669 | RSS: Main: 255737856 20:38:20 INFO - PROCESS | 1669 | 20:41:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 20:41:23 INFO - PROCESS | 1669 | RSS: Main: 268779520 20:41:23 INFO - PROCESS | 1669 | 20:44:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 20:44:26 INFO - PROCESS | 1669 | RSS: Main: 270176256 20:44:26 INFO - PROCESS | 1669 | 20:47:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 20:47:28 INFO - PROCESS | 1669 | RSS: Main: 269828096 20:47:28 INFO - PROCESS | 1669 | 20:50:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 20:50:32 INFO - PROCESS | 1669 | RSS: Main: 275185664 20:50:32 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 20:53:35 INFO - PROCESS | 1669 | RSS: Main: 277999616 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | __start_tp_report 20:53:35 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 20:53:35 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 20:53:35 INFO - PROCESS | 1669 | |i|pagename|runs| 20:53:35 INFO - PROCESS | 1669 | |0;dojo.html;3440.294739578388;3471.722262219023;3473.6179020307777;3499.9325205812233;3503.859845606175;5772.682502462363;5867.413258674136;5916.408359164081;5968.552358573108;5972.79095231667;5814.883702325951;5896.616719913202;5924.999999999989;5940.34656187819;6053.697315134236;5239.607029472795;5368.91946620801;5381.730913454331;5406.91889621654;5427.185922111695;5313.73431328434;5421.159720243369;5466.1527463243265;5468.72656367182;5534.418886016971;5241.240020197089;5278.762455689464;5295.655782374133;5316.654417462892;5331.493508116722;5304.443033481506;5323.653962492425;5338.492843179892;5386.8922621547745;5421.457854214547;5261.6842989420375;5300.867478313035;5309.654872433318;5347.652402593819;5381.408045115034;5812.796552120655;5879.67661778602;5943.465088142088;5958.40415958405;5993.370696076893;6170.2941570990815;6266.091416744546;6268.059791031336;6271.404216599416;6286.528510361742;6294.339094395114;6320.209973753281;6326.93673063268;6327.683615819236;6327.987521996459;5825.475707186373;5899.793507227269;5961.314448838352;5969.641821490724;5993.280806303184;6469.45009674183;6488.67556622167;6502.804915852532;6518.674066296761;6520.989246666774;6239.001759718423;6239.688015599202;6281.780137695158;6282.151909492251;6292.4966002720585;6163.784267550704;6224.9377506224355;6249.187605611241;6282.560220784592;6332.873342533124;6223.284322302902;6250.624962502174;6283.937160628427;6288.937110628926;6322.652254125976;5007.9499205008215;6232.875342493125;6236.345183755731;6251.6561589112125;6296.716647750863;4889.48660390661;4994.600431965507;5016.172331565251;5028.472010438924;5032.421271553745;4465.285554311295;4476.328550717353;4481.551844815557;4570.154521413549;4605.309203619484;5762.567807414461;5994.37059108796;6041.848953776191;6062.393760623902;6072.392760723892;4762.357081793983;5473.261109750133;6339.841503962438;6362.109304697254;6372.522060845455;5008.84973450797;5714.885597308568;6003.429674181033;6062.454379105813;6124.877502449926;4854.368932038812;4861.51384861511;5265.183896496049;5561.63849349791;5572.60991730575;6354.4916406686425;6504.1869766279215;6562.573432726953;6568.8357791055605;6588.538802283986;5219.765110569958;6215.471684906653;6240.7503699851495;6254.249490061222;6328.335524770017;6484.967575162094;6485.3514648534765;6506.284308726131;6509.153810004669;6525.543211975116;5129.487051294841;6162.476189523941;6190.969045154746;6236.968815155895;6284.24589049317;6140.5701600887505;6221.9377806223165;6307.96846015767;6330.272018717907;6339.492840572835;6164.198654174928;6249.187605611241;6276.215473065867;6278.089676996901;6282.277538082996;6102.09542342839;6138.204480310071;6232.750689972531;6253.280872699698;6260.280067792262;6033.12519684652;6124.265088189446;6146.139540464249;6182.165407669907;6185;6209.348018458178;6224.751009959732;6246.562740608296;6258.499320054476;6302.369763023661;6135.447809697149;6169.938300617116;6177.7837775677635;6212.254529456494;6217.285012223471 20:53:35 INFO - PROCESS | 1669 | |1;ext.html;466.27261472103515;482.59944246275575;494.68093079963427;527.9947200527994;533.4958464251282;39847.003824904394;40536.79731601341;42249.15501689964;42271.73184804453;42308.98064683858;42816.143677126514;43313;43315.7005289841;43459;43535.78232108843;9740.659076932308;9770.120689137977;9874.259430542703;9884.308098433112;9887.357321774098;9596.520173991308;9735.56189971453;9736.95131524345;9741.172000379976;9756.658516951908;9707.174890134313;9734.36726612768;9747.025297470233;9760.755981100494;9765.267604929659;9651.806963860754;9674.90325096747;9694.903050969471;9697.612095516171;9709.126178643884;9640.903590964072;9699.854502182472;9720.270979676552;9724.562394692255;9731.026897310283;39878;40504.39243411351;40569.98575035648;40641.79679101615;40961.1807763843;3363.428217203081;3378.712809411203;3389.610194827602;3404.2000129969438;3415.590129184514;30496.932607358634;30599.847000765076;31873.84063079693;31905.202369940704;31994.360112797614;2848.373357861288;3221.2752130770623;3223.435898717715;3310.784798988058;3311.7019468247972;401922;499107;499264;506738.46630766976;507080;61989.690051549456;62288.37711622826;62897.68551157215;62951.37048629547;63025.68487157535;34667.13332166716;35196.47205291872;35333;35918;65267.84151981003;11616.651500455;14037.73660370551;15607.219639018003;16008.359665613245;16128.032318060954;11130.33218006906;12947.158434701903;12954.287514186623;12959.416826242841;12989.480420783251;19346.7386557622;19450.33181612857;19536.952099868136;19543.84722423107;19623;6634.303398143222;7562.357199637982;7850.175731548219;7913.564753938474;7970.840583188304;761.7676608634309;847.2628812932788;999.5651891427107;1028.881678606955;1102.1183053557122;29813.254668633457;30388.69611303903;30935.845320773704;31003.379932401225;31127.84436077805;936.1995493852794;1020.8264595018865;1059.7191744187796;1089.7112265249716;1103.2994048779083;15161.545153645407;15629.296681649354;15818.971766835119;15833.129177895096;15948.76076858848;645617;649401;650393;651099;651950;53759.731201344526;56444.43555564474;56519.869602607716;56749.43250567441;56950.71524642433;1359.1573224600613;1366.5422083601907;1392.9442822286994;1396.322783450026;1397.3641992893208;28783.424331512833;29657.110286691433;29871.103866884027;30382.544261835646;30400.391992160476;49790;51028.489715102376;51572.48427515677;51818.48181518287;51894.481055190474;596729;597901;601458;601565;602029;26059.478810423305;26258.474830503666;26618.733812661627;26619.467610648066;26651.200463985337;45266.547334526236;46300.30549541692;46689;46730.29904551502;46857.531424685316;36590.63409365872;37309.81345093366;38986.80506597449;39909.60090399059;40178.799106004284;38334.42498362471;38480.80759596184;38490.422643660924;39580;39679.40480892731;32239.838800805846;37409.81295093507;37739.81130094332;38150.618493814705;38382;29379.412411752073;34393.140171495914;34881;35703.28593428169;36247.45628815517;25257.368565786004;25297.241082767545;25370.619440708037;25614.487710245317;25854 20:53:35 INFO - PROCESS | 1669 | |2;jquery.html;317.50469267942015;370.9369407200776;375.6938095452207;383.2545698616189;395.50956813551187;19681.803181968175;20685.896570517147;20817.375478735623;21498.355049348524;21628.89185554074;20090.49321300901;20248.493787655316;20632.69050964237;20730.689039664416;20828.583428331425;5019.799208031674;5903.173555702205;6065.150878876961;6094.268687757453;6159.23009623797;5914.9408505915035;5958.225430694004;6053.757849686007;6062.666553339564;6076.966915624333;5826.359100498942;5949.940500594982;5987.072003839412;5988.281406231258;6007.279126504825;5683.374828768832;5856.267966504187;5943.791967281146;5956.37458066901;6000.579959402844;4060.4112403701297;4406.779661016936;4407.911841763179;4471.731696098212;4548.431446069241;21274.46813829651;25359.746402536108;25544.872275638503;25585.48829023409;26154.215373538824;1824.4435447188603;2388.319328991229;2405.855648661086;2418.806495480357;3015.321552650658;14959.177245251507;15093.47172848956;15148;15174.848251517564;15479.845201547952;1788.97316540252;1829.8627602929832;1852.6387354465885;1905.9142338594797;1936.3762102351332;110561.89438105596;113524;113726.86273137246;113971;114507;9204.677836275698;10644;10764.3541387517;10964.232503724663;11602;13723.725525489433;13891.4443422264;13894.374753136133;13902.16587004783;13955.441782328593;8379.790505237417;8550.358723095793;8664.220220180088;8739.650413983496;8778.868316975251;8666;8710.303175745925;8710.782230444289;8821.514816685143;8877.33419993503;6553;6638.369354911276;6643.667816609151;6684.933150668431;6702.229243636946;1886.6792645250341;1902.3531999120366;1912.0917564156914;1912.8087191281038;1938.6138910678933;841.2428814067389;871.8561437362764;888.7467071884482;906.5603182456504;983.6966020023498;18061.819381806275;22157.44897857167;22241.77758222397;22248.66627000564;22390;931.8161455066837;947.6920000999703;949.5489642419795;975.4196253229317;1062.2404980439023;11419.828702569468;11737.295762254293;11904.2262252955;11924.761504769856;11994.700132496757;449557.75221123686;528555.2150153252;546196;549798;551037;111541;116488;132862.33568832095;135339.32330338482;135541.6445835529;951.3293128344501;988.7577543501889;992.1269283030887;997.2470784557613;1013.9290249682599;17199.312027518758;17252.396166134124;18617.720734189268;19137.808621913602;19842.60314793725;55582.72208638931;55797.44202557922;56551.71724141353;58287.54281143005;58443;70969;71981.6400917992;75125.62437187778;75322.24677753152;79327.20672793199;6610.2398224204835;7195.82010449722;7333.706651733871;7412.96293518529;7796.571188584682;10929.453527323443;12652.493900243888;12760.29818359999;12910.354482276036;13065.67335816574;10705.143588513056;10950.780984380108;10982;11014.504347304552;11378;7985.92014079875;10062.748431288983;10836.241463097824;10993.340399576051;11115;10454.895451045391;11005.954434328725;11135.220534562503;11202.38386888729;11483.36841473727;7196.136463624399;7389.298016688406;7445.032145821008;7481.326680598772;7590.924090759243;9340.065993400605;10772;11121.221514493907;11209.15931305139;11459.598914037968 20:53:35 INFO - PROCESS | 1669 | |3;mootools.html;1495.3196295685464;1562.0159299641225;1761.145844265531;1821.5446138465384;1860.962780744386;7995.880061799077;8244.628991695374;8371.121032291612;8946.597403116859;8998.19016288534;8382.87425688615;8678.91321086789;8703.825923481543;8781.64873405063;8791.516466594334;2331.8717470539113;2351.106579499796;2400.1599440195964;2405.915792947247;2409.6867407237037;1977.6143651987868;2267.7958983691465;2354.21133920137;2382.154335211001;2403.723571789249;2175.9347219583437;2285.074544809355;2339.181286549711;2397.9520409591796;2428.1865575032384;2060.9072591733407;2176.2927048709153;2389.784919357266;2398.8800559972105;2412.6501657259773;2014.5668681233458;2370.988145059281;2385.9642105368434;2387.9164229252065;2390.067873529325;8790.56047197644;8833.55832208387;8867.556622168866;8875.28997680184;8876.556172191365;5051.393832740058;5205.193195054772;5213.843584692465;5218.425973142951;5220.347456567929;3486.3724529584665;3542.8582856685703;3653.780773153619;3657.104009517685;3690.8708195213308;1031.2214278219972;1060.5916722061984;1069.8609180806445;1084.35480888871;1090.3185509056839;11507.712307192303;11556.53773849045;11675.241109327866;11678.124140689482;11688.415579221006;4583.702059366131;4654.581087702123;4825.30033145199;4827.8551643450755;4828.782704778293;8634.050254472004;9164.221041211438;9978.151857092229;9981.800363992825;10005.849912251322;5363.141897296414;5366;5366.463353664681;5369;5396.244525766396;4431.202383570923;4594.173048851172;4744.240921452551;4866.245731911559;4911.631627627942;3359.798412095282;3944.36890097583;3963.544192417909;4038.212548553004;4090.8159132839096;1299.2719682821823;1302.1470936536584;1302.8697130286896;1317.157019507516;1326.8540460549332;797.6928882380209;858.1761508951477;891.6879092317766;895.6238379880466;914.9176574108362;5501.559875209973;5608.355039170466;5706.172604972338;5901.527877769854;6051;424.3465063801711;441.1639942309306;442.3077883112918;445.09423323536447;920.2959735802117;4009.599040095967;4052.63526282636;4069.4302797608357;4150.460440142822;4169.833206671759;10213.387196768217;10556.47217639115;10582.523786429629;10741.301815381976;10814;9412.576434060484;10698.946505267424;10700.464976751287;10709.678709638723;10735.785284294427;6984.301569842975;8107.067687215927;8162.26539611426;8164.346852251806;8302.045264794506;5785.681787501728;5840.883182336414;5991.460768530853;5993.280806303272;6059.818205453844;9896.406215627085;10039.899601003897;10076.445795481319;10095.444750538498;10102.646407375707;9565.378250413702;9640.084192001748;9751.073648003428;9889.357191782512;10102.141317988053;6856.5200435969;7058.823529411806;7236.674349654383;7244;7497.137829149718;8229.012518497819;8241.423100382915;8363.038250601016;8422.747317580483;8422.789430264293;6907.896381554381;7401.925980740339;7487.438442116972;7496.437767167593;7546.735864244725;6705.932940670531;7160.749373771893;7301.196868344584;7305.525140865827;7398.075240594926;6495.707693153914;6914.757983470756;6991.161060672548;6998.440124790106;7015.088038554955;4020.6582440492884;4557.863264102082;4954.851354459372;5008.098542262428;5087.23691446286;3966.5636779954757;4613.284940834176;4663.953360466352;5088.643794934467;5124.128898087409 20:53:35 INFO - PROCESS | 1669 | |4;prototype.html;280.6085510712556;296.7403372682961;305.1395065914123;308.7545401405883;312.8639042016724;4723.07899959508;5130.127878260695;5195.922061169081;5733.770649174028;5759.510441612468;4927.827526036589;5479.657483916446;5600.247833951253;5620.241267428906;5693.259876216096;4074.592540745924;4106.096658735089;4167.770772607505;4215.220184265905;4226.809793559281;3662.487251784752;3728.6084961079105;3986.9003274918214;4196.3705444183315;4271.829126834923;3659.79871107089;4208.45290112285;4219.282721937278;4223.936640950388;4228.429162063128;3387.3902697514436;4089.734167279132;4189.324270291877;4204.306289462235;4214.304639734441;2978.731914127717;3592.2456284180353;3620.818959052037;3627.963720362789;3647.2705458908326;5432.565394768409;5450.672959622435;5466.262054622614;5468.56251499883;5513.696746678931;4042.5755295694116;4470.82116715331;4812.639052071074;4840.080384726926;4856.68431551948;4871.707697538159;5325.854941187663;5921.733521991478;5924.2381088009;5932.495737862287;3042.9653917668097;3599.046252743025;3935.527736671589;3952.367621180626;3974.364101743707;5912.881742365172;6259.593126446812;6303.747850085991;6311.053341998691;6328.936710632881;3046.4516387050544;3413.368526822546;3729.6083911188935;3777.660010599059;3991.401289806552;3190.7128358447853;3213.6304325002457;3681.9874534503224;3799.6200379961783;4034.5360283567766;4794.729396709875;4805.6155507559315;4818.253170758538;4820.132376172252;4834.540718631724;5105.540501354896;5572.331320241516;5942.61373010753;6015.30823955242;6048.667323297261;1271.1991445389347;1340.8458027326983;1366.2553908120099;1371.6296599917966;1394.7001394699985;726.6439444672178;793.5714714054461;852.3905407633448;854.6538651846013;857.5712143928037;4874.610031197496;5024.7689316117785;5254.632175747737;5370.254667233086;5488.945110548923;5835.67903765297;5987.6888640179;6154.415330543591;6166.81499555014;6205.47253483459;5328;5505.834824955257;5518.779248830082;5571.829915717663;5577.2191893135;2641.9207423777316;2801.173653772142;3086.2284428892776;3180.807197301012;3218.115018369967;5002.874928126826;5209.609279304067;5560.332760068818;5675.404082571271;5913.58604897653;5266.894662106736;5904.852378690567;5994.7602095916545;6185.2784774698985;6273.843153921189;5141.485851414904;6386.808395748228;6414.743410263631;6423.389777971085;6432.13166222554;5668.922904648269;5707.743151558107;5853.590318601125;6033.728482218398;6087.847803804941;4978.452370239198;5241.240020197126;5591.735347184397;6039.63762174271;6043.70896663374;4809.945684490443;5660.745266462936;5937.762489500545;6363.936360636334;6369.490440764635;3522.7005704514377;3989.401589761559;4009.1981603679965;4022.7586344818233;4044.988752811797;5172.741362931763;5854.419306787228;6106.664133472702;6201.286852012076;6202.534809889366;4808.807647694053;5295.391030031596;5396.704790850246;5544.641562817135;6007.759689612367;4702.717836929658;5991.970040149771;6013;6083.65019011409;6090.939090609215;5209.583233341248;5393.568514518751;5488.957098151339;5894.086416605433;5920.615160014585;5520.454272803621;5802.199559288672;5885.411458854081;5921.467067963904;5993.550483713651;5832.300123985149;5886.852063847508;5898.439648233411;5930.673812940329;5949.370883760816 20:53:35 INFO - PROCESS | 1669 | |5;yui.html;641.6310621392699;689.5345641691857;754.9660265288059;774.4617490843866;781.9374450043995;14753.852461475382;15900.681986360265;15993.440229591966;16018.19909004548;16032.198390080508;14141.646458838533;14418.639534011654;14522;14542.200178990151;14680.26598670065;834.9123342049088;837.8073043200068;850.4769566716456;853.0488505316558;856.4133568505563;677.2076670295742;697.6651207420441;854.3592305770673;860.9354298427612;861.4099341950783;866.4411454611771;892.7991201979568;894.5348418822208;897.2642433204742;900.2078171209326;871.376965469689;889.3996552327186;889.5241046040337;889.902110767815;891.8394688955952;664.3954001858334;665.5773583774289;665.6871270502855;665.9433948114367;666.3436515032689;14259.928700356431;14668.119912805267;14740.557783266519;14748;14758.188299643516;13656.24890631015;13660.316984150753;13690.315484225848;13745.175289482662;13937.024408291423;12542;12598.496060157582;12656.17734847232;12660.493580256778;12737.808932866015;4381.16757816014;4468.173387923212;4490.775461226958;4508;4689.20283551797;113010;114128.42935785351;114498.85501144965;114880.42559787148;115662;10691.893081069245;10789.46052697362;10845.945770271099;10927;10945.562177512811;21588.028538715796;21679.34961951144;21711.34865954024;21721.456963576038;21756.912154392216;7603.163651998276;7639.274268944441;7770.92229077702;7848.175941526058;7876.133625301212;4215.768132752728;4276.978615106967;4294.484661840536;4305.375720520507;4421.005273813366;3345.381104495676;3359.2441700617655;3426.5031570422148;3450.879219227315;3461.4115600348;543.2611648158502;648.3095503288982;654.6595770199469;673.4275865514273;718.1884470548351;560.1289994059196;563.2058797096075;587.6630665236621;632.8164832198611;687.6011913090396;8397.664093436317;8595.914040859636;8653.961524617087;9657.565409556586;9697.563609637584;638.7002450014198;678.281022116558;679.1815861886415;680.1701923653135;681.8295426143465;4273.9358909616385;4474.574915383034;4508.211063063951;4702.412198475191;4841.104395686809;94735.10529789365;95800.52099739596;147638.26180869027;154275;159169.2041539785;143157.56842431444;145254.27372863068;146700;147153.26423367814;149440;88022.55988720016;93694;119560;120020.99947501383;122248.38875805742;7717.459777815499;8765.123487651184;8788.42875213109;8895.154960278764;9129.680461183827;67804.32195678177;67962.66018669875;68432;69385;69977.65011174911;63518.36481635125;73188;99173.51239731266;100343.49828250812;102582;11675.502710437646;11747.177697561088;11831.70420739454;12005.39973001364;12020.579279725167;13048.739025219633;13100;13159.868401315864;13162.276074815594;13561.525346613216;8739;11446.542138314708;11894.92945634897;12097.092718046006;12127.151099422956;11038.944805275922;11591.95672389489;12000.459979300778;12079.51681932713;12405.503779849067;10788.298760580537;10862.891371086187;11752.706182345168;12132.211406258564;12160;8568.843206167088;8659.437136586102;9401.905980940102;9617.71146865595;9684.08001239881;7752.92247077522;8708.303335732999;9583.424994500074;9618.567164477756;9796.069373409515 20:53:35 INFO - PROCESS | 1669 | __end_tp_report 20:53:35 INFO - PROCESS | 1669 | __start_cc_report 20:53:35 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,373 20:53:35 INFO - PROCESS | 1669 | __end_cc_report 20:53:35 INFO - PROCESS | 1669 | __startTimestamp1474602815293__endTimestamp 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | ------- Summary: start ------- 20:53:35 INFO - PROCESS | 1669 | Number of tests: 6 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5833.67 Median:6124.88 stddev:659.57 (10.8%) stddev-sans-first:634.31 20:53:35 INFO - PROCESS | 1669 | Values: 3440.3 3471.7 3473.6 3499.9 3503.9 5772.7 5867.4 5916.4 5968.6 5972.8 5814.9 5896.6 5925.0 5940.3 6053.7 5239.6 5368.9 5381.7 5406.9 5427.2 5313.7 5421.2 5466.2 5468.7 5534.4 5241.2 5278.8 5295.7 5316.7 5331.5 5304.4 5323.7 5338.5 5386.9 5421.5 5261.7 5300.9 5309.7 5347.7 5381.4 5812.8 5879.7 5943.5 5958.4 5993.4 6170.3 6266.1 6268.1 6271.4 6286.5 6294.3 6320.2 6326.9 6327.7 6328.0 5825.5 5899.8 5961.3 5969.6 5993.3 6469.5 6488.7 6502.8 6518.7 6521.0 6239.0 6239.7 6281.8 6282.2 6292.5 6163.8 6224.9 6249.2 6282.6 6332.9 6223.3 6250.6 6283.9 6288.9 6322.7 5007.9 6232.9 6236.3 6251.7 6296.7 4889.5 4994.6 5016.2 5028.5 5032.4 4465.3 4476.3 4481.6 4570.2 4605.3 5762.6 5994.4 6041.8 6062.4 6072.4 4762.4 5473.3 6339.8 6362.1 6372.5 5008.8 5714.9 6003.4 6062.5 6124.9 4854.4 4861.5 5265.2 5561.6 5572.6 6354.5 6504.2 6562.6 6568.8 6588.5 5219.8 6215.5 6240.8 6254.2 6328.3 6485.0 6485.4 6506.3 6509.2 6525.5 5129.5 6162.5 6191.0 6237.0 6284.2 6140.6 6221.9 6308.0 6330.3 6339.5 6164.2 6249.2 6276.2 6278.1 6282.3 6102.1 6138.2 6232.8 6253.3 6260.3 6033.1 6124.3 6146.1 6182.2 6185.0 6209.3 6224.8 6246.6 6258.5 6302.4 6135.4 6169.9 6177.8 6212.3 6217.3 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:70461.61 Median:40044.20 stddev:155732.98 (388.9%) stddev-sans-first:156081.17 20:53:35 INFO - PROCESS | 1669 | Values: 466.3 482.6 494.7 528.0 533.5 39847.0 40536.8 42249.2 42271.7 42309.0 42816.1 43313.0 43315.7 43459.0 43535.8 9740.7 9770.1 9874.3 9884.3 9887.4 9596.5 9735.6 9737.0 9741.2 9756.7 9707.2 9734.4 9747.0 9760.8 9765.3 9651.8 9674.9 9694.9 9697.6 9709.1 9640.9 9699.9 9720.3 9724.6 9731.0 39878.0 40504.4 40570.0 40641.8 40961.2 3363.4 3378.7 3389.6 3404.2 3415.6 30496.9 30599.8 31873.8 31905.2 31994.4 2848.4 3221.3 3223.4 3310.8 3311.7 401922.0 499107.0 499264.0 506738.5 507080.0 61989.7 62288.4 62897.7 62951.4 63025.7 34667.1 35196.5 35333.0 35918.0 65267.8 11616.7 14037.7 15607.2 16008.4 16128.0 11130.3 12947.2 12954.3 12959.4 12989.5 19346.7 19450.3 19537.0 19543.8 19623.0 6634.3 7562.4 7850.2 7913.6 7970.8 761.8 847.3 999.6 1028.9 1102.1 29813.3 30388.7 30935.8 31003.4 31127.8 936.2 1020.8 1059.7 1089.7 1103.3 15161.5 15629.3 15819.0 15833.1 15948.8 645617.0 649401.0 650393.0 651099.0 651950.0 53759.7 56444.4 56519.9 56749.4 56950.7 1359.2 1366.5 1392.9 1396.3 1397.4 28783.4 29657.1 29871.1 30382.5 30400.4 49790.0 51028.5 51572.5 51818.5 51894.5 596729.0 597901.0 601458.0 601565.0 602029.0 26059.5 26258.5 26618.7 26619.5 26651.2 45266.5 46300.3 46689.0 46730.3 46857.5 36590.6 37309.8 38986.8 39909.6 40178.8 38334.4 38480.8 38490.4 39580.0 39679.4 32239.8 37409.8 37739.8 38150.6 38382.0 29379.4 34393.1 34881.0 35703.3 36247.5 25257.4 25297.2 25370.6 25614.5 25854.0 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:32924.75 Median:25565.18 stddev:88418.57 (345.9%) stddev-sans-first:88632.71 20:53:35 INFO - PROCESS | 1669 | Values: 317.5 370.9 375.7 383.3 395.5 19681.8 20685.9 20817.4 21498.4 21628.9 20090.5 20248.5 20632.7 20730.7 20828.6 5019.8 5903.2 6065.2 6094.3 6159.2 5914.9 5958.2 6053.8 6062.7 6077.0 5826.4 5949.9 5987.1 5988.3 6007.3 5683.4 5856.3 5943.8 5956.4 6000.6 4060.4 4406.8 4407.9 4471.7 4548.4 21274.5 25359.7 25544.9 25585.5 26154.2 1824.4 2388.3 2405.9 2418.8 3015.3 14959.2 15093.5 15148.0 15174.8 15479.8 1789.0 1829.9 1852.6 1905.9 1936.4 110561.9 113524.0 113726.9 113971.0 114507.0 9204.7 10644.0 10764.4 10964.2 11602.0 13723.7 13891.4 13894.4 13902.2 13955.4 8379.8 8550.4 8664.2 8739.7 8778.9 8666.0 8710.3 8710.8 8821.5 8877.3 6553.0 6638.4 6643.7 6684.9 6702.2 1886.7 1902.4 1912.1 1912.8 1938.6 841.2 871.9 888.7 906.6 983.7 18061.8 22157.4 22241.8 22248.7 22390.0 931.8 947.7 949.5 975.4 1062.2 11419.8 11737.3 11904.2 11924.8 11994.7 449557.8 528555.2 546196.0 549798.0 551037.0 111541.0 116488.0 132862.3 135339.3 135541.6 951.3 988.8 992.1 997.2 1013.9 17199.3 17252.4 18617.7 19137.8 19842.6 55582.7 55797.4 56551.7 58287.5 58443.0 70969.0 71981.6 75125.6 75322.2 79327.2 6610.2 7195.8 7333.7 7413.0 7796.6 10929.5 12652.5 12760.3 12910.4 13065.7 10705.1 10950.8 10982.0 11014.5 11378.0 7985.9 10062.7 10836.2 10993.3 11115.0 10454.9 11006.0 11135.2 11202.4 11483.4 7196.1 7389.3 7445.0 7481.3 7590.9 9340.1 10772.0 11121.2 11209.2 11459.6 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5630.61 Median:4828.32 stddev:3168.41 (65.6%) stddev-sans-first:3162.06 20:53:35 INFO - PROCESS | 1669 | Values: 1495.3 1562.0 1761.1 1821.5 1861.0 7995.9 8244.6 8371.1 8946.6 8998.2 8382.9 8678.9 8703.8 8781.6 8791.5 2331.9 2351.1 2400.2 2405.9 2409.7 1977.6 2267.8 2354.2 2382.2 2403.7 2175.9 2285.1 2339.2 2398.0 2428.2 2060.9 2176.3 2389.8 2398.9 2412.7 2014.6 2371.0 2386.0 2387.9 2390.1 8790.6 8833.6 8867.6 8875.3 8876.6 5051.4 5205.2 5213.8 5218.4 5220.3 3486.4 3542.9 3653.8 3657.1 3690.9 1031.2 1060.6 1069.9 1084.4 1090.3 11507.7 11556.5 11675.2 11678.1 11688.4 4583.7 4654.6 4825.3 4827.9 4828.8 8634.1 9164.2 9978.2 9981.8 10005.8 5363.1 5366.0 5366.5 5369.0 5396.2 4431.2 4594.2 4744.2 4866.2 4911.6 3359.8 3944.4 3963.5 4038.2 4090.8 1299.3 1302.1 1302.9 1317.2 1326.9 797.7 858.2 891.7 895.6 914.9 5501.6 5608.4 5706.2 5901.5 6051.0 424.3 441.2 442.3 445.1 920.3 4009.6 4052.6 4069.4 4150.5 4169.8 10213.4 10556.5 10582.5 10741.3 10814.0 9412.6 10698.9 10700.5 10709.7 10735.8 6984.3 8107.1 8162.3 8164.3 8302.0 5785.7 5840.9 5991.5 5993.3 6059.8 9896.4 10039.9 10076.4 10095.4 10102.6 9565.4 9640.1 9751.1 9889.4 10102.1 6856.5 7058.8 7236.7 7244.0 7497.1 8229.0 8241.4 8363.0 8422.7 8422.8 6907.9 7401.9 7487.4 7496.4 7546.7 6705.9 7160.7 7301.2 7305.5 7398.1 6495.7 6914.8 6991.2 6998.4 7015.1 4020.7 4557.9 4954.9 5008.1 5087.2 3966.6 4613.3 4664.0 5088.6 5124.1 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4700.40 Median:5310.62 stddev:1511.22 (28.5%) stddev-sans-first:1478.60 20:53:35 INFO - PROCESS | 1669 | Values: 280.6 296.7 305.1 308.8 312.9 4723.1 5130.1 5195.9 5733.8 5759.5 4927.8 5479.7 5600.2 5620.2 5693.3 4074.6 4106.1 4167.8 4215.2 4226.8 3662.5 3728.6 3986.9 4196.4 4271.8 3659.8 4208.5 4219.3 4223.9 4228.4 3387.4 4089.7 4189.3 4204.3 4214.3 2978.7 3592.2 3620.8 3628.0 3647.3 5432.6 5450.7 5466.3 5468.6 5513.7 4042.6 4470.8 4812.6 4840.1 4856.7 4871.7 5325.9 5921.7 5924.2 5932.5 3043.0 3599.0 3935.5 3952.4 3974.4 5912.9 6259.6 6303.7 6311.1 6328.9 3046.5 3413.4 3729.6 3777.7 3991.4 3190.7 3213.6 3682.0 3799.6 4034.5 4794.7 4805.6 4818.3 4820.1 4834.5 5105.5 5572.3 5942.6 6015.3 6048.7 1271.2 1340.8 1366.3 1371.6 1394.7 726.6 793.6 852.4 854.7 857.6 4874.6 5024.8 5254.6 5370.3 5488.9 5835.7 5987.7 6154.4 6166.8 6205.5 5328.0 5505.8 5518.8 5571.8 5577.2 2641.9 2801.2 3086.2 3180.8 3218.1 5002.9 5209.6 5560.3 5675.4 5913.6 5266.9 5904.9 5994.8 6185.3 6273.8 5141.5 6386.8 6414.7 6423.4 6432.1 5668.9 5707.7 5853.6 6033.7 6087.8 4978.5 5241.2 5591.7 6039.6 6043.7 4809.9 5660.7 5937.8 6363.9 6369.5 3522.7 3989.4 4009.2 4022.8 4045.0 5172.7 5854.4 6106.7 6201.3 6202.5 4808.8 5295.4 5396.7 5544.6 6007.8 4702.7 5992.0 6013.0 6083.7 6090.9 5209.6 5393.6 5489.0 5894.1 5920.6 5520.5 5802.2 5885.4 5921.5 5993.6 5832.3 5886.9 5898.4 5930.7 5949.4 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:24636.40 Median:4482.68 stddev:40246.74 (897.8%) stddev-sans-first:40319.32 20:53:35 INFO - PROCESS | 1669 | Values: 641.6 689.5 755.0 774.5 781.9 14753.9 15900.7 15993.4 16018.2 16032.2 14141.6 14418.6 14522.0 14542.2 14680.3 834.9 837.8 850.5 853.0 856.4 677.2 697.7 854.4 860.9 861.4 866.4 892.8 894.5 897.3 900.2 871.4 889.4 889.5 889.9 891.8 664.4 665.6 665.7 665.9 666.3 14259.9 14668.1 14740.6 14748.0 14758.2 13656.2 13660.3 13690.3 13745.2 13937.0 12542.0 12598.5 12656.2 12660.5 12737.8 4381.2 4468.2 4490.8 4508.0 4689.2 113010.0 114128.4 114498.9 114880.4 115662.0 10691.9 10789.5 10845.9 10927.0 10945.6 21588.0 21679.3 21711.3 21721.5 21756.9 7603.2 7639.3 7770.9 7848.2 7876.1 4215.8 4277.0 4294.5 4305.4 4421.0 3345.4 3359.2 3426.5 3450.9 3461.4 543.3 648.3 654.7 673.4 718.2 560.1 563.2 587.7 632.8 687.6 8397.7 8595.9 8654.0 9657.6 9697.6 638.7 678.3 679.2 680.2 681.8 4273.9 4474.6 4508.2 4702.4 4841.1 94735.1 95800.5 147638.3 154275.0 159169.2 143157.6 145254.3 146700.0 147153.3 149440.0 88022.6 93694.0 119560.0 120021.0 122248.4 7717.5 8765.1 8788.4 8895.2 9129.7 67804.3 67962.7 68432.0 69385.0 69977.7 63518.4 73188.0 99173.5 100343.5 102582.0 11675.5 11747.2 11831.7 12005.4 12020.6 13048.7 13100.0 13159.9 13162.3 13561.5 8739.0 11446.5 11894.9 12097.1 12127.2 11038.9 11592.0 12000.5 12079.5 12405.5 10788.3 10862.9 11752.7 12132.2 12160.0 8568.8 8659.4 9401.9 9617.7 9684.1 7752.9 8708.3 9583.4 9618.6 9796.1 20:53:35 INFO - PROCESS | 1669 | -------- Summary: end -------- 20:53:35 INFO - PROCESS | 1669 | 20:53:35 INFO - TEST-INFO | 1669: exit 0 20:53:35 INFO - TEST-OK | dromaeo_css | took 1114042ms 20:53:35 INFO - TEST-START | kraken 20:53:35 INFO - operating with platform_type : mac_ 20:53:35 INFO - Initialising browser for kraken test... 20:53:35 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpNcYSiT/profile http://localhost:49272/getInfo.html) 20:53:38 INFO - PROCESS | 1677 | 2016-09-22 20:53:38.716 plugin-container[1678:10816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8617, name = 'com.apple.tsm.portname' 20:53:38 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:53:38 INFO - PROCESS | 1677 | 2016-09-22 20:53:38.719 plugin-container[1678:10816] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 20:53:38 INFO - PROCESS | 1677 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:53:38 INFO - PROCESS | 1677 | 2016-09-22 20:53:38.719 plugin-container[1678:10816] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:53:38 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 20:53:38 INFO - PROCESS | 1677 | colorDepth:24 20:53:38 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 20:53:38 INFO - PROCESS | 1677 | __metrics 20:53:38 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 20:53:39 INFO - TEST-INFO | 1677: exit 0 20:53:39 INFO - Browser initialized. 20:53:39 INFO - Running cycle 1/1 for kraken test... 20:53:39 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/T/tmpNcYSiT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:53:41 INFO - PROCESS | 1679 | 2016-09-22 20:53:41.934 plugin-container[1680:10927] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8827, name = 'com.apple.tsm.portname' 20:53:41 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:53:41 INFO - PROCESS | 1679 | 2016-09-22 20:53:41.936 plugin-container[1680:10927] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 20:53:41 INFO - PROCESS | 1679 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:53:41 INFO - PROCESS | 1679 | 2016-09-22 20:53:41.937 plugin-container[1680:10927] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:53:51 INFO - PROCESS | 1679 | RSS: Main: 239792128 20:53:51 INFO - PROCESS | 1679 | 20:53:54 INFO - PROCESS | 1679 | 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) 20:53:55 INFO - PROCESS | 1679 | RSS: Main: 253145088 20:53:55 INFO - PROCESS | 1679 | 20:53:57 INFO - PROCESS | 1679 | 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) 20:53:58 INFO - PROCESS | 1679 | RSS: Main: 260653056 20:53:58 INFO - PROCESS | 1679 | 20:54:01 INFO - PROCESS | 1679 | 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) 20:54:02 INFO - PROCESS | 1679 | RSS: Main: 261185536 20:54:02 INFO - PROCESS | 1679 | 20:54:04 INFO - PROCESS | 1679 | 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) 20:54:04 INFO - PROCESS | 1679 | RSS: Main: 262381568 20:54:04 INFO - PROCESS | 1679 | 20:54:06 INFO - PROCESS | 1679 | 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) 20:54:07 INFO - PROCESS | 1679 | RSS: Main: 262815744 20:54:07 INFO - PROCESS | 1679 | 20:54:10 INFO - PROCESS | 1679 | 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) 20:54:10 INFO - PROCESS | 1679 | RSS: Main: 264585216 20:54:10 INFO - PROCESS | 1679 | 20:54:13 INFO - PROCESS | 1679 | 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) 20:54:14 INFO - PROCESS | 1679 | RSS: Main: 264605696 20:54:14 INFO - PROCESS | 1679 | 20:54:17 INFO - PROCESS | 1679 | 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) 20:54:18 INFO - PROCESS | 1679 | RSS: Main: 265121792 20:54:18 INFO - PROCESS | 1679 | 20:54:19 INFO - PROCESS | 1679 | 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) 20:54:20 INFO - PROCESS | 1679 | RSS: Main: 264667136 20:54:20 INFO - PROCESS | 1679 | 20:54:22 INFO - PROCESS | 1679 | 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) 20:54:23 INFO - PROCESS | 1679 | RSS: Main: 264728576 20:54:23 INFO - PROCESS | 1679 | 20:54:25 INFO - PROCESS | 1679 | 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) 20:54:26 INFO - PROCESS | 1679 | RSS: Main: 264757248 20:54:26 INFO - PROCESS | 1679 | 20:54:29 INFO - PROCESS | 1679 | 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) 20:54:29 INFO - PROCESS | 1679 | RSS: Main: 265027584 20:54:29 INFO - PROCESS | 1679 | 20:54:32 INFO - PROCESS | 1679 | 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) 20:54:33 INFO - PROCESS | 1679 | RSS: Main: 265158656 20:54:33 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | 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) 20:54:35 INFO - PROCESS | 1679 | RSS: Main: 266743808 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | __start_tp_report 20:54:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 20:54:35 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 20:54:35 INFO - PROCESS | 1679 | |i|pagename|runs| 20:54:35 INFO - PROCESS | 1679 | |0;ai-astar;110;119;119;117;118;118;116;118;118;115 20:54:35 INFO - PROCESS | 1679 | |1;audio-beat-detection;138;111;113;164;101;138;141;146;130;93 20:54:35 INFO - PROCESS | 1679 | |2;audio-dft;192;194;196;210;207;263;192;191;197;195 20:54:35 INFO - PROCESS | 1679 | |3;audio-fft;87;61;59;84;62;61;61;61;76;59 20:54:35 INFO - PROCESS | 1679 | |4;audio-oscillator;91;71;86;73;70;70;87;70;71;87 20:54:35 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;92;90;93;88;104;123;93;96;92;89 20:54:35 INFO - PROCESS | 1679 | |6;imaging-darkroom;151;122;97;149;144;98;100;152;93;153 20:54:35 INFO - PROCESS | 1679 | |7;imaging-desaturate;98;151;91;91;118;149;149;151;94;129 20:54:35 INFO - PROCESS | 1679 | |8;json-parse-financial;57;58;56;59;57;58;58;57;58;57 20:54:35 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;70;70;75;122;112;67;106;61;69;61 20:54:35 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;96;113;81;96;108;112;82;80;99;111 20:54:35 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;139;146;163;156;143;143;138;142;186;142 20:54:35 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;171;171;170;177;170;172;173;171;169;168 20:54:35 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;70;71;69;92;92;91;73;66;69;69 20:54:35 INFO - PROCESS | 1679 | __end_tp_report 20:54:35 INFO - PROCESS | 1679 | __start_cc_report 20:54:35 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,907 20:54:35 INFO - PROCESS | 1679 | __end_cc_report 20:54:35 INFO - PROCESS | 1679 | __startTimestamp1474602875403__endTimestamp 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | ------- Summary: start ------- 20:54:35 INFO - PROCESS | 1679 | Number of tests: 14 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:116.80 Median:118.00 stddev:2.70 (2.3%) stddev-sans-first:1.33 20:54:35 INFO - PROCESS | 1679 | Values: 110.0 119.0 119.0 117.0 118.0 118.0 116.0 118.0 118.0 115.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:139.50 stddev:22.26 (16.0%) stddev-sans-first:23.28 20:54:35 INFO - PROCESS | 1679 | Values: 138.0 111.0 113.0 164.0 101.0 138.0 141.0 146.0 130.0 93.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:203.70 Median:196.50 stddev:21.80 (11.1%) stddev-sans-first:22.70 20:54:35 INFO - PROCESS | 1679 | Values: 192.0 194.0 196.0 210.0 207.0 263.0 192.0 191.0 197.0 195.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:67.10 Median:61.50 stddev:10.89 (17.7%) stddev-sans-first:8.85 20:54:35 INFO - PROCESS | 1679 | Values: 87.0 61.0 59.0 84.0 62.0 61.0 61.0 61.0 76.0 59.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.50 stddev:8.87 (11.2%) stddev-sans-first:7.98 20:54:35 INFO - PROCESS | 1679 | Values: 91.0 71.0 86.0 73.0 70.0 70.0 87.0 70.0 71.0 87.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:92.00 stddev:10.50 (11.4%) stddev-sans-first:11.04 20:54:35 INFO - PROCESS | 1679 | Values: 92.0 90.0 93.0 88.0 104.0 123.0 93.0 96.0 92.0 89.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:125.90 Median:152.50 stddev:26.43 (17.3%) stddev-sans-first:26.43 20:54:35 INFO - PROCESS | 1679 | Values: 151.0 122.0 97.0 149.0 144.0 98.0 100.0 152.0 93.0 153.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:122.10 Median:121.00 stddev:26.85 (22.2%) stddev-sans-first:27.02 20:54:35 INFO - PROCESS | 1679 | Values: 98.0 151.0 91.0 91.0 118.0 149.0 149.0 151.0 94.0 129.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 20:54:35 INFO - PROCESS | 1679 | Values: 57.0 58.0 56.0 59.0 57.0 58.0 58.0 57.0 58.0 57.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:68.00 stddev:22.81 (33.5%) stddev-sans-first:23.83 20:54:35 INFO - PROCESS | 1679 | Values: 70.0 70.0 75.0 122.0 112.0 67.0 106.0 61.0 69.0 61.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:81.50 stddev:13.20 (16.2%) stddev-sans-first:13.98 20:54:35 INFO - PROCESS | 1679 | Values: 96.0 113.0 81.0 96.0 108.0 112.0 82.0 80.0 99.0 111.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:144.50 stddev:14.94 (10.3%) stddev-sans-first:15.32 20:54:35 INFO - PROCESS | 1679 | Values: 139.0 146.0 163.0 156.0 143.0 143.0 138.0 142.0 186.0 142.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.00 stddev:2.49 (1.5%) stddev-sans-first:2.64 20:54:35 INFO - PROCESS | 1679 | Values: 171.0 171.0 170.0 177.0 170.0 172.0 173.0 171.0 169.0 168.0 20:54:35 INFO - PROCESS | 1679 | 20:54:35 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:72.00 stddev:10.82 (15.0%) stddev-sans-first:11.24 20:54:35 INFO - PROCESS | 1679 | Values: 70.0 71.0 69.0 92.0 92.0 91.0 73.0 66.0 69.0 69.0 20:54:35 INFO - PROCESS | 1679 | -------- Summary: end -------- 20:54:35 INFO - PROCESS | 1679 | 20:54:36 INFO - TEST-INFO | 1679: exit 0 20:54:36 INFO - TEST-OK | kraken | took 60432ms 20:54:36 INFO - SUITE-END | took 1174s 20:54:36 INFO - Completed test suite (00:19:34) 20:54:36 INFO - javascript benchmark 20:54:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.82968466024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.294739578388, 3471.722262219023, 3473.6179020307777, 3499.9325205812233, 3503.859845606175, 5772.682502462363, 5867.413258674136, 5916.408359164081, 5968.552358573108, 5972.79095231667, 5814.883702325951, 5896.616719913202, 5924.999999999989, 5940.34656187819, 6053.697315134236, 5239.607029472795, 5368.91946620801, 5381.730913454331, 5406.91889621654, 5427.185922111695, 5313.73431328434, 5421.159720243369, 5466.1527463243265, 5468.72656367182, 5534.418886016971, 5241.240020197089, 5278.762455689464, 5295.655782374133, 5316.654417462892, 5331.493508116722, 5304.443033481506, 5323.653962492425, 5338.492843179892, 5386.8922621547745, 5421.457854214547, 5261.6842989420375, 5300.867478313035, 5309.654872433318, 5347.652402593819, 5381.408045115034, 5812.796552120655, 5879.67661778602, 5943.465088142088, 5958.40415958405, 5993.370696076893, 6170.2941570990815, 6266.091416744546, 6268.059791031336, 6271.404216599416, 6286.528510361742, 6294.339094395114, 6320.209973753281, 6326.93673063268, 6327.683615819236, 6327.987521996459, 5825.475707186373, 5899.793507227269, 5961.314448838352, 5969.641821490724, 5993.280806303184, 6469.45009674183, 6488.67556622167, 6502.804915852532, 6518.674066296761, 6520.989246666774, 6239.001759718423, 6239.688015599202, 6281.780137695158, 6282.151909492251, 6292.4966002720585, 6163.784267550704, 6224.9377506224355, 6249.187605611241, 6282.560220784592, 6332.873342533124, 6223.284322302902, 6250.624962502174, 6283.937160628427, 6288.937110628926, 6322.652254125976, 5007.9499205008215, 6232.875342493125, 6236.345183755731, 6251.6561589112125, 6296.716647750863, 4889.48660390661, 4994.600431965507, 5016.172331565251, 5028.472010438924, 5032.421271553745, 4465.285554311295, 4476.328550717353, 4481.551844815557, 4570.154521413549, 4605.309203619484, 5762.567807414461, 5994.37059108796, 6041.848953776191, 6062.393760623902, 6072.392760723892, 4762.357081793983, 5473.261109750133, 6339.841503962438, 6362.109304697254, 6372.522060845455, 5008.84973450797, 5714.885597308568, 6003.429674181033, 6062.454379105813, 6124.877502449926, 4854.368932038812, 4861.51384861511, 5265.183896496049, 5561.63849349791, 5572.60991730575, 6354.4916406686425, 6504.1869766279215, 6562.573432726953, 6568.8357791055605, 6588.538802283986, 5219.765110569958, 6215.471684906653, 6240.7503699851495, 6254.249490061222, 6328.335524770017, 6484.967575162094, 6485.3514648534765, 6506.284308726131, 6509.153810004669, 6525.543211975116, 5129.487051294841, 6162.476189523941, 6190.969045154746, 6236.968815155895, 6284.24589049317, 6140.5701600887505, 6221.9377806223165, 6307.96846015767, 6330.272018717907, 6339.492840572835, 6164.198654174928, 6249.187605611241, 6276.215473065867, 6278.089676996901, 6282.277538082996, 6102.09542342839, 6138.204480310071, 6232.750689972531, 6253.280872699698, 6260.280067792262, 6033.12519684652, 6124.265088189446, 6146.139540464249, 6182.165407669907, 6185.0, 6209.348018458178, 6224.751009959732, 6246.562740608296, 6258.499320054476, 6302.369763023661, 6135.447809697149, 6169.938300617116, 6177.7837775677635, 6212.254529456494, 6217.285012223471], "value": 5793.938843962865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.27261472103515, 482.59944246275575, 494.68093079963427, 527.9947200527994, 533.4958464251282, 39847.003824904394, 40536.79731601341, 42249.15501689964, 42271.73184804453, 42308.98064683858, 42816.143677126514, 43313.0, 43315.7005289841, 43459.0, 43535.78232108843, 9740.659076932308, 9770.120689137977, 9874.259430542703, 9884.308098433112, 9887.357321774098, 9596.520173991308, 9735.56189971453, 9736.95131524345, 9741.172000379976, 9756.658516951908, 9707.174890134313, 9734.36726612768, 9747.025297470233, 9760.755981100494, 9765.267604929659, 9651.806963860754, 9674.90325096747, 9694.903050969471, 9697.612095516171, 9709.126178643884, 9640.903590964072, 9699.854502182472, 9720.270979676552, 9724.562394692255, 9731.026897310283, 39878.0, 40504.39243411351, 40569.98575035648, 40641.79679101615, 40961.1807763843, 3363.428217203081, 3378.712809411203, 3389.610194827602, 3404.2000129969438, 3415.590129184514, 30496.932607358634, 30599.847000765076, 31873.84063079693, 31905.202369940704, 31994.360112797614, 2848.373357861288, 3221.2752130770623, 3223.435898717715, 3310.784798988058, 3311.7019468247972, 401922.0, 499107.0, 499264.0, 506738.46630766976, 507080.0, 61989.690051549456, 62288.37711622826, 62897.68551157215, 62951.37048629547, 63025.68487157535, 34667.13332166716, 35196.47205291872, 35333.0, 35918.0, 65267.84151981003, 11616.651500455, 14037.73660370551, 15607.219639018003, 16008.359665613245, 16128.032318060954, 11130.33218006906, 12947.158434701903, 12954.287514186623, 12959.416826242841, 12989.480420783251, 19346.7386557622, 19450.33181612857, 19536.952099868136, 19543.84722423107, 19623.0, 6634.303398143222, 7562.357199637982, 7850.175731548219, 7913.564753938474, 7970.840583188304, 761.7676608634309, 847.2628812932788, 999.5651891427107, 1028.881678606955, 1102.1183053557122, 29813.254668633457, 30388.69611303903, 30935.845320773704, 31003.379932401225, 31127.84436077805, 936.1995493852794, 1020.8264595018865, 1059.7191744187796, 1089.7112265249716, 1103.2994048779083, 15161.545153645407, 15629.296681649354, 15818.971766835119, 15833.129177895096, 15948.76076858848, 645617.0, 649401.0, 650393.0, 651099.0, 651950.0, 53759.731201344526, 56444.43555564474, 56519.869602607716, 56749.43250567441, 56950.71524642433, 1359.1573224600613, 1366.5422083601907, 1392.9442822286994, 1396.322783450026, 1397.3641992893208, 28783.424331512833, 29657.110286691433, 29871.103866884027, 30382.544261835646, 30400.391992160476, 49790.0, 51028.489715102376, 51572.48427515677, 51818.48181518287, 51894.481055190474, 596729.0, 597901.0, 601458.0, 601565.0, 602029.0, 26059.478810423305, 26258.474830503666, 26618.733812661627, 26619.467610648066, 26651.200463985337, 45266.547334526236, 46300.30549541692, 46689.0, 46730.29904551502, 46857.531424685316, 36590.63409365872, 37309.81345093366, 38986.80506597449, 39909.60090399059, 40178.799106004284, 38334.42498362471, 38480.80759596184, 38490.422643660924, 39580.0, 39679.40480892731, 32239.838800805846, 37409.81295093507, 37739.81130094332, 38150.618493814705, 38382.0, 29379.412411752073, 34393.140171495914, 34881.0, 35703.28593428169, 36247.45628815517, 25257.368565786004, 25297.241082767545, 25370.619440708037, 25614.487710245317, 25854.0], "value": 19798.40674361223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.50469267942015, 370.9369407200776, 375.6938095452207, 383.2545698616189, 395.50956813551187, 19681.803181968175, 20685.896570517147, 20817.375478735623, 21498.355049348524, 21628.89185554074, 20090.49321300901, 20248.493787655316, 20632.69050964237, 20730.689039664416, 20828.583428331425, 5019.799208031674, 5903.173555702205, 6065.150878876961, 6094.268687757453, 6159.23009623797, 5914.9408505915035, 5958.225430694004, 6053.757849686007, 6062.666553339564, 6076.966915624333, 5826.359100498942, 5949.940500594982, 5987.072003839412, 5988.281406231258, 6007.279126504825, 5683.374828768832, 5856.267966504187, 5943.791967281146, 5956.37458066901, 6000.579959402844, 4060.4112403701297, 4406.779661016936, 4407.911841763179, 4471.731696098212, 4548.431446069241, 21274.46813829651, 25359.746402536108, 25544.872275638503, 25585.48829023409, 26154.215373538824, 1824.4435447188603, 2388.319328991229, 2405.855648661086, 2418.806495480357, 3015.321552650658, 14959.177245251507, 15093.47172848956, 15148.0, 15174.848251517564, 15479.845201547952, 1788.97316540252, 1829.8627602929832, 1852.6387354465885, 1905.9142338594797, 1936.3762102351332, 110561.89438105596, 113524.0, 113726.86273137246, 113971.0, 114507.0, 9204.677836275698, 10644.0, 10764.3541387517, 10964.232503724663, 11602.0, 13723.725525489433, 13891.4443422264, 13894.374753136133, 13902.16587004783, 13955.441782328593, 8379.790505237417, 8550.358723095793, 8664.220220180088, 8739.650413983496, 8778.868316975251, 8666.0, 8710.303175745925, 8710.782230444289, 8821.514816685143, 8877.33419993503, 6553.0, 6638.369354911276, 6643.667816609151, 6684.933150668431, 6702.229243636946, 1886.6792645250341, 1902.3531999120366, 1912.0917564156914, 1912.8087191281038, 1938.6138910678933, 841.2428814067389, 871.8561437362764, 888.7467071884482, 906.5603182456504, 983.6966020023498, 18061.819381806275, 22157.44897857167, 22241.77758222397, 22248.66627000564, 22390.0, 931.8161455066837, 947.6920000999703, 949.5489642419795, 975.4196253229317, 1062.2404980439023, 11419.828702569468, 11737.295762254293, 11904.2262252955, 11924.761504769856, 11994.700132496757, 449557.75221123686, 528555.2150153252, 546196.0, 549798.0, 551037.0, 111541.0, 116488.0, 132862.33568832095, 135339.32330338482, 135541.6445835529, 951.3293128344501, 988.7577543501889, 992.1269283030887, 997.2470784557613, 1013.9290249682599, 17199.312027518758, 17252.396166134124, 18617.720734189268, 19137.808621913602, 19842.60314793725, 55582.72208638931, 55797.44202557922, 56551.71724141353, 58287.54281143005, 58443.0, 70969.0, 71981.6400917992, 75125.62437187778, 75322.24677753152, 79327.20672793199, 6610.2398224204835, 7195.82010449722, 7333.706651733871, 7412.96293518529, 7796.571188584682, 10929.453527323443, 12652.493900243888, 12760.29818359999, 12910.354482276036, 13065.67335816574, 10705.143588513056, 10950.780984380108, 10982.0, 11014.504347304552, 11378.0, 7985.92014079875, 10062.748431288983, 10836.241463097824, 10993.340399576051, 11115.0, 10454.895451045391, 11005.954434328725, 11135.220534562503, 11202.38386888729, 11483.36841473727, 7196.136463624399, 7389.298016688406, 7445.032145821008, 7481.326680598772, 7590.924090759243, 9340.065993400605, 10772.0, 11121.221514493907, 11209.15931305139, 11459.598914037968], "value": 9606.721460584666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.3196295685464, 1562.0159299641225, 1761.145844265531, 1821.5446138465384, 1860.962780744386, 7995.880061799077, 8244.628991695374, 8371.121032291612, 8946.597403116859, 8998.19016288534, 8382.87425688615, 8678.91321086789, 8703.825923481543, 8781.64873405063, 8791.516466594334, 2331.8717470539113, 2351.106579499796, 2400.1599440195964, 2405.915792947247, 2409.6867407237037, 1977.6143651987868, 2267.7958983691465, 2354.21133920137, 2382.154335211001, 2403.723571789249, 2175.9347219583437, 2285.074544809355, 2339.181286549711, 2397.9520409591796, 2428.1865575032384, 2060.9072591733407, 2176.2927048709153, 2389.784919357266, 2398.8800559972105, 2412.6501657259773, 2014.5668681233458, 2370.988145059281, 2385.9642105368434, 2387.9164229252065, 2390.067873529325, 8790.56047197644, 8833.55832208387, 8867.556622168866, 8875.28997680184, 8876.556172191365, 5051.393832740058, 5205.193195054772, 5213.843584692465, 5218.425973142951, 5220.347456567929, 3486.3724529584665, 3542.8582856685703, 3653.780773153619, 3657.104009517685, 3690.8708195213308, 1031.2214278219972, 1060.5916722061984, 1069.8609180806445, 1084.35480888871, 1090.3185509056839, 11507.712307192303, 11556.53773849045, 11675.241109327866, 11678.124140689482, 11688.415579221006, 4583.702059366131, 4654.581087702123, 4825.30033145199, 4827.8551643450755, 4828.782704778293, 8634.050254472004, 9164.221041211438, 9978.151857092229, 9981.800363992825, 10005.849912251322, 5363.141897296414, 5366.0, 5366.463353664681, 5369.0, 5396.244525766396, 4431.202383570923, 4594.173048851172, 4744.240921452551, 4866.245731911559, 4911.631627627942, 3359.798412095282, 3944.36890097583, 3963.544192417909, 4038.212548553004, 4090.8159132839096, 1299.2719682821823, 1302.1470936536584, 1302.8697130286896, 1317.157019507516, 1326.8540460549332, 797.6928882380209, 858.1761508951477, 891.6879092317766, 895.6238379880466, 914.9176574108362, 5501.559875209973, 5608.355039170466, 5706.172604972338, 5901.527877769854, 6051.0, 424.3465063801711, 441.1639942309306, 442.3077883112918, 445.09423323536447, 920.2959735802117, 4009.599040095967, 4052.63526282636, 4069.4302797608357, 4150.460440142822, 4169.833206671759, 10213.387196768217, 10556.47217639115, 10582.523786429629, 10741.301815381976, 10814.0, 9412.576434060484, 10698.946505267424, 10700.464976751287, 10709.678709638723, 10735.785284294427, 6984.301569842975, 8107.067687215927, 8162.26539611426, 8164.346852251806, 8302.045264794506, 5785.681787501728, 5840.883182336414, 5991.460768530853, 5993.280806303272, 6059.818205453844, 9896.406215627085, 10039.899601003897, 10076.445795481319, 10095.444750538498, 10102.646407375707, 9565.378250413702, 9640.084192001748, 9751.073648003428, 9889.357191782512, 10102.141317988053, 6856.5200435969, 7058.823529411806, 7236.674349654383, 7244.0, 7497.137829149718, 8229.012518497819, 8241.423100382915, 8363.038250601016, 8422.747317580483, 8422.789430264293, 6907.896381554381, 7401.925980740339, 7487.438442116972, 7496.437767167593, 7546.735864244725, 6705.932940670531, 7160.749373771893, 7301.196868344584, 7305.525140865827, 7398.075240594926, 6495.707693153914, 6914.757983470756, 6991.161060672548, 6998.440124790106, 7015.088038554955, 4020.6582440492884, 4557.863264102082, 4954.851354459372, 5008.098542262428, 5087.23691446286, 3966.5636779954757, 4613.284940834176, 4663.953360466352, 5088.643794934467, 5124.128898087409], "value": 4476.57642504225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.6085510712556, 296.7403372682961, 305.1395065914123, 308.7545401405883, 312.8639042016724, 4723.07899959508, 5130.127878260695, 5195.922061169081, 5733.770649174028, 5759.510441612468, 4927.827526036589, 5479.657483916446, 5600.247833951253, 5620.241267428906, 5693.259876216096, 4074.592540745924, 4106.096658735089, 4167.770772607505, 4215.220184265905, 4226.809793559281, 3662.487251784752, 3728.6084961079105, 3986.9003274918214, 4196.3705444183315, 4271.829126834923, 3659.79871107089, 4208.45290112285, 4219.282721937278, 4223.936640950388, 4228.429162063128, 3387.3902697514436, 4089.734167279132, 4189.324270291877, 4204.306289462235, 4214.304639734441, 2978.731914127717, 3592.2456284180353, 3620.818959052037, 3627.963720362789, 3647.2705458908326, 5432.565394768409, 5450.672959622435, 5466.262054622614, 5468.56251499883, 5513.696746678931, 4042.5755295694116, 4470.82116715331, 4812.639052071074, 4840.080384726926, 4856.68431551948, 4871.707697538159, 5325.854941187663, 5921.733521991478, 5924.2381088009, 5932.495737862287, 3042.9653917668097, 3599.046252743025, 3935.527736671589, 3952.367621180626, 3974.364101743707, 5912.881742365172, 6259.593126446812, 6303.747850085991, 6311.053341998691, 6328.936710632881, 3046.4516387050544, 3413.368526822546, 3729.6083911188935, 3777.660010599059, 3991.401289806552, 3190.7128358447853, 3213.6304325002457, 3681.9874534503224, 3799.6200379961783, 4034.5360283567766, 4794.729396709875, 4805.6155507559315, 4818.253170758538, 4820.132376172252, 4834.540718631724, 5105.540501354896, 5572.331320241516, 5942.61373010753, 6015.30823955242, 6048.667323297261, 1271.1991445389347, 1340.8458027326983, 1366.2553908120099, 1371.6296599917966, 1394.7001394699985, 726.6439444672178, 793.5714714054461, 852.3905407633448, 854.6538651846013, 857.5712143928037, 4874.610031197496, 5024.7689316117785, 5254.632175747737, 5370.254667233086, 5488.945110548923, 5835.67903765297, 5987.6888640179, 6154.415330543591, 6166.81499555014, 6205.47253483459, 5328.0, 5505.834824955257, 5518.779248830082, 5571.829915717663, 5577.2191893135, 2641.9207423777316, 2801.173653772142, 3086.2284428892776, 3180.807197301012, 3218.115018369967, 5002.874928126826, 5209.609279304067, 5560.332760068818, 5675.404082571271, 5913.58604897653, 5266.894662106736, 5904.852378690567, 5994.7602095916545, 6185.2784774698985, 6273.843153921189, 5141.485851414904, 6386.808395748228, 6414.743410263631, 6423.389777971085, 6432.13166222554, 5668.922904648269, 5707.743151558107, 5853.590318601125, 6033.728482218398, 6087.847803804941, 4978.452370239198, 5241.240020197126, 5591.735347184397, 6039.63762174271, 6043.70896663374, 4809.945684490443, 5660.745266462936, 5937.762489500545, 6363.936360636334, 6369.490440764635, 3522.7005704514377, 3989.401589761559, 4009.1981603679965, 4022.7586344818233, 4044.988752811797, 5172.741362931763, 5854.419306787228, 6106.664133472702, 6201.286852012076, 6202.534809889366, 4808.807647694053, 5295.391030031596, 5396.704790850246, 5544.641562817135, 6007.759689612367, 4702.717836929658, 5991.970040149771, 6013.0, 6083.65019011409, 6090.939090609215, 5209.583233341248, 5393.568514518751, 5488.957098151339, 5894.086416605433, 5920.615160014585, 5520.454272803621, 5802.199559288672, 5885.411458854081, 5921.467067963904, 5993.550483713651, 5832.300123985149, 5886.852063847508, 5898.439648233411, 5930.673812940329, 5949.370883760816], "value": 4207.0198578278905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.6310621392699, 689.5345641691857, 754.9660265288059, 774.4617490843866, 781.9374450043995, 14753.852461475382, 15900.681986360265, 15993.440229591966, 16018.19909004548, 16032.198390080508, 14141.646458838533, 14418.639534011654, 14522.0, 14542.200178990151, 14680.26598670065, 834.9123342049088, 837.8073043200068, 850.4769566716456, 853.0488505316558, 856.4133568505563, 677.2076670295742, 697.6651207420441, 854.3592305770673, 860.9354298427612, 861.4099341950783, 866.4411454611771, 892.7991201979568, 894.5348418822208, 897.2642433204742, 900.2078171209326, 871.376965469689, 889.3996552327186, 889.5241046040337, 889.902110767815, 891.8394688955952, 664.3954001858334, 665.5773583774289, 665.6871270502855, 665.9433948114367, 666.3436515032689, 14259.928700356431, 14668.119912805267, 14740.557783266519, 14748.0, 14758.188299643516, 13656.24890631015, 13660.316984150753, 13690.315484225848, 13745.175289482662, 13937.024408291423, 12542.0, 12598.496060157582, 12656.17734847232, 12660.493580256778, 12737.808932866015, 4381.16757816014, 4468.173387923212, 4490.775461226958, 4508.0, 4689.20283551797, 113010.0, 114128.42935785351, 114498.85501144965, 114880.42559787148, 115662.0, 10691.893081069245, 10789.46052697362, 10845.945770271099, 10927.0, 10945.562177512811, 21588.028538715796, 21679.34961951144, 21711.34865954024, 21721.456963576038, 21756.912154392216, 7603.163651998276, 7639.274268944441, 7770.92229077702, 7848.175941526058, 7876.133625301212, 4215.768132752728, 4276.978615106967, 4294.484661840536, 4305.375720520507, 4421.005273813366, 3345.381104495676, 3359.2441700617655, 3426.5031570422148, 3450.879219227315, 3461.4115600348, 543.2611648158502, 648.3095503288982, 654.6595770199469, 673.4275865514273, 718.1884470548351, 560.1289994059196, 563.2058797096075, 587.6630665236621, 632.8164832198611, 687.6011913090396, 8397.664093436317, 8595.914040859636, 8653.961524617087, 9657.565409556586, 9697.563609637584, 638.7002450014198, 678.281022116558, 679.1815861886415, 680.1701923653135, 681.8295426143465, 4273.9358909616385, 4474.574915383034, 4508.211063063951, 4702.412198475191, 4841.104395686809, 94735.10529789365, 95800.52099739596, 147638.26180869027, 154275.0, 159169.2041539785, 143157.56842431444, 145254.27372863068, 146700.0, 147153.26423367814, 149440.0, 88022.55988720016, 93694.0, 119560.0, 120020.99947501383, 122248.38875805742, 7717.459777815499, 8765.123487651184, 8788.42875213109, 8895.154960278764, 9129.680461183827, 67804.32195678177, 67962.66018669875, 68432.0, 69385.0, 69977.65011174911, 63518.36481635125, 73188.0, 99173.51239731266, 100343.49828250812, 102582.0, 11675.502710437646, 11747.177697561088, 11831.70420739454, 12005.39973001364, 12020.579279725167, 13048.739025219633, 13100.0, 13159.868401315864, 13162.276074815594, 13561.525346613216, 8739.0, 11446.542138314708, 11894.92945634897, 12097.092718046006, 12127.151099422956, 11038.944805275922, 11591.95672389489, 12000.459979300778, 12079.51681932713, 12405.503779849067, 10788.298760580537, 10862.891371086187, 11752.706182345168, 12132.211406258564, 12160.0, 8568.843206167088, 8659.437136586102, 9401.905980940102, 9617.71146865595, 9684.08001239881, 7752.92247077522, 8708.303335732999, 9583.424994500074, 9618.567164477756, 9796.069373409515], "value": 7588.6443646210555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 119.0, 119.0, 117.0, 118.0, 118.0, 116.0, 118.0, 118.0, 115.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 113.0, 164.0, 101.0, 138.0, 141.0, 146.0, 130.0, 93.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 194.0, 196.0, 210.0, 207.0, 263.0, 192.0, 191.0, 197.0, 195.0], "value": 203.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 61.0, 59.0, 84.0, 62.0, 61.0, 61.0, 61.0, 76.0, 59.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 86.0, 73.0, 70.0, 70.0, 87.0, 70.0, 71.0, 87.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 93.0, 88.0, 104.0, 123.0, 93.0, 96.0, 92.0, 89.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 97.0, 149.0, 144.0, 98.0, 100.0, 152.0, 93.0, 153.0], "value": 125.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 151.0, 91.0, 91.0, 118.0, 149.0, 149.0, 151.0, 94.0, 129.0], "value": 122.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 59.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 75.0, 122.0, 112.0, 67.0, 106.0, 61.0, 69.0, 61.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 113.0, 81.0, 96.0, 108.0, 112.0, 82.0, 80.0, 99.0, 111.0], "value": 97.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 146.0, 163.0, 156.0, 143.0, 143.0, 138.0, 142.0, 186.0, 142.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 170.0, 177.0, 170.0, 172.0, 173.0, 171.0, 169.0, 168.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 69.0, 92.0, 92.0, 91.0, 73.0, 66.0, 69.0, 69.0], "value": 76.2, "unit": "score"}]}]} 20:54:36 INFO - Return code: 0 20:54:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:54:36 ERROR - # TBPL SUCCESS # 20:54:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:54:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:54:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:54:36 INFO - 2016-09-22 20:54:36.724 screenresolution[1684:11299] starting screenresolution argv=screenresolution get 20:54:36 INFO - 2016-09-22 20:54:36.727 screenresolution[1684:11299] Display 0: 1600x1200x32@60 20:54:36 INFO - 2016-09-22 20:54:36.733 screenresolution[1685:11302] starting screenresolution argv=screenresolution list 20:54:36 INFO - Available Modes on Display 0 20:54:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:54:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:54:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:54:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:54:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:54:36 INFO - Intel Iris: 20:54:36 INFO - Chipset Model: Intel Iris 20:54:36 INFO - Type: GPU 20:54:36 INFO - Bus: Built-In 20:54:36 INFO - VRAM (Dynamic, Max): 1536 MB 20:54:36 INFO - Vendor: Intel (0x8086) 20:54:36 INFO - Device ID: 0x0a2e 20:54:36 INFO - Revision ID: 0x0009 20:54:36 INFO - Displays: 20:54:36 INFO - Display: 20:54:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:54:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:54:36 INFO - Display Serial Number: 1600x1200 60 20:54:36 INFO - Main Display: Yes 20:54:36 INFO - Mirror: Off 20:54:36 INFO - Online: Yes 20:54:36 INFO - Rotation: Supported 20:54:36 INFO - Return code: 0 20:54:36 INFO - Running post-action listener: _resource_record_post_action 20:54:36 INFO - [mozharness: 2016-09-23 03:54:36.977220Z] Finished run-tests step (success) 20:54:36 INFO - Running post-run listener: _resource_record_post_run 20:54:37 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32666112; Write bytes: 709007872; Read time: 199; Write time: 1983 20:54:37 INFO - TinderboxPrint: CPU usage
54.4% 20:54:37 INFO - TinderboxPrint: I/O read bytes / time
32,666,112 / 199 20:54:37 INFO - TinderboxPrint: I/O write bytes / time
709,007,872 / 1,983 20:54:37 INFO - TinderboxPrint: CPU idle
2,209.6 (45.6%) 20:54:37 INFO - TinderboxPrint: CPU system
979.3 (20.2%) 20:54:37 INFO - TinderboxPrint: CPU user
1,652.8 (34.1%) 20:54:37 INFO - TinderboxPrint: Swap in / out
435,527,680 / 0 20:54:37 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384002560; Write bytes: 378521600; Read time: 29084; Write time: 742 20:54:37 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31744512; Write bytes: 299954688; Read time: 188; Write time: 1172 20:54:37 INFO - Running post-run listener: _upload_blobber_files 20:54:37 INFO - Blob upload gear active. 20:54:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:54:37 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 20:54:37 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:54:37 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:54:37 INFO - (blobuploader) - INFO - Open directory for files ... 20:54:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:54:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:38 INFO - (blobuploader) - INFO - Done attempting. 20:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:54:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:54:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:39 INFO - (blobuploader) - INFO - Done attempting. 20:54:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:54:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:54:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:54:42 INFO - (blobuploader) - INFO - Done attempting. 20:54:42 INFO - (blobuploader) - INFO - Iteration through files over. 20:54:42 INFO - Return code: 0 20:54:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:54:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:54:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e4bbcffafa28d19aa5714a27977e46549eefdb750d58238d57c30a9addcbbad852237495a77a69b17b3927da89b752c61bdc3de6f3371804f1dcf063d9703a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c88908ed19fb43e4901c3edf2e54a15604a6de6027a9cf0c19a475c0de9984e6b0242e0f05a74367aa80873488631591d6e763550335a2ea2b2af4beb5e54c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/04826044f88719007e5d25525dd7d3980b293bcc2b1ba5384a813a28d6082eb5091dc35252965a14a2ec0eca64a273f62da0f8d2d2a5cddd27ed5004e2fa9a7b"} 20:54:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:54:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:54:42 INFO - Contents: 20:54:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e4bbcffafa28d19aa5714a27977e46549eefdb750d58238d57c30a9addcbbad852237495a77a69b17b3927da89b752c61bdc3de6f3371804f1dcf063d9703a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c88908ed19fb43e4901c3edf2e54a15604a6de6027a9cf0c19a475c0de9984e6b0242e0f05a74367aa80873488631591d6e763550335a2ea2b2af4beb5e54c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/04826044f88719007e5d25525dd7d3980b293bcc2b1ba5384a813a28d6082eb5091dc35252965a14a2ec0eca64a273f62da0f8d2d2a5cddd27ed5004e2fa9a7b"} 20:54:42 INFO - Running post-run listener: copy_logs_to_upload_dir 20:54:42 INFO - Copying logs to upload dir... 20:54:42 INFO - mkdir: /builds/slave/test/build/upload/logs 20:54:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.886161 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-09-22 20:54:42.270063) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 20:54:42.273676) ========= 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.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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/Autoland/sha512/3e4bbcffafa28d19aa5714a27977e46549eefdb750d58238d57c30a9addcbbad852237495a77a69b17b3927da89b752c61bdc3de6f3371804f1dcf063d9703a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c88908ed19fb43e4901c3edf2e54a15604a6de6027a9cf0c19a475c0de9984e6b0242e0f05a74367aa80873488631591d6e763550335a2ea2b2af4beb5e54c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/04826044f88719007e5d25525dd7d3980b293bcc2b1ba5384a813a28d6082eb5091dc35252965a14a2ec0eca64a273f62da0f8d2d2a5cddd27ed5004e2fa9a7b"} build_url:https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/Glp9nJvRSLCBAMTCpEc7gA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3e4bbcffafa28d19aa5714a27977e46549eefdb750d58238d57c30a9addcbbad852237495a77a69b17b3927da89b752c61bdc3de6f3371804f1dcf063d9703a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c88908ed19fb43e4901c3edf2e54a15604a6de6027a9cf0c19a475c0de9984e6b0242e0f05a74367aa80873488631591d6e763550335a2ea2b2af4beb5e54c6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/04826044f88719007e5d25525dd7d3980b293bcc2b1ba5384a813a28d6082eb5091dc35252965a14a2ec0eca64a273f62da0f8d2d2a5cddd27ed5004e2fa9a7b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 20:54:42.313723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:54:42.314284) ========= 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.xXiYfx3wSW/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.jE962DHFbJ/Listeners TMPDIR=/var/folders/_y/5qjgk6c15rn_gtyl8d944nb400000w/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.005031 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 20:54:42.364582) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 20:54:42.365134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 20:54:42.365624) ========= ========= Total master_lag: 0.22 =========