builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1474529840.84 results: success (0) buildid: 20160921231359 builduid: fba6eb565fa34d5da8a17e49ce0e2586 revision: 583124bcd4d9a222bbd4444682c6058643c36abb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:20.841047) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:20.841936) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:20.842417) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:20.937584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:20.937951) ========= 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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.2M=0s 2016-09-22 00:37:21 (66.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.507353 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:21.503538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:21.504055) ========= 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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.027941 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:21.581709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 00:37:21.582133) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 583124bcd4d9a222bbd4444682c6058643c36abb --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 583124bcd4d9a222bbd4444682c6058643c36abb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:21,669 truncating revision to first 12 chars 2016-09-22 00:37:21,669 Setting DEBUG logging. 2016-09-22 00:37:21,669 attempt 1/10 2016-09-22 00:37:21,669 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/583124bcd4d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 00:37:22,799 unpacking tar archive at: autoland-583124bcd4d9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.399934 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 00:37:23.016447) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:23.016833) ========= script_repo_revision: 583124bcd4d9a222bbd4444682c6058643c36abb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:23.017301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:23.017643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 00:37:23.036455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-22 00:37:23.036796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:23 INFO - MultiFileLogger online at 20160922 00:37:23 in /builds/slave/test 00:37:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:37:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:37:23 INFO - {'append_to_log': False, 00:37:23 INFO - 'base_work_dir': '/builds/slave/test', 00:37:23 INFO - 'blob_upload_branch': 'Autoland', 00:37:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:37:23 INFO - 'branch': 'Autoland', 00:37:23 INFO - 'buildbot_json_path': 'buildprops.json', 00:37:23 INFO - 'config_files': ('talos/mac_config.py',), 00:37:23 INFO - 'default_actions': ('clobber', 00:37:23 INFO - 'read-buildbot-config', 00:37:23 INFO - 'download-and-extract', 00:37:23 INFO - 'populate-webroot', 00:37:23 INFO - 'create-virtualenv', 00:37:23 INFO - 'install', 00:37:23 INFO - 'run-tests'), 00:37:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:37:23 INFO - 'download_minidump_stackwalk': True, 00:37:23 INFO - 'download_symbols': 'ondemand', 00:37:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:37:23 INFO - 'tooltool.py': '/tools/tooltool.py', 00:37:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:37:23 INFO - '/tools/misc-python/virtualenv.py')}, 00:37:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:37:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:37:23 INFO - 'installer_path': 'installer.exe', 00:37:23 INFO - 'log_level': 'info', 00:37:23 INFO - 'log_name': 'talos', 00:37:23 INFO - 'log_to_console': True, 00:37:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:37:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:37:23 INFO - 'opt_config_files': (), 00:37:23 INFO - 'pip_index': False, 00:37:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:37:23 INFO - 'cmd': ('bash', 00:37:23 INFO - '-c', 00:37:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:37:23 INFO - 'enabled': True, 00:37:23 INFO - 'halt_on_failure': False, 00:37:23 INFO - 'name': 'check_screen_resolution'},), 00:37:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:37:23 INFO - 'cmd': ('bash', 00:37:23 INFO - '-c', 00:37:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:37:23 INFO - 'enabled': True, 00:37:23 INFO - 'halt_on_failure': False, 00:37:23 INFO - 'name': 'check_screen_resolution'},), 00:37:23 INFO - 'run_cmd_checks_enabled': True, 00:37:23 INFO - 'sps_profile': False, 00:37:23 INFO - 'sps_profile_interval': 0, 00:37:23 INFO - 'suite': 'dromaeojs', 00:37:23 INFO - 'system_bits': '32', 00:37:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:37:23 INFO - 'title': 't-yosemite-r7-0051', 00:37:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:37:23 INFO - 'use_talos_json': True, 00:37:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:37:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:37:23 INFO - 'work_dir': 'build'} 00:37:23 INFO - [mozharness: 2016-09-22 07:37:23.244652Z] Running clobber step. 00:37:23 INFO - Running pre-action listener: _resource_record_pre_action 00:37:23 INFO - Running main action method: clobber 00:37:23 INFO - rmtree: /builds/slave/test/build 00:37:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:37:25 INFO - Running post-action listener: _resource_record_post_action 00:37:25 INFO - [mozharness: 2016-09-22 07:37:25.326200Z] Finished clobber step (success) 00:37:25 INFO - [mozharness: 2016-09-22 07:37:25.326322Z] Running read-buildbot-config step. 00:37:25 INFO - Running pre-action listener: _resource_record_pre_action 00:37:25 INFO - Running main action method: read_buildbot_config 00:37:25 INFO - Using buildbot properties: 00:37:25 INFO - { 00:37:25 INFO - "project": "", 00:37:25 INFO - "product": "firefox", 00:37:25 INFO - "script_repo_revision": "production", 00:37:25 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 00:37:25 INFO - "repository": "", 00:37:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 00:37:25 INFO - "buildid": "20160921231359", 00:37:25 INFO - "pgo_build": "False", 00:37:25 INFO - "basedir": "/builds/slave/test", 00:37:25 INFO - "buildnumber": 295, 00:37:25 INFO - "slavename": "t-yosemite-r7-0051", 00:37:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:37:25 INFO - "platform": "yosemite_r7", 00:37:25 INFO - "scheduler": "tests-autoland-macosx64-talos", 00:37:25 INFO - "branch": "autoland", 00:37:25 INFO - "repo_path": "integration/autoland", 00:37:25 INFO - "revision": "583124bcd4d9a222bbd4444682c6058643c36abb", 00:37:25 INFO - "stage_platform": "macosx64", 00:37:25 INFO - "builduid": "fba6eb565fa34d5da8a17e49ce0e2586", 00:37:25 INFO - "slavebuilddir": "test" 00:37:25 INFO - } 00:37:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:37:25 INFO - Running post-action listener: _resource_record_post_action 00:37:25 INFO - [mozharness: 2016-09-22 07:37:25.329601Z] Finished read-buildbot-config step (success) 00:37:25 INFO - [mozharness: 2016-09-22 07:37:25.329709Z] Running download-and-extract step. 00:37:25 INFO - Running pre-action listener: _resource_record_pre_action 00:37:25 INFO - Running main action method: download_and_extract 00:37:25 INFO - mkdir: /builds/slave/test/build/tests 00:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:25 INFO - trying https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/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 00:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/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 00:37:26 INFO - Downloaded 1199 bytes. 00:37:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:37:26 INFO - Using the following test package requirements: 00:37:26 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:37:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:37:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:37:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'jsshell-mac.zip'], 00:37:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:37:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:37:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:37:26 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:37:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:37:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:37:26 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:37:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:37:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:37:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:37:26 INFO - Fetch https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:37:26 INFO - Expected file size: 16434799 00:37:33 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 00:37:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:37:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:37:33 INFO - Fetch https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:37:34 INFO - Expected file size: 16434799 00:37:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:37:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:37:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:37:41 INFO - Expected file size: 14414059 00:37:42 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')]} 00:37:42 INFO - trying https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:37:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/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 00:37:44 INFO - Downloaded 111334034 bytes. 00:37:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:37:44 INFO - mkdir: /builds/slave/test/properties 00:37:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:37:44 INFO - Writing to file /builds/slave/test/properties/build_url 00:37:44 INFO - Contents: 00:37:44 INFO - build_url:https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:37:45 INFO - Running post-action listener: _resource_record_post_action 00:37:45 INFO - Running post-action listener: set_extra_try_arguments 00:37:45 INFO - [mozharness: 2016-09-22 07:37:45.461386Z] Finished download-and-extract step (success) 00:37:45 INFO - [mozharness: 2016-09-22 07:37:45.461536Z] Running populate-webroot step. 00:37:45 INFO - Running pre-action listener: _resource_record_pre_action 00:37:45 INFO - Running main action method: populate_webroot 00:37:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:37:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:37:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:37:45 INFO - '--tppagecycles', 00:37:45 INFO - '7'], 00:37:45 INFO - 'tests': ['tsvgm']}}, 00:37:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:37:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:37:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:37:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:37:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['damp', 'tps']}, 00:37:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'tests': ['damp', 'tps']}, 00:37:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['dromaeo_dom']}, 00:37:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:37:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['basic_compositor_video']}, 00:37:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:37:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'other-e10s': {'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['a11yr', 00:37:45 INFO - 'ts_paint', 00:37:45 INFO - 'tpaint', 00:37:45 INFO - 'sessionrestore', 00:37:45 INFO - 'sessionrestore_no_auto_restore', 00:37:45 INFO - 'tabpaint']}, 00:37:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['tsvgx', 00:37:45 INFO - 'tsvgr_opacity', 00:37:45 INFO - 'tart', 00:37:45 INFO - 'tscrollx', 00:37:45 INFO - 'cart']}, 00:37:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:37:45 INFO - 'tsvgr_opacity', 00:37:45 INFO - 'tart', 00:37:45 INFO - 'tscrollx', 00:37:45 INFO - 'cart']}, 00:37:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'talos_options': ['--disable-e10s'], 00:37:45 INFO - 'tests': ['tp5o']}, 00:37:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'tests': ['tp5o']}, 00:37:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'talos_options': ['--disable-e10s', 00:37:45 INFO - '--xperf_path', 00:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:45 INFO - 'tests': ['tp5n']}, 00:37:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:45 INFO - 'talos_options': ['--xperf_path', 00:37:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:45 INFO - 'tests': ['tp5n']}}, 00:37:45 INFO - 'talos.zip': {'path': '', 00:37:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:37:45 INFO - Running post-action listener: _resource_record_post_action 00:37:45 INFO - [mozharness: 2016-09-22 07:37:45.480559Z] Finished populate-webroot step (success) 00:37:45 INFO - [mozharness: 2016-09-22 07:37:45.480693Z] Running create-virtualenv step. 00:37:45 INFO - Running pre-action listener: _resource_record_pre_action 00:37:45 INFO - Running main action method: create_virtualenv 00:37:45 INFO - Creating virtualenv /builds/slave/test/build/venv 00:37:45 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 00:37:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:37:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:37:45 INFO - Using real prefix '/tools/python27' 00:37:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:37:46 INFO - Installing distribute.............................................................................................................................................................................................done. 00:37:49 INFO - Installing pip.................done. 00:37:49 INFO - Return code: 0 00:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:49 INFO - 'HOME': '/Users/cltbld', 00:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:49 INFO - 'LOGNAME': 'cltbld', 00:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:49 INFO - 'MOZ_NO_REMOTE': '1', 00:37:49 INFO - 'NO_EM_RESTART': '1', 00:37:49 INFO - 'PAGER': '/bin/cat', 00:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:49 INFO - 'PWD': '/builds/slave/test', 00:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:49 INFO - 'SHELL': '/bin/bash', 00:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:37:49 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:49 INFO - 'USER': 'cltbld', 00:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:49 INFO - 'XPC_FLAGS': '0x0', 00:37:49 INFO - 'XPC_SERVICE_NAME': '0', 00:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:37:49 INFO - Cleaning up... 00:37:49 INFO - Return code: 0 00:37:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:49 INFO - 'HOME': '/Users/cltbld', 00:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:49 INFO - 'LOGNAME': 'cltbld', 00:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:49 INFO - 'MOZ_NO_REMOTE': '1', 00:37:49 INFO - 'NO_EM_RESTART': '1', 00:37:49 INFO - 'PAGER': '/bin/cat', 00:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:49 INFO - 'PWD': '/builds/slave/test', 00:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:49 INFO - 'SHELL': '/bin/bash', 00:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:37:49 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:49 INFO - 'USER': 'cltbld', 00:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:49 INFO - 'XPC_FLAGS': '0x0', 00:37:49 INFO - 'XPC_SERVICE_NAME': '0', 00:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:49 INFO - Downloading/unpacking psutil>=3.1.1 00:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:52 INFO - Installing collected packages: psutil 00:37:52 INFO - Running setup.py install for psutil 00:37:52 INFO - building 'psutil._psutil_osx' extension 00:37:52 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 00:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:37:53 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 00:37:53 INFO - building 'psutil._psutil_posix' extension 00:37:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 00:37:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:37:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:37:53 INFO - ^ 00:37:53 INFO - 1 warning generated. 00:37:53 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 00:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:53 INFO - Successfully installed psutil 00:37:53 INFO - Cleaning up... 00:37:53 INFO - Return code: 0 00:37:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:37:53 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')]} 00:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:53 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')]} 00:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:53 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:53 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 00:37:53 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 00:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:53 INFO - 'HOME': '/Users/cltbld', 00:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:53 INFO - 'LOGNAME': 'cltbld', 00:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:53 INFO - 'MOZ_NO_REMOTE': '1', 00:37:53 INFO - 'NO_EM_RESTART': '1', 00:37:53 INFO - 'PAGER': '/bin/cat', 00:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:53 INFO - 'PWD': '/builds/slave/test', 00:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:53 INFO - 'SHELL': '/bin/bash', 00:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:37:53 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:53 INFO - 'USER': 'cltbld', 00:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:53 INFO - 'XPC_FLAGS': '0x0', 00:37:53 INFO - 'XPC_SERVICE_NAME': '0', 00:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:37:54 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 00:37:54 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 00:37:54 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 00:37:54 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 00:37:54 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 00:37:54 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 00:37:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:37:56 INFO - Installing collected packages: mozsystemmonitor 00:37:56 INFO - Running setup.py install for mozsystemmonitor 00:37:56 INFO - Successfully installed mozsystemmonitor 00:37:56 INFO - Cleaning up... 00:37:57 INFO - Return code: 0 00:37:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:37:57 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')]} 00:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:57 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')]} 00:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:57 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:37:57 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 00:37:57 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 00:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:57 INFO - 'HOME': '/Users/cltbld', 00:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:57 INFO - 'LOGNAME': 'cltbld', 00:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:57 INFO - 'MOZ_NO_REMOTE': '1', 00:37:57 INFO - 'NO_EM_RESTART': '1', 00:37:57 INFO - 'PAGER': '/bin/cat', 00:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:57 INFO - 'PWD': '/builds/slave/test', 00:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:57 INFO - 'SHELL': '/bin/bash', 00:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:37:57 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:57 INFO - 'USER': 'cltbld', 00:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:57 INFO - 'XPC_FLAGS': '0x0', 00:37:57 INFO - 'XPC_SERVICE_NAME': '0', 00:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:57 INFO - Downloading/unpacking jsonschema==2.5.1 00:37:57 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 00:37:57 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 00:37:57 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 00:37:57 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 00:37:57 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 00:37:57 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 00:37:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:37:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:37:59 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 00:37:59 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 00:37:59 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 00:37:59 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 00:37:59 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 00:37:59 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 00:38:00 INFO - Downloading functools32-3.2.3-2.tar.gz 00:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:38:00 INFO - warning: no files found matching '*.txt' 00:38:00 INFO - no previously-included directories found matching 'build' 00:38:00 INFO - no previously-included directories found matching 'dist' 00:38:00 INFO - no previously-included directories found matching '.git*' 00:38:00 INFO - Installing collected packages: jsonschema, functools32 00:38:00 INFO - Running setup.py install for functools32 00:38:00 INFO - warning: no files found matching '*.txt' 00:38:00 INFO - no previously-included directories found matching 'build' 00:38:00 INFO - no previously-included directories found matching 'dist' 00:38:00 INFO - no previously-included directories found matching '.git*' 00:38:00 INFO - Successfully installed jsonschema functools32 00:38:00 INFO - Cleaning up... 00:38:00 INFO - Return code: 0 00:38:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:38:00 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')]} 00:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:00 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')]} 00:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:00 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:00 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 00:38:00 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 00:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:00 INFO - 'HOME': '/Users/cltbld', 00:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:00 INFO - 'LOGNAME': 'cltbld', 00:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:00 INFO - 'MOZ_NO_REMOTE': '1', 00:38:00 INFO - 'NO_EM_RESTART': '1', 00:38:00 INFO - 'PAGER': '/bin/cat', 00:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:00 INFO - 'PWD': '/builds/slave/test', 00:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:00 INFO - 'SHELL': '/bin/bash', 00:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:00 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:00 INFO - 'USER': 'cltbld', 00:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:00 INFO - 'XPC_FLAGS': '0x0', 00:38:00 INFO - 'XPC_SERVICE_NAME': '0', 00:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:38:00 INFO - Cleaning up... 00:38:00 INFO - Return code: 0 00:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:38:00 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')]} 00:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:00 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')]} 00:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:00 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:00 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 00:38:00 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 00:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:00 INFO - 'HOME': '/Users/cltbld', 00:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:00 INFO - 'LOGNAME': 'cltbld', 00:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:00 INFO - 'MOZ_NO_REMOTE': '1', 00:38:00 INFO - 'NO_EM_RESTART': '1', 00:38:00 INFO - 'PAGER': '/bin/cat', 00:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:00 INFO - 'PWD': '/builds/slave/test', 00:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:00 INFO - 'SHELL': '/bin/bash', 00:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:00 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:00 INFO - 'USER': 'cltbld', 00:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:00 INFO - 'XPC_FLAGS': '0x0', 00:38:00 INFO - 'XPC_SERVICE_NAME': '0', 00:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:01 INFO - Downloading/unpacking blobuploader==1.2.4 00:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:03 INFO - Downloading blobuploader-1.2.4.tar.gz 00:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:38:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:38:03 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 00:38:03 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 00:38:03 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 00:38:03 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 00:38:03 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 00:38:03 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 00:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:38:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38: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 00:38:04 INFO - Downloading docopt-0.6.1.tar.gz 00:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:38:04 INFO - Installing collected packages: blobuploader, requests, docopt 00:38:04 INFO - Running setup.py install for blobuploader 00:38:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:38:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:38:04 INFO - Running setup.py install for requests 00:38:05 INFO - Running setup.py install for docopt 00:38:05 INFO - Successfully installed blobuploader requests docopt 00:38:05 INFO - Cleaning up... 00:38:05 INFO - Return code: 0 00:38:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:05 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:05 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 00:38:05 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 00:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:05 INFO - 'HOME': '/Users/cltbld', 00:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:05 INFO - 'LOGNAME': 'cltbld', 00:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:05 INFO - 'MOZ_NO_REMOTE': '1', 00:38:05 INFO - 'NO_EM_RESTART': '1', 00:38:05 INFO - 'PAGER': '/bin/cat', 00:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:05 INFO - 'PWD': '/builds/slave/test', 00:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:05 INFO - 'SHELL': '/bin/bash', 00:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:05 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:05 INFO - 'USER': 'cltbld', 00:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:05 INFO - 'XPC_FLAGS': '0x0', 00:38:05 INFO - 'XPC_SERVICE_NAME': '0', 00:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:05 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-lmOEfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-mDVS5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zqfHTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-by6K9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zd7q2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5si0gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8p8smk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-cYIZCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1jL3IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:06 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-H0Q_8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FOYRJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-bqAFtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hDcQbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MhzcuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-WqQpjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-vKuM4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:07 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fzOLKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:38:07 INFO - Running setup.py install for manifestparser 00:38:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:38:07 INFO - Running setup.py install for mozcrash 00:38:08 INFO - Running setup.py install for mozdebug 00:38:08 INFO - Running setup.py install for mozdevice 00:38:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Running setup.py install for mozfile 00:38:08 INFO - Running setup.py install for mozhttpd 00:38:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Running setup.py install for mozinfo 00:38:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Running setup.py install for mozInstall 00:38:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Running setup.py install for mozleak 00:38:09 INFO - Running setup.py install for mozlog 00:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for moznetwork 00:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozprocess 00:38:09 INFO - Running setup.py install for mozprofile 00:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozrunner 00:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozscreenshot 00:38:10 INFO - Running setup.py install for moztest 00:38:10 INFO - Running setup.py install for mozversion 00:38:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:38:10 INFO - Cleaning up... 00:38:10 INFO - Return code: 0 00:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:10 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:10 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 00:38:10 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 00:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:10 INFO - 'HOME': '/Users/cltbld', 00:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:10 INFO - 'LOGNAME': 'cltbld', 00:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:10 INFO - 'MOZ_NO_REMOTE': '1', 00:38:10 INFO - 'NO_EM_RESTART': '1', 00:38:10 INFO - 'PAGER': '/bin/cat', 00:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:10 INFO - 'PWD': '/builds/slave/test', 00:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:10 INFO - 'SHELL': '/bin/bash', 00:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:10 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:10 INFO - 'USER': 'cltbld', 00:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:10 INFO - 'XPC_FLAGS': '0x0', 00:38:10 INFO - 'XPC_SERVICE_NAME': '0', 00:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-PSa6n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:10 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)) 00:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1X1c8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:10 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)) 00:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-hAAkiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:10 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)) 00:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:10 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-sbcCpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BizPEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-mH7DH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-fias4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-47COFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Y5ibK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-v_Es0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-8HZDuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-U2sfd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:11 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-CxMPNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-s9NTvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9fxkHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-RMv5Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:12 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-10tr3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:12 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)) 00:38:12 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)) 00:38:12 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)) 00:38:12 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)) 00:38:12 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)) 00:38:12 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)) 00:38:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:14 INFO - Downloading blessings-1.6.tar.gz 00:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:38:15 INFO - Installing collected packages: blessings 00:38:15 INFO - Running setup.py install for blessings 00:38:15 INFO - Successfully installed blessings 00:38:15 INFO - Cleaning up... 00:38:15 INFO - Return code: 0 00:38:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:15 INFO - Reading from file tmpfile_stdout 00:38:15 INFO - Current package versions: 00:38:15 INFO - blessings == 1.6 00:38:15 INFO - blobuploader == 1.2.4 00:38:15 INFO - docopt == 0.6.1 00:38:15 INFO - functools32 == 3.2.3-2 00:38:15 INFO - jsonschema == 2.5.1 00:38:15 INFO - manifestparser == 1.1 00:38:15 INFO - mozInstall == 1.12 00:38:15 INFO - mozcrash == 0.17 00:38:15 INFO - mozdebug == 0.1 00:38:15 INFO - mozdevice == 0.48 00:38:15 INFO - mozfile == 1.2 00:38:15 INFO - mozhttpd == 0.7 00:38:15 INFO - mozinfo == 0.9 00:38:15 INFO - mozleak == 0.1 00:38:15 INFO - mozlog == 3.4 00:38:15 INFO - moznetwork == 0.27 00:38:15 INFO - mozprocess == 0.23 00:38:15 INFO - mozprofile == 0.28 00:38:15 INFO - mozrunner == 6.12 00:38:15 INFO - mozscreenshot == 0.1 00:38:15 INFO - mozsystemmonitor == 0.3 00:38:15 INFO - moztest == 0.7 00:38:15 INFO - mozversion == 1.4 00:38:15 INFO - psutil == 3.1.1 00:38:15 INFO - requests == 1.2.3 00:38:15 INFO - wsgiref == 0.1.2 00:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38: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')]} 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38: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')]} 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:15 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 00:38:15 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 00:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:15 INFO - 'HOME': '/Users/cltbld', 00:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:15 INFO - 'LOGNAME': 'cltbld', 00:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:15 INFO - 'MOZ_NO_REMOTE': '1', 00:38:15 INFO - 'NO_EM_RESTART': '1', 00:38:15 INFO - 'PAGER': '/bin/cat', 00:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:15 INFO - 'PWD': '/builds/slave/test', 00:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:15 INFO - 'SHELL': '/bin/bash', 00:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:15 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:15 INFO - 'USER': 'cltbld', 00:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:15 INFO - 'XPC_FLAGS': '0x0', 00:38:15 INFO - 'XPC_SERVICE_NAME': '0', 00:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 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)) 00:38:15 INFO - Cleaning up... 00:38:15 INFO - Return code: 0 00:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:38: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')]} 00:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38: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')]} 00:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:15 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 0x10140b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101381570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfab488e80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, '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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 00:38:15 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 00:38:15 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 00:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:15 INFO - 'HOME': '/Users/cltbld', 00:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:15 INFO - 'LOGNAME': 'cltbld', 00:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:15 INFO - 'MOZ_NO_REMOTE': '1', 00:38:15 INFO - 'NO_EM_RESTART': '1', 00:38:15 INFO - 'PAGER': '/bin/cat', 00:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:15 INFO - 'PWD': '/builds/slave/test', 00:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:15 INFO - 'SHELL': '/bin/bash', 00:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:15 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:15 INFO - 'USER': 'cltbld', 00:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:15 INFO - 'XPC_FLAGS': '0x0', 00:38:15 INFO - 'XPC_SERVICE_NAME': '0', 00:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:38:16 INFO - Cleaning up... 00:38:16 INFO - Return code: 0 00:38:16 INFO - Running post-action listener: _resource_record_post_action 00:38:16 INFO - Running post-action listener: _start_resource_monitoring 00:38:16 INFO - Starting resource monitoring. 00:38:16 INFO - [mozharness: 2016-09-22 07:38:16.146829Z] Finished create-virtualenv step (success) 00:38:16 INFO - [mozharness: 2016-09-22 07:38:16.147724Z] Running install step. 00:38:16 INFO - Running pre-action listener: _resource_record_pre_action 00:38:16 INFO - Running main action method: install 00:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:16 INFO - Reading from file tmpfile_stdout 00:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 00:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:38:16 INFO - Reading from file tmpfile_stdout 00:38:16 INFO - Output received: 00:38:16 INFO - Usage: mozinstall [options] installer 00:38:16 INFO - Options: 00:38:16 INFO - -h, --help show this help message and exit 00:38:16 INFO - -d DEST, --destination=DEST 00:38:16 INFO - Directory to install application into. [default: 00:38:16 INFO - "/builds/slave/test"] 00:38:16 INFO - --app=APP Application being installed. [default: firefox] 00:38:16 INFO - mkdir: /builds/slave/test/build/application 00:38:16 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'] 00:38:16 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 00:38:50 INFO - Reading from file tmpfile_stdout 00:38:50 INFO - Output received: 00:38:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:38:50 INFO - Running post-action listener: _resource_record_post_action 00:38:50 INFO - [mozharness: 2016-09-22 07:38:50.449169Z] Finished install step (success) 00:38:50 INFO - [mozharness: 2016-09-22 07:38:50.449301Z] Running run-tests step. 00:38:50 INFO - Running pre-action listener: _resource_record_pre_action 00:38:50 INFO - Running main action method: run_tests 00:38:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:38:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:38:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:38:50 INFO - 2016-09-22 00:38:50.463 screenresolution[1655:9267] starting screenresolution argv=screenresolution get 00:38:50 INFO - 2016-09-22 00:38:50.466 screenresolution[1655:9267] Display 0: 1600x1200x32@60 00:38:50 INFO - 2016-09-22 00:38:50.472 screenresolution[1656:9269] starting screenresolution argv=screenresolution list 00:38:50 INFO - Available Modes on Display 0 00:38:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:38:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:38:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:38:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:38:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:38:50 INFO - Intel Iris: 00:38:50 INFO - Chipset Model: Intel Iris 00:38:50 INFO - Type: GPU 00:38:50 INFO - Bus: Built-In 00:38:50 INFO - VRAM (Dynamic, Max): 1536 MB 00:38:50 INFO - Vendor: Intel (0x8086) 00:38:50 INFO - Device ID: 0x0a2e 00:38:50 INFO - Revision ID: 0x0009 00:38:50 INFO - Displays: 00:38:50 INFO - Display: 00:38:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:38:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:38:50 INFO - Display Serial Number: 1600x1200 60 00:38:50 INFO - Main Display: Yes 00:38:50 INFO - Mirror: Off 00:38:50 INFO - Online: Yes 00:38:50 INFO - Rotation: Supported 00:38:50 INFO - Return code: 0 00:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:38:50 INFO - Python 2.7.3 00:38:50 INFO - Return code: 0 00:38:50 INFO - grabbing minidump binary from tooltool 00:38:50 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')]} 00:38:50 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 0x10121fd30>, '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 0x101045db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101217b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:38:50 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 00:38:50 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 00:38:50 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 00:38:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:38:50 INFO - Return code: 0 00:38:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XwZ8wUkX8/Render', 00:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:50 INFO - 'HOME': '/Users/cltbld', 00:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:50 INFO - 'LOGNAME': 'cltbld', 00:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:50 INFO - 'MOZ_NO_REMOTE': '1', 00:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:38:50 INFO - 'NO_EM_RESTART': '1', 00:38:50 INFO - 'PAGER': '/bin/cat', 00:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:50 INFO - 'PWD': '/builds/slave/test', 00:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:50 INFO - 'SHELL': '/bin/bash', 00:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SHqlAeAlpc/Listeners', 00:38:50 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 00:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:50 INFO - 'USER': 'cltbld', 00:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:50 INFO - 'XPC_FLAGS': '0x0', 00:38:50 INFO - 'XPC_SERVICE_NAME': '0', 00:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:38:51 INFO - mozversion application_buildid: 20160921231359 00:38:51 INFO - mozversion application_changeset: 583124bcd4d9a222bbd4444682c6058643c36abb 00:38:51 INFO - mozversion application_display_name: Nightly 00:38:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:38:51 INFO - mozversion application_name: Firefox 00:38:51 INFO - mozversion application_remotingname: firefox 00:38:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:38:51 INFO - mozversion application_vendor: Mozilla 00:38:51 INFO - mozversion application_version: 52.0a1 00:38:51 INFO - mozversion platform_buildid: 20160921231359 00:38:51 INFO - mozversion platform_changeset: 583124bcd4d9a222bbd4444682c6058643c36abb 00:38:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:38:51 INFO - mozversion platform_version: 52.0a1 00:38:51 INFO - using testdate: 1474529931 00:38:51 INFO - actual date: 1474529931 00:38:51 INFO - starting webserver on 'localhost:49272' 00:38:51 INFO - SUITE-START | Running 2 tests 00:38:51 INFO - TEST-START | dromaeo_css 00:38:51 INFO - operating with platform_type : mac_ 00:38:51 INFO - Initialising browser for dromaeo_css test... 00:38:51 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp0xBDqm/profile http://localhost:49272/getInfo.html) 00:38:53 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 00:38:53 INFO - PROCESS | 1666 | colorDepth:24 00:38:53 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 00:38:53 INFO - PROCESS | 1666 | __metrics 00:38:53 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:38:53 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:38:54 INFO - TEST-INFO | 1666: exit 0 00:38:54 INFO - Browser initialized. 00:38:54 INFO - Running cycle 1/1 for dromaeo_css test... 00:38:54 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp0xBDqm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:39:06 INFO - PROCESS | 1669 | RSS: Main: 235315200 00:39:06 INFO - PROCESS | 1669 | 00:39:58 INFO - PROCESS | 1669 | 1474529998037 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] 00:42:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 00:42:10 INFO - PROCESS | 1669 | RSS: Main: 363212800 00:42:10 INFO - PROCESS | 1669 | 00:45:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 00:45:13 INFO - PROCESS | 1669 | RSS: Main: 378339328 00:45:13 INFO - PROCESS | 1669 | 00:48:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 00:48:16 INFO - PROCESS | 1669 | RSS: Main: 343879680 00:48:16 INFO - PROCESS | 1669 | 00:51:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 00:51:19 INFO - PROCESS | 1669 | RSS: Main: 352043008 00:51:19 INFO - PROCESS | 1669 | 00:54:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 00:54:23 INFO - PROCESS | 1669 | RSS: Main: 331735040 00:54:23 INFO - PROCESS | 1669 | 00:57:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 00:57:27 INFO - PROCESS | 1669 | RSS: Main: 397811712 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | __start_tp_report 00:57:27 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 00:57:27 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 00:57:27 INFO - PROCESS | 1669 | |i|pagename|runs| 00:57:27 INFO - PROCESS | 1669 | |0;dojo.html;2778.4720903028424;2829.2502486840986;3192.3455691583226;3234.0621219846244;3281.31092470581;5549.77800887965;5635.351934527531;5655.971720141393;5694.943050569493;5732.283464566929;5647.09646456567;5656.547476201904;5668.348139963895;5728.398518155585;5771.480566748992;5123.436421993578;5137.101007323722;5162.8709282268055;5173.534381905628;5254.632175747699;4502.7842482529695;5059.519345662156;5266.894662106755;5332.520073193412;5337.813176538822;5191.818286359997;5210.036143313499;5229.294045303893;5245.2132180173085;5300.708461034642;5068.847934561969;5111.1566591512355;5112.821051263188;5128.948710512885;5133.178691409394;3992.9201415971806;5085.389753229599;5089.287499750038;5103.693778373309;5105.285260063594;5646.887062258732;5667.1782591524;5687.289088863892;5703.344115426696;5704.657720536781;6029.246344206974;6054.909176362358;6062.272527296753;6132.662703551303;6171.13604095427;6015.428534289279;6093.550834974197;6098.492741543372;6139.6009259398;6230.96884515579;5702.515286200636;5704.800331988402;5709.115087161496;5709.8287051388525;5711.857203569944;6149.877002459926;6169.383061693795;6311.463525600284;6318;6328;5980.401959804072;6030.246219222598;6044.879102418015;6066.45401913821;6107.694615269308;6129.973805662966;6141.528693577439;6180.3201647818705;6190.969045154836;6196.907046394308;5972.163897054415;6105.8473538161015;6108.297545782203;6110.327863934964;6110.7861224856915;6004.609700369462;6045.909311360333;6113.602615829956;6128.448439640454;6135.447809697149;4865.440474345495;4865.659403841768;4873.244647079709;4885.267209918469;4916.606671466274;4397.802098905557;4410.3825464435;4416.779161041935;4425.09285596452;4440.911181776411;5611.2144299798065;5611.635243709227;5655.095184770417;5707.74315155819;5744.339400968942;6118.265808103056;6120.294761999531;6127.556056270569;6138.294096178996;6224.06639004153;5697.287839020122;5697.914531282034;5729.4843464088435;5732.828015159552;5752.568557358215;5318.521333080042;5352.812651557255;5354.839354819362;5357.223202635674;5363.463653634605;6155.784547540904;6205.782797602063;6245.219347581552;6310.652914089769;6311.084892690626;6182.196314479269;6186.536009799193;6200.596961197508;6207.006878899354;6210.72051757681;6338.397852204033;6341.524385671001;6353.809385718436;6354.809355719336;6357.141785859035;5956.195913551788;5960.523158147251;6004.729787159501;6025.096235564701;6070.089486576872;6061.302950160788;6182.536309776875;6191.659458729813;6200.534959878118;6216.875662486816;5967.940320596738;5979.551533634908;5991;5996.340402555628;6047.637141771508;4619.353290539394;5729.4843464088435;5818.679972601548;5976.671283079472;6008.669523176092;5813.941860581509;5826.067829147316;5859.853503662443;5888.3228428729535;5941.7623295067715;5981.234175644006;6003.969980150071;6017.789377371771;6027.276726792813;6038.426349496791;5686.687232202268;5717.228174196596;5752.022156233534;5811.4188581143235;5861.531077513703 00:57:27 INFO - PROCESS | 1669 | |1;ext.html;521.0542864700568;523.0271694647954;530.1491106773628;536.0966770990879;555.7110302642624;30875.691243087564;39428.40857387138;41522.16955660885;42572;42605.14789704204;35862.64137358626;43836.46572369968;43875;43888;43955.78022109893;8842.602082906285;8998.01021887592;9771.853422198656;9955.10404063634;9971.55412465192;11943.880561194364;12178;12179.33013684247;12429.81355279667;12450.875491245108;12119.818202726967;12173;12173.756524869541;12188.51245950161;12203.962663173641;12132.818007729848;12133.272003679807;12140.757184856342;12189.695257618541;12221.69445763863;12007.639770806889;12093.093018023683;12095.39523023854;12100.455479503444;12103.818442723366;41031.17937641231;41039.384409233884;41374;41467.7926610365;41472;3021.561873528326;3377.7804442711144;3505.7545971781988;3631.7457777955556;4054.067564460161;30455.69544304573;31259.062228133193;31934.361312773846;31938.361232775445;31983;2668.519666460036;2872.841993690346;3245.837708114585;3385.18755498681;3394.9490757638655;496463;502584;502830;503625;506143;60395;60660.696696516236;60738.696306518184;60805;60871.6956415224;60290.39709602936;63939.16365018114;64047;64058.6797066021;64164.679176603815;16116.516504504883;16334.183290835648;16354.264058117413;16382.344706211856;16396.344146234016;11581.594644187413;11787.880151385605;11806.173567850168;12499.875001250053;12643.178193417398;16758.581035473966;16817.990920544806;17065.658686826195;17103.401380951607;17124.315027398763;5965.850853728692;6081.331053584102;6145.156453064063;6152.815415537541;6215.471684906744;867.8134201146784;934.8317302885409;961.6101749693009;1004.3471743366724;1102.1568500097433;29878.850605746833;30216.71207538672;30268.394632107236;30764.230894227374;31206;988.7379844341256;1062.9893701063045;1101.1576144249655;1126.2566705974018;1172.6364826903687;14212.862970962298;15671.68656626884;15703;15841.920790396205;16165.515034548982;653354;659507;661698;662327;662626;58354.416455835744;58464.707676461345;58465.70767146222;58686.11970820441;58851.41148588545;1262.696952731338;1280.3982128399637;1349.5411560069426;1374.8075269462083;1404.1996062244423;25952.8702356487;30575.388492230475;31245;31827.840860795546;32537.674623253464;48089.5191048085;49893;50494.2425863605;50573.73565660888;50723.239151413494;537824;543789;544337;544856.5514344806;629791;24456.021759129435;25289.747102528738;25559.105431309814;25749;25786.226413207634;45784.313235302165;46199.76900115478;46225.76887115543;46270.07459850717;46366;32467.512987304737;37329.81335093307;38444;38837;39274.60725392824;35137;35206.64793352136;38900.6109938897;40166;41051.76844694664;38185;39168.2166356677;39387.40918886162;39469;39500.604993950845;31312;34648.30703385868;35147.82426087853;35275.47086793752;35342;25411.983520659705;25536.489270214865;25598.23205303844;25977.090801821847;26253.606195907458 00:57:27 INFO - PROCESS | 1669 | |2;jquery.html;332.85188091299364;354;375.7576363245707;386.127352184064;406.0660480893943;14937.626559336022;15236.390544378211;15984.290819199894;20771.376858694264;20831.375058748225;19709.90145049276;20108.296209632666;20712.27507037254;20721.171153153893;20964.790352096476;5679.602427830054;5850.824475265738;6095.3599872013465;6101.328853826098;6128;5183.948160518385;6019.488343490809;6058.242719660043;6074.635521868702;6078.969605151968;4145.54399016108;4395.011122497444;6315.873682526347;6599.67001649918;6646.93353066468;5749;6043.335233124353;6700.195976482804;6707.396334329909;6710.7315707371645;5882.735276912549;5917.349091599921;5940.851478713067;5949.315828679714;5962.0162673158875;12568.685782855411;12742.490300388066;23452.882735586212;23793;25099.62350564743;2027.3715148304072;2174.1303478608525;2471.4068623530225;2522.84465633692;2790.1350581319653;9445.622175112987;9511;9612.711618651452;10110.797784044351;10124.139448146916;1790.2570433270178;1814.129217975379;1860.283790740561;1872.5786697992978;1884.6230753849286;109318.45340773245;119879.4006029973;120527.3973630135;120532.7946720539;120752;10918;11242.550297988153;11250.718732031764;11419;11559.884401155881;14082.436702531784;14095;14158.29208539569;14168.433262669378;14175.503857364944;8216.46592971455;8391.790205244917;8392.580370981426;8397.160283971676;8467.110953349933;8392.202740739742;8419.621117049748;8423;8559.95720021396;8600.268977136888;4207.200631879933;4313.180495705806;4331.40564144927;4335.458067741532;4356.825726970949;1795.5690634247687;1829.6980948504563;1832.2762508808946;1874.8593855460622;1881.8021069409563;831.821158450936;882.250087425683;905.4341036851968;930.5626355612851;953.6172549802814;20050.398488045383;20567.8971605144;21737;21754.673679894815;21853.781462185492;872.3239489395769;894.4677916639589;902.6118768929292;912.3248795890993;918;10901.781964360669;11141.944290278496;11309.491072901574;11338.716532086764;11350.262232954832;573162;577101;586923;587288.0169586423;587294;122823;128917.35541322234;128977.71022289657;129667;131604;923.5705396990297;956.4309236004566;968.651285537206;970.8301047316692;974.1768205866032;18242.81757182411;18920.621587568447;19052.523686907938;19058.142383593047;19125.90437047806;56209;56845.71577142088;57050.14424783549;57256.278341907644;57785;48905.755471222416;78310.6084469574;79637.60181199056;82212;82577.58711206405;7729.652165652672;7866.449348545547;7972.681092756225;8052.154523775153;8218.876716849132;10191.050980235428;10636.30863993838;13143.73712525725;13242.668933276746;13366.799498007733;10895.455227238765;11054.00513953748;11294.60468883585;11319.09447244235;11471.483783229607;10799.082078023455;11008.614698485515;11157.13615538915;11162.609308674157;11189.216754827085;8186.590670466572;9348.719538413858;9888;9964.55159517838;10029.648962286285;7082.3979961703835;7265.418766498562;7356.117265928123;7399.038125043709;7516.962415187889;8902.465852048897;9520.66677666306;9663.222729982062;9832.754181145528;9864.950675246579 00:57:27 INFO - PROCESS | 1669 | |3;mootools.html;1324.2782683437529;1360.9591712248637;1553.2311505804628;1724.9223784929677;1937.2154277517611;7736.303732664059;7776.455648104635;8280.29617482514;8798.120187981198;8835.204831565157;8712.30301575874;8773.60518776655;8774.122587741223;8778;8778.2099611035;2338.1465764995783;2363.917262895799;2366.3965688749345;2367.763223677636;2368.7394386617457;2315.340128063502;2336.170659415908;2370.992328260491;2371.620540713486;2380.75002124777;2330.3009097270838;2350.4946436516148;2352.212008976986;2357.2574638988663;2363.2555744940373;2027.2093883385344;2305.101010605865;2315.6989591353185;2328.6739856420113;2333.171724037976;2312;2318.988405057981;2321.814254859607;2323.94190145246;2328.988355058231;8666.52334121623;8831.911680883173;8851.77870553235;8861.42400743956;8885.4668719877;4846.539578740014;5133.897322053575;5293.232481290192;5296.841094767163;5310;3473.8263086845554;3560.181158333598;3563.002359339389;3565.6612621800887;3567.02276961189;1081.621432498627;1097.0510508410248;1110.5613282753347;1118.6867677050438;1119.7424592343725;11438.19932604718;11536.826947595793;11543.307401556018;11544.422778861024;11562.05167682244;4382.780860957003;4465.106978604292;4471.776411179428;4558.452985641744;4586.862394128181;9055.456672599665;9061.54692265384;9066.410683305565;9069.410488318239;9095.181433671001;5154.226865970059;5162.92255616166;5171.741412929338;5172.250023746611;5186.455422180692;4045.3931910213705;4350.71720338177;4396.296592545177;4465.665075119314;4822.348982887335;3702.5742039665784;3764.8117594120185;3826.5025546678753;3837.9232415351535;3846.519185101862;1080.9081228095542;1109.944502774858;1160.5647882044234;1175.2595864605244;1189.79178643737;842.1957031035347;862.3920136304016;896.8654701794652;908.5502676175336;936.4334577580465;5616.943830561724;5682.886342273131;5944.603018290698;5999.220101386792;6008.948434024029;918.6049998500708;940.1162906867522;955.3360414511986;960.8078384323163;1008.1531513528671;3477.8608855646;4093.467849179647;4102.630763231324;4148.979255103705;4326.697131200785;10586.735331616772;10725.463726813628;10807.83788243177;10822;10857.891421085687;10756.946215268874;10757.408342541079;10758.838617420744;10771.353718776898;10845.783084338269;8064.798380040546;8259.8348033039;8267.793305167419;8279.58602069894;8287.337013038943;5760.855978600569;6070.089486577049;6130.233720784902;6139;6204.410580994799;9357.53212339394;9766.511674416393;9880.555375007998;10037.598496060367;10125.189984801345;10014.248931330034;10179.745506362104;10258.948705256425;10280.2803803736;10294;7164.462665300019;7205.88308812135;7501.699932002659;7549.547027178387;7659.69361225567;8277;8329.750107496784;8340;8374.371922105745;8402.453840500348;7478.326950574475;7558.470907036454;7571.091469023752;7635.5800430974605;7733.265339792711;7420.962895185489;7523.924760752322;7569.091708994956;7592.734254301073;7740.922590774246;6727.831804204934;6963.1296087989;6964.025036494996;6974.546654467444;6975.162980442176;5061.468545802785;5079.888156580669;5249.721476996236;5289.523942845162;5403.189521571796;5149.794008239778;5190.755777638976;5194.194899790538;5213.76538055796;5366.275552800322 00:57:27 INFO - PROCESS | 1669 | |4;prototype.html;277.9458005688891;289.2926793988697;290.66718607194775;299.41315022555784;301.7374883851049;5029.773660185291;5060.5951523878;5072.416672082707;5125.6412051156385;5219.817306394277;4377.7154484958455;5222.996776853305;5249.842504724855;5257.737113144347;5264.868378290545;3541.9645803541894;3711.1093337598986;3954.762714237155;3977.184677141194;3980.8304474061706;3725.795081270529;3754;3965.286248475273;3967.583403742609;4011.8135616089303;2990.9551356729667;3740.532433445819;3914.3345631242755;3939.5863434339267;3947.250022495731;3260.510923361503;3393.778239833658;3838.846446142151;3893.3914277434187;3894.4353068804867;3338.6327503974544;3353.815540145291;3362.5124356968104;3371.9494207586904;3386.5597472328686;4433.844815431445;4911.361523002022;4991.652253891429;5033.521815427529;5078.4413714491375;3511.6488351164935;4335.764307172472;4399.538048504893;4411.492678342;4449.709584220572;4569.47451043131;5416.079266524661;5419.918701219485;5440.898687747986;5470.425605311425;2816.5919237722383;2925.2594706149807;3536.257385948954;3661.6085887362897;3698.2973235085246;5391.622586418913;5656.66256908426;5672.631278966854;5690.715464226772;5720.795215516592;3702.81485925708;3707.2770809692393;3727.589965103836;3731.458938453909;3737;3636.61815509373;3775.131719704483;3802.239552089593;3807.638274363931;3809.9238015240094;3882.9223415532097;4336.436263285753;4365.410669559632;4374.62815660666;4416.359627854007;4993.275974983607;5319.0213480451075;5411.756470958738;5419.430959749248;5427;1051.0645525482328;1166.2069792540983;1269.771441140585;1288.8195652608642;1289.9548515801903;642.996785016072;744.7616762636013;802.193795235796;855.7304449098514;876.8334016536837;4690.742009189527;4740.502247264057;4970.446131016341;5035.420926593415;5085.7457127144235;4807.855764327076;5279.841604751864;5459;5560.833175004756;5580.1629755537;4346.195953748566;4800.303955926371;4852.708837469763;5083.848014231126;5088.567471764942;2472.5425796227755;2614.830036047651;2874.8131371460786;2960.0167887515418;2965.9258518536776;4873.975630121898;5516.448355164452;5792.420757924258;5797.681127537941;5845.853853653693;5387.24578559002;5699.487046165865;5707.3721890592005;5712.2288491054005;5736.71316434185;4586.793594288199;4998.925016124761;5775.27809023872;5777.88444231113;5780.277465316835;4500.842470513648;5546.809010440934;5581.358143813513;5586.452602597299;5598.468145526169;4891.364122664031;4933.161362568444;5448.147629805885;5541.944580554143;5558.249636299048;5532.28080349552;5778.653280803165;5792.333881603669;5821.534277257724;5826.475617194473;2746.986265068662;3745.943810842785;3747.9063023424633;3752.962470375261;3758.3047136279874;4952.529509696573;5338.772082420987;5589.469000444951;5630.5214056805635;5643.407442218508;4600.470945841137;5239.790408383622;5421.674699518042;5424.945750542444;5460;4544.954550454586;5200.349956255468;5419.6206265562605;5436.320459942507;5456.61803673739;4563.429571303587;5362.276092727432;5410.620291825717;5424.403315635356;5425.647332923348;5483.287172667528;5484.204790305464;5484.643498172606;5542.11326187808;5550.361708403424;4829.227323628203;5178.249153872743;5352.678839269656;5386.811461598825;5440.721430463917 00:57:27 INFO - PROCESS | 1669 | |5;yui.html;737.7012310014444;742.3170682971669;748.2891253309358;778.828657695307;818.5457071325419;15379.769303460444;16289.266982985764;16293.59266018347;16320.591985200375;16381.017138971654;14547.490837820678;14644.414223431077;14654.120752754816;14660.340284687189;14681.412743490275;715.4133610439442;736.7163641997815;742.940564754821;865.4720620421538;878.6221924572448;884.2572239318971;899.9920089499736;901.5086777706166;903.471469190521;906.9410488318272;935.3452583191759;954.1460392948308;955.0544960489135;956.268454632207;956.9760755981087;945.7493764152505;946.1673727120125;947.209080417852;947.2847999760171;949.9715008549755;548.6653141583631;576.1357963055417;680.9489288303348;711.121764620693;715.0132816712954;14802.40790368384;15019.849801501954;15020.624484387869;15084.39662413502;15115.732640103963;13807;14204.218767967757;14278.214698191596;14330.713385732332;14354;10926.180536459718;12768.872311276955;12806.29565373904;12830.935845320808;13206.537771178058;4484.2376795944765;4631.073785242965;4631.652626053059;4633.513481084505;4689;117166.82833171645;121116.39441802734;125517.82062883356;125726;125814.37092814568;10773.407462589634;11092.389918554396;11345.567577261148;11357.261777984404;11547.249428787101;22439.21462748796;22463.88768056182;22472.763997979942;22487.437814054778;22523;7850.646720897459;8074.717384891501;8173;8207.835843283101;8211.17888211174;4392.670549708785;4529.343245229489;4607.76961151941;4642.953570464252;4758.7858546364805;3200.6159260888844;3253;3310.6358300586917;3324.5678061852286;3333.033420308132;636.8821767972939;640.8077576726963;641.0896526931768;655.220287857448;658.649767975648;590.4656286061122;618.9226346706662;633.740166531729;641.9743210271537;649.0912722188879;6825.448677971455;8433.156684331518;8716.520591367409;8970.506622135714;8997.981509631387;508.01619675168524;573.2604939627917;636.6084857812413;660.9490909453991;671.684308375063;4245.405643209953;4626.773904915201;4655;4940.184869496565;5058.747062646853;101122;105531;132410.33794831156;161360.15919522432;168029;136402;140882.2955885214;141503;142507;142993;101686.49156754169;106327;107336.46331768291;107507;111775.58692956572;8990.505522196341;9454.14912657864;9766.218702503924;9965.451900145561;9997.450140242356;51570.484295156566;59455.56805399325;61505;62569;63505;93996.59005115066;95021;95136;95815.52092239494;98008;12677.328727005619;13016.15394999322;13258.270795106362;13315.80157785804;13477.258750768802;14410.855891441372;14499.275036248357;14779.408823647364;15041.774373384627;15292.405937004998;13694.726105477635;13862.861371386158;13884.841832152802;14005.439782408997;14201;10978.286411383235;13153.145045572008;13395.933020334836;13428.19430834153;13803.930980345034;13433.26117063571;13492.730145397234;13645.317734113056;13943.930280348939;14150.929245353707;10899.564017439214;10900.454977251264;10999.120070394509;11162.107031437303;11599.246049006788;9748.366356186825;10920.726981825517;11433.428328583705;11503.309801411942;11662.416879156179 00:57:27 INFO - PROCESS | 1669 | __end_tp_report 00:57:27 INFO - PROCESS | 1669 | __start_cc_report 00:57:27 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1086 00:57:27 INFO - PROCESS | 1669 | __end_cc_report 00:57:27 INFO - PROCESS | 1669 | __startTimestamp1474531047088__endTimestamp 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | ------- Summary: start ------- 00:57:27 INFO - PROCESS | 1669 | Number of tests: 6 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5653.21 Median:5818.68 stddev:672.48 (11.6%) stddev-sans-first:635.61 00:57:27 INFO - PROCESS | 1669 | Values: 2778.5 2829.3 3192.3 3234.1 3281.3 5549.8 5635.4 5656.0 5694.9 5732.3 5647.1 5656.5 5668.3 5728.4 5771.5 5123.4 5137.1 5162.9 5173.5 5254.6 4502.8 5059.5 5266.9 5332.5 5337.8 5191.8 5210.0 5229.3 5245.2 5300.7 5068.8 5111.2 5112.8 5128.9 5133.2 3992.9 5085.4 5089.3 5103.7 5105.3 5646.9 5667.2 5687.3 5703.3 5704.7 6029.2 6054.9 6062.3 6132.7 6171.1 6015.4 6093.6 6098.5 6139.6 6231.0 5702.5 5704.8 5709.1 5709.8 5711.9 6149.9 6169.4 6311.5 6318.0 6328.0 5980.4 6030.2 6044.9 6066.5 6107.7 6130.0 6141.5 6180.3 6191.0 6196.9 5972.2 6105.8 6108.3 6110.3 6110.8 6004.6 6045.9 6113.6 6128.4 6135.4 4865.4 4865.7 4873.2 4885.3 4916.6 4397.8 4410.4 4416.8 4425.1 4440.9 5611.2 5611.6 5655.1 5707.7 5744.3 6118.3 6120.3 6127.6 6138.3 6224.1 5697.3 5697.9 5729.5 5732.8 5752.6 5318.5 5352.8 5354.8 5357.2 5363.5 6155.8 6205.8 6245.2 6310.7 6311.1 6182.2 6186.5 6200.6 6207.0 6210.7 6338.4 6341.5 6353.8 6354.8 6357.1 5956.2 5960.5 6004.7 6025.1 6070.1 6061.3 6182.5 6191.7 6200.5 6216.9 5967.9 5979.6 5991.0 5996.3 6047.6 4619.4 5729.5 5818.7 5976.7 6008.7 5813.9 5826.1 5859.9 5888.3 5941.8 5981.2 6004.0 6017.8 6027.3 6038.4 5686.7 5717.2 5752.0 5811.4 5861.5 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:70891.28 Median:35241.06 stddev:154458.92 (438.3%) stddev-sans-first:154801.85 00:57:27 INFO - PROCESS | 1669 | Values: 521.1 523.0 530.1 536.1 555.7 30875.7 39428.4 41522.2 42572.0 42605.1 35862.6 43836.5 43875.0 43888.0 43955.8 8842.6 8998.0 9771.9 9955.1 9971.6 11943.9 12178.0 12179.3 12429.8 12450.9 12119.8 12173.0 12173.8 12188.5 12204.0 12132.8 12133.3 12140.8 12189.7 12221.7 12007.6 12093.1 12095.4 12100.5 12103.8 41031.2 41039.4 41374.0 41467.8 41472.0 3021.6 3377.8 3505.8 3631.7 4054.1 30455.7 31259.1 31934.4 31938.4 31983.0 2668.5 2872.8 3245.8 3385.2 3394.9 496463.0 502584.0 502830.0 503625.0 506143.0 60395.0 60660.7 60738.7 60805.0 60871.7 60290.4 63939.2 64047.0 64058.7 64164.7 16116.5 16334.2 16354.3 16382.3 16396.3 11581.6 11787.9 11806.2 12499.9 12643.2 16758.6 16818.0 17065.7 17103.4 17124.3 5965.9 6081.3 6145.2 6152.8 6215.5 867.8 934.8 961.6 1004.3 1102.2 29878.9 30216.7 30268.4 30764.2 31206.0 988.7 1063.0 1101.2 1126.3 1172.6 14212.9 15671.7 15703.0 15841.9 16165.5 653354.0 659507.0 661698.0 662327.0 662626.0 58354.4 58464.7 58465.7 58686.1 58851.4 1262.7 1280.4 1349.5 1374.8 1404.2 25952.9 30575.4 31245.0 31827.8 32537.7 48089.5 49893.0 50494.2 50573.7 50723.2 537824.0 543789.0 544337.0 544856.6 629791.0 24456.0 25289.7 25559.1 25749.0 25786.2 45784.3 46199.8 46225.8 46270.1 46366.0 32467.5 37329.8 38444.0 38837.0 39274.6 35137.0 35206.6 38900.6 40166.0 41051.8 38185.0 39168.2 39387.4 39469.0 39500.6 31312.0 34648.3 35147.8 35275.5 35342.0 25412.0 25536.5 25598.2 25977.1 26253.6 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34254.88 Median:4322.29 stddev:97440.65 (2254.4%) stddev-sans-first:97680.70 00:57:27 INFO - PROCESS | 1669 | Values: 332.9 354.0 375.8 386.1 406.1 14937.6 15236.4 15984.3 20771.4 20831.4 19709.9 20108.3 20712.3 20721.2 20964.8 5679.6 5850.8 6095.4 6101.3 6128.0 5183.9 6019.5 6058.2 6074.6 6079.0 4145.5 4395.0 6315.9 6599.7 6646.9 5749.0 6043.3 6700.2 6707.4 6710.7 5882.7 5917.3 5940.9 5949.3 5962.0 12568.7 12742.5 23452.9 23793.0 25099.6 2027.4 2174.1 2471.4 2522.8 2790.1 9445.6 9511.0 9612.7 10110.8 10124.1 1790.3 1814.1 1860.3 1872.6 1884.6 109318.5 119879.4 120527.4 120532.8 120752.0 10918.0 11242.6 11250.7 11419.0 11559.9 14082.4 14095.0 14158.3 14168.4 14175.5 8216.5 8391.8 8392.6 8397.2 8467.1 8392.2 8419.6 8423.0 8560.0 8600.3 4207.2 4313.2 4331.4 4335.5 4356.8 1795.6 1829.7 1832.3 1874.9 1881.8 831.8 882.3 905.4 930.6 953.6 20050.4 20567.9 21737.0 21754.7 21853.8 872.3 894.5 902.6 912.3 918.0 10901.8 11141.9 11309.5 11338.7 11350.3 573162.0 577101.0 586923.0 587288.0 587294.0 122823.0 128917.4 128977.7 129667.0 131604.0 923.6 956.4 968.7 970.8 974.2 18242.8 18920.6 19052.5 19058.1 19125.9 56209.0 56845.7 57050.1 57256.3 57785.0 48905.8 78310.6 79637.6 82212.0 82577.6 7729.7 7866.4 7972.7 8052.2 8218.9 10191.1 10636.3 13143.7 13242.7 13366.8 10895.5 11054.0 11294.6 11319.1 11471.5 10799.1 11008.6 11157.1 11162.6 11189.2 8186.6 9348.7 9888.0 9964.6 10029.6 7082.4 7265.4 7356.1 7399.0 7517.0 8902.5 9520.7 9663.2 9832.8 9865.0 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5678.34 Median:5106.89 stddev:3180.40 (62.3%) stddev-sans-first:3172.49 00:57:27 INFO - PROCESS | 1669 | Values: 1324.3 1361.0 1553.2 1724.9 1937.2 7736.3 7776.5 8280.3 8798.1 8835.2 8712.3 8773.6 8774.1 8778.0 8778.2 2338.1 2363.9 2366.4 2367.8 2368.7 2315.3 2336.2 2371.0 2371.6 2380.8 2330.3 2350.5 2352.2 2357.3 2363.3 2027.2 2305.1 2315.7 2328.7 2333.2 2312.0 2319.0 2321.8 2323.9 2329.0 8666.5 8831.9 8851.8 8861.4 8885.5 4846.5 5133.9 5293.2 5296.8 5310.0 3473.8 3560.2 3563.0 3565.7 3567.0 1081.6 1097.1 1110.6 1118.7 1119.7 11438.2 11536.8 11543.3 11544.4 11562.1 4382.8 4465.1 4471.8 4558.5 4586.9 9055.5 9061.5 9066.4 9069.4 9095.2 5154.2 5162.9 5171.7 5172.3 5186.5 4045.4 4350.7 4396.3 4465.7 4822.3 3702.6 3764.8 3826.5 3837.9 3846.5 1080.9 1109.9 1160.6 1175.3 1189.8 842.2 862.4 896.9 908.6 936.4 5616.9 5682.9 5944.6 5999.2 6008.9 918.6 940.1 955.3 960.8 1008.2 3477.9 4093.5 4102.6 4149.0 4326.7 10586.7 10725.5 10807.8 10822.0 10857.9 10756.9 10757.4 10758.8 10771.4 10845.8 8064.8 8259.8 8267.8 8279.6 8287.3 5760.9 6070.1 6130.2 6139.0 6204.4 9357.5 9766.5 9880.6 10037.6 10125.2 10014.2 10179.7 10258.9 10280.3 10294.0 7164.5 7205.9 7501.7 7549.5 7659.7 8277.0 8329.8 8340.0 8374.4 8402.5 7478.3 7558.5 7571.1 7635.6 7733.3 7421.0 7523.9 7569.1 7592.7 7740.9 6727.8 6963.1 6964.0 6974.5 6975.2 5061.5 5079.9 5249.7 5289.5 5403.2 5149.8 5190.8 5194.2 5213.8 5366.3 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4376.68 Median:4981.05 stddev:1385.14 (27.8%) stddev-sans-first:1354.43 00:57:27 INFO - PROCESS | 1669 | Values: 277.9 289.3 290.7 299.4 301.7 5029.8 5060.6 5072.4 5125.6 5219.8 4377.7 5223.0 5249.8 5257.7 5264.9 3542.0 3711.1 3954.8 3977.2 3980.8 3725.8 3754.0 3965.3 3967.6 4011.8 2991.0 3740.5 3914.3 3939.6 3947.3 3260.5 3393.8 3838.8 3893.4 3894.4 3338.6 3353.8 3362.5 3371.9 3386.6 4433.8 4911.4 4991.7 5033.5 5078.4 3511.6 4335.8 4399.5 4411.5 4449.7 4569.5 5416.1 5419.9 5440.9 5470.4 2816.6 2925.3 3536.3 3661.6 3698.3 5391.6 5656.7 5672.6 5690.7 5720.8 3702.8 3707.3 3727.6 3731.5 3737.0 3636.6 3775.1 3802.2 3807.6 3809.9 3882.9 4336.4 4365.4 4374.6 4416.4 4993.3 5319.0 5411.8 5419.4 5427.0 1051.1 1166.2 1269.8 1288.8 1290.0 643.0 744.8 802.2 855.7 876.8 4690.7 4740.5 4970.4 5035.4 5085.7 4807.9 5279.8 5459.0 5560.8 5580.2 4346.2 4800.3 4852.7 5083.8 5088.6 2472.5 2614.8 2874.8 2960.0 2965.9 4874.0 5516.4 5792.4 5797.7 5845.9 5387.2 5699.5 5707.4 5712.2 5736.7 4586.8 4998.9 5775.3 5777.9 5780.3 4500.8 5546.8 5581.4 5586.5 5598.5 4891.4 4933.2 5448.1 5541.9 5558.2 5532.3 5778.7 5792.3 5821.5 5826.5 2747.0 3745.9 3747.9 3753.0 3758.3 4952.5 5338.8 5589.5 5630.5 5643.4 4600.5 5239.8 5421.7 5424.9 5460.0 4545.0 5200.3 5419.6 5436.3 5456.6 4563.4 5362.3 5410.6 5424.4 5425.6 5483.3 5484.2 5484.6 5542.1 5550.4 4829.2 5178.2 5352.7 5386.8 5440.7 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:25193.70 Median:3281.82 stddev:40301.36 (1228.0%) stddev-sans-first:40372.59 00:57:27 INFO - PROCESS | 1669 | Values: 737.7 742.3 748.3 778.8 818.5 15379.8 16289.3 16293.6 16320.6 16381.0 14547.5 14644.4 14654.1 14660.3 14681.4 715.4 736.7 742.9 865.5 878.6 884.3 900.0 901.5 903.5 906.9 935.3 954.1 955.1 956.3 957.0 945.7 946.2 947.2 947.3 950.0 548.7 576.1 680.9 711.1 715.0 14802.4 15019.8 15020.6 15084.4 15115.7 13807.0 14204.2 14278.2 14330.7 14354.0 10926.2 12768.9 12806.3 12830.9 13206.5 4484.2 4631.1 4631.7 4633.5 4689.0 117166.8 121116.4 125517.8 125726.0 125814.4 10773.4 11092.4 11345.6 11357.3 11547.2 22439.2 22463.9 22472.8 22487.4 22523.0 7850.6 8074.7 8173.0 8207.8 8211.2 4392.7 4529.3 4607.8 4643.0 4758.8 3200.6 3253.0 3310.6 3324.6 3333.0 636.9 640.8 641.1 655.2 658.6 590.5 618.9 633.7 642.0 649.1 6825.4 8433.2 8716.5 8970.5 8998.0 508.0 573.3 636.6 660.9 671.7 4245.4 4626.8 4655.0 4940.2 5058.7 101122.0 105531.0 132410.3 161360.2 168029.0 136402.0 140882.3 141503.0 142507.0 142993.0 101686.5 106327.0 107336.5 107507.0 111775.6 8990.5 9454.1 9766.2 9965.5 9997.5 51570.5 59455.6 61505.0 62569.0 63505.0 93996.6 95021.0 95136.0 95815.5 98008.0 12677.3 13016.2 13258.3 13315.8 13477.3 14410.9 14499.3 14779.4 15041.8 15292.4 13694.7 13862.9 13884.8 14005.4 14201.0 10978.3 13153.1 13395.9 13428.2 13803.9 13433.3 13492.7 13645.3 13943.9 14150.9 10899.6 10900.5 10999.1 11162.1 11599.2 9748.4 10920.7 11433.4 11503.3 11662.4 00:57:27 INFO - PROCESS | 1669 | -------- Summary: end -------- 00:57:27 INFO - PROCESS | 1669 | 00:57:27 INFO - TEST-INFO | 1669: exit 0 00:57:27 INFO - TEST-OK | dromaeo_css | took 1116681ms 00:57:27 INFO - TEST-START | kraken 00:57:27 INFO - operating with platform_type : mac_ 00:57:27 INFO - Initialising browser for kraken test... 00:57:27 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpDkLPWO/profile http://localhost:49272/getInfo.html) 00:57:30 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 00:57:30 INFO - PROCESS | 1673 | colorDepth:24 00:57:30 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 00:57:30 INFO - PROCESS | 1673 | __metrics 00:57:30 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:57:30 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:30 INFO - TEST-INFO | 1673: exit 0 00:57:30 INFO - Browser initialized. 00:57:30 INFO - Running cycle 1/1 for kraken test... 00:57:30 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpDkLPWO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:43 INFO - PROCESS | 1674 | RSS: Main: 235458560 00:57:43 INFO - PROCESS | 1674 | 00:57:45 INFO - PROCESS | 1674 | 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) 00:57:46 INFO - PROCESS | 1674 | RSS: Main: 293888000 00:57:46 INFO - PROCESS | 1674 | 00:57:49 INFO - PROCESS | 1674 | 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) 00:57:49 INFO - PROCESS | 1674 | RSS: Main: 294084608 00:57:49 INFO - PROCESS | 1674 | 00:57:53 INFO - PROCESS | 1674 | 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) 00:57:54 INFO - PROCESS | 1674 | RSS: Main: 386424832 00:57:54 INFO - PROCESS | 1674 | 00:57:56 INFO - PROCESS | 1674 | 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) 00:57:56 INFO - PROCESS | 1674 | RSS: Main: 285278208 00:57:56 INFO - PROCESS | 1674 | 00:57:58 INFO - PROCESS | 1674 | 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) 00:57:59 INFO - PROCESS | 1674 | RSS: Main: 289931264 00:57:59 INFO - PROCESS | 1674 | 00:58:02 INFO - PROCESS | 1674 | 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) 00:58:02 INFO - PROCESS | 1674 | RSS: Main: 326520832 00:58:02 INFO - PROCESS | 1674 | 00:58:05 INFO - PROCESS | 1674 | 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) 00:58:06 INFO - PROCESS | 1674 | RSS: Main: 327790592 00:58:06 INFO - PROCESS | 1674 | 00:58:09 INFO - PROCESS | 1674 | 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) 00:58:09 INFO - PROCESS | 1674 | RSS: Main: 326774784 00:58:09 INFO - PROCESS | 1674 | 00:58:11 INFO - PROCESS | 1674 | 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) 00:58:11 INFO - PROCESS | 1674 | RSS: Main: 299782144 00:58:11 INFO - PROCESS | 1674 | 00:58:13 INFO - PROCESS | 1674 | 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) 00:58:14 INFO - PROCESS | 1674 | RSS: Main: 305819648 00:58:14 INFO - PROCESS | 1674 | 00:58:16 INFO - PROCESS | 1674 | 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) 00:58:17 INFO - PROCESS | 1674 | RSS: Main: 307924992 00:58:17 INFO - PROCESS | 1674 | 00:58:20 INFO - PROCESS | 1674 | 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) 00:58:20 INFO - PROCESS | 1674 | RSS: Main: 320094208 00:58:20 INFO - PROCESS | 1674 | 00:58:23 INFO - PROCESS | 1674 | 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) 00:58:24 INFO - PROCESS | 1674 | RSS: Main: 316157952 00:58:24 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | 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) 00:58:26 INFO - PROCESS | 1674 | RSS: Main: 359903232 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | __start_tp_report 00:58:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 00:58:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 00:58:26 INFO - PROCESS | 1674 | |i|pagename|runs| 00:58:26 INFO - PROCESS | 1674 | |0;ai-astar;111;112;113;113;111;112;110;112;112;112 00:58:26 INFO - PROCESS | 1674 | |1;audio-beat-detection;145;108;104;126;102;126;93;130;173;136 00:58:26 INFO - PROCESS | 1674 | |2;audio-dft;182;185;199;265;195;185;181;184;184;182 00:58:26 INFO - PROCESS | 1674 | |3;audio-fft;78;58;59;86;64;83;78;83;108;57 00:58:26 INFO - PROCESS | 1674 | |4;audio-oscillator;82;72;91;69;67;69;93;69;70;89 00:58:26 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;86;87;81;89;84;87;84;86;84 00:58:26 INFO - PROCESS | 1674 | |6;imaging-darkroom;92;93;93;92;92;94;93;93;93;94 00:58:26 INFO - PROCESS | 1674 | |7;imaging-desaturate;119;135;104;84;85;85;87;86;86;85 00:58:26 INFO - PROCESS | 1674 | |8;json-parse-financial;56;55;52;52;51;53;52;54;53;52 00:58:26 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;65;72;68;75;73;70;70;69;71;70 00:58:26 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;86;85;88;86;87;85;84;84;88;90 00:58:26 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;142;143;141;145;149;150;143;136;191;149 00:58:26 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;171;167;172;167;165;167;168;165;168;168 00:58:26 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;69;67;68;67;66;67;68;67;67 00:58:26 INFO - PROCESS | 1674 | __end_tp_report 00:58:26 INFO - PROCESS | 1674 | __start_cc_report 00:58:26 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1988 00:58:26 INFO - PROCESS | 1674 | __end_cc_report 00:58:26 INFO - PROCESS | 1674 | __startTimestamp1474531106355__endTimestamp 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | ------- Summary: start ------- 00:58:26 INFO - PROCESS | 1674 | Number of tests: 14 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 00:58:26 INFO - PROCESS | 1674 | Values: 111.0 112.0 113.0 113.0 111.0 112.0 110.0 112.0 112.0 112.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:133.00 stddev:23.87 (18.0%) stddev-sans-first:24.12 00:58:26 INFO - PROCESS | 1674 | Values: 145.0 108.0 104.0 126.0 102.0 126.0 93.0 130.0 173.0 136.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:194.20 Median:185.00 stddev:25.57 (13.8%) stddev-sans-first:26.74 00:58:26 INFO - PROCESS | 1674 | Values: 182.0 185.0 199.0 265.0 195.0 185.0 181.0 184.0 184.0 182.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:75.40 Median:78.00 stddev:16.14 (20.7%) stddev-sans-first:17.09 00:58:26 INFO - PROCESS | 1674 | Values: 78.0 58.0 59.0 86.0 64.0 83.0 78.0 83.0 108.0 57.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.00 stddev:10.47 (13.6%) stddev-sans-first:10.96 00:58:26 INFO - PROCESS | 1674 | Values: 82.0 72.0 91.0 69.0 67.0 69.0 93.0 69.0 70.0 89.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:2.27 (2.6%) stddev-sans-first:2.35 00:58:26 INFO - PROCESS | 1674 | Values: 87.0 86.0 87.0 81.0 89.0 84.0 87.0 84.0 86.0 84.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 00:58:26 INFO - PROCESS | 1674 | Values: 92.0 93.0 93.0 92.0 92.0 94.0 93.0 93.0 93.0 94.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:85.00 stddev:17.95 (21.1%) stddev-sans-first:16.93 00:58:26 INFO - PROCESS | 1674 | Values: 119.0 135.0 104.0 84.0 85.0 85.0 87.0 86.0 86.0 85.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.56 (2.9%) stddev-sans-first:1.22 00:58:26 INFO - PROCESS | 1674 | Values: 56.0 55.0 52.0 52.0 51.0 53.0 52.0 54.0 53.0 52.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:2.75 (3.9%) stddev-sans-first:2.15 00:58:26 INFO - PROCESS | 1674 | Values: 65.0 72.0 68.0 75.0 73.0 70.0 70.0 69.0 71.0 70.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.95 (2.3%) stddev-sans-first:2.06 00:58:26 INFO - PROCESS | 1674 | Values: 86.0 85.0 88.0 86.0 87.0 85.0 84.0 84.0 88.0 90.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:147.00 stddev:15.40 (10.5%) stddev-sans-first:16.13 00:58:26 INFO - PROCESS | 1674 | Values: 142.0 143.0 141.0 145.0 149.0 150.0 143.0 136.0 191.0 149.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.25 (1.3%) stddev-sans-first:2.07 00:58:26 INFO - PROCESS | 1674 | Values: 171.0 167.0 172.0 167.0 165.0 167.0 168.0 165.0 168.0 168.0 00:58:26 INFO - PROCESS | 1674 | 00:58:26 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 00:58:26 INFO - PROCESS | 1674 | Values: 67.0 69.0 67.0 68.0 67.0 66.0 67.0 68.0 67.0 67.0 00:58:26 INFO - PROCESS | 1674 | -------- Summary: end -------- 00:58:26 INFO - PROCESS | 1674 | 00:58:27 INFO - TEST-INFO | 1674: exit 0 00:58:27 INFO - TEST-OK | kraken | took 59456ms 00:58:27 INFO - SUITE-END | took 1176s 00:58:27 INFO - Completed test suite (00:19:36) 00:58:27 INFO - javascript benchmark 00:58:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2778.4720903028424, 2829.2502486840986, 3192.3455691583226, 3234.0621219846244, 3281.31092470581, 5549.77800887965, 5635.351934527531, 5655.971720141393, 5694.943050569493, 5732.283464566929, 5647.09646456567, 5656.547476201904, 5668.348139963895, 5728.398518155585, 5771.480566748992, 5123.436421993578, 5137.101007323722, 5162.8709282268055, 5173.534381905628, 5254.632175747699, 4502.7842482529695, 5059.519345662156, 5266.894662106755, 5332.520073193412, 5337.813176538822, 5191.818286359997, 5210.036143313499, 5229.294045303893, 5245.2132180173085, 5300.708461034642, 5068.847934561969, 5111.1566591512355, 5112.821051263188, 5128.948710512885, 5133.178691409394, 3992.9201415971806, 5085.389753229599, 5089.287499750038, 5103.693778373309, 5105.285260063594, 5646.887062258732, 5667.1782591524, 5687.289088863892, 5703.344115426696, 5704.657720536781, 6029.246344206974, 6054.909176362358, 6062.272527296753, 6132.662703551303, 6171.13604095427, 6015.428534289279, 6093.550834974197, 6098.492741543372, 6139.6009259398, 6230.96884515579, 5702.515286200636, 5704.800331988402, 5709.115087161496, 5709.8287051388525, 5711.857203569944, 6149.877002459926, 6169.383061693795, 6311.463525600284, 6318.0, 6328.0, 5980.401959804072, 6030.246219222598, 6044.879102418015, 6066.45401913821, 6107.694615269308, 6129.973805662966, 6141.528693577439, 6180.3201647818705, 6190.969045154836, 6196.907046394308, 5972.163897054415, 6105.8473538161015, 6108.297545782203, 6110.327863934964, 6110.7861224856915, 6004.609700369462, 6045.909311360333, 6113.602615829956, 6128.448439640454, 6135.447809697149, 4865.440474345495, 4865.659403841768, 4873.244647079709, 4885.267209918469, 4916.606671466274, 4397.802098905557, 4410.3825464435, 4416.779161041935, 4425.09285596452, 4440.911181776411, 5611.2144299798065, 5611.635243709227, 5655.095184770417, 5707.74315155819, 5744.339400968942, 6118.265808103056, 6120.294761999531, 6127.556056270569, 6138.294096178996, 6224.06639004153, 5697.287839020122, 5697.914531282034, 5729.4843464088435, 5732.828015159552, 5752.568557358215, 5318.521333080042, 5352.812651557255, 5354.839354819362, 5357.223202635674, 5363.463653634605, 6155.784547540904, 6205.782797602063, 6245.219347581552, 6310.652914089769, 6311.084892690626, 6182.196314479269, 6186.536009799193, 6200.596961197508, 6207.006878899354, 6210.72051757681, 6338.397852204033, 6341.524385671001, 6353.809385718436, 6354.809355719336, 6357.141785859035, 5956.195913551788, 5960.523158147251, 6004.729787159501, 6025.096235564701, 6070.089486576872, 6061.302950160788, 6182.536309776875, 6191.659458729813, 6200.534959878118, 6216.875662486816, 5967.940320596738, 5979.551533634908, 5991.0, 5996.340402555628, 6047.637141771508, 4619.353290539394, 5729.4843464088435, 5818.679972601548, 5976.671283079472, 6008.669523176092, 5813.941860581509, 5826.067829147316, 5859.853503662443, 5888.3228428729535, 5941.7623295067715, 5981.234175644006, 6003.969980150071, 6017.789377371771, 6027.276726792813, 6038.426349496791, 5686.687232202268, 5717.228174196596, 5752.022156233534, 5811.4188581143235, 5861.531077513703], "value": 5606.241523110278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [521.0542864700568, 523.0271694647954, 530.1491106773628, 536.0966770990879, 555.7110302642624, 30875.691243087564, 39428.40857387138, 41522.16955660885, 42572.0, 42605.14789704204, 35862.64137358626, 43836.46572369968, 43875.0, 43888.0, 43955.78022109893, 8842.602082906285, 8998.01021887592, 9771.853422198656, 9955.10404063634, 9971.55412465192, 11943.880561194364, 12178.0, 12179.33013684247, 12429.81355279667, 12450.875491245108, 12119.818202726967, 12173.0, 12173.756524869541, 12188.51245950161, 12203.962663173641, 12132.818007729848, 12133.272003679807, 12140.757184856342, 12189.695257618541, 12221.69445763863, 12007.639770806889, 12093.093018023683, 12095.39523023854, 12100.455479503444, 12103.818442723366, 41031.17937641231, 41039.384409233884, 41374.0, 41467.7926610365, 41472.0, 3021.561873528326, 3377.7804442711144, 3505.7545971781988, 3631.7457777955556, 4054.067564460161, 30455.69544304573, 31259.062228133193, 31934.361312773846, 31938.361232775445, 31983.0, 2668.519666460036, 2872.841993690346, 3245.837708114585, 3385.18755498681, 3394.9490757638655, 496463.0, 502584.0, 502830.0, 503625.0, 506143.0, 60395.0, 60660.696696516236, 60738.696306518184, 60805.0, 60871.6956415224, 60290.39709602936, 63939.16365018114, 64047.0, 64058.6797066021, 64164.679176603815, 16116.516504504883, 16334.183290835648, 16354.264058117413, 16382.344706211856, 16396.344146234016, 11581.594644187413, 11787.880151385605, 11806.173567850168, 12499.875001250053, 12643.178193417398, 16758.581035473966, 16817.990920544806, 17065.658686826195, 17103.401380951607, 17124.315027398763, 5965.850853728692, 6081.331053584102, 6145.156453064063, 6152.815415537541, 6215.471684906744, 867.8134201146784, 934.8317302885409, 961.6101749693009, 1004.3471743366724, 1102.1568500097433, 29878.850605746833, 30216.71207538672, 30268.394632107236, 30764.230894227374, 31206.0, 988.7379844341256, 1062.9893701063045, 1101.1576144249655, 1126.2566705974018, 1172.6364826903687, 14212.862970962298, 15671.68656626884, 15703.0, 15841.920790396205, 16165.515034548982, 653354.0, 659507.0, 661698.0, 662327.0, 662626.0, 58354.416455835744, 58464.707676461345, 58465.70767146222, 58686.11970820441, 58851.41148588545, 1262.696952731338, 1280.3982128399637, 1349.5411560069426, 1374.8075269462083, 1404.1996062244423, 25952.8702356487, 30575.388492230475, 31245.0, 31827.840860795546, 32537.674623253464, 48089.5191048085, 49893.0, 50494.2425863605, 50573.73565660888, 50723.239151413494, 537824.0, 543789.0, 544337.0, 544856.5514344806, 629791.0, 24456.021759129435, 25289.747102528738, 25559.105431309814, 25749.0, 25786.226413207634, 45784.313235302165, 46199.76900115478, 46225.76887115543, 46270.07459850717, 46366.0, 32467.512987304737, 37329.81335093307, 38444.0, 38837.0, 39274.60725392824, 35137.0, 35206.64793352136, 38900.6109938897, 40166.0, 41051.76844694664, 38185.0, 39168.2166356677, 39387.40918886162, 39469.0, 39500.604993950845, 31312.0, 34648.30703385868, 35147.82426087853, 35275.47086793752, 35342.0, 25411.983520659705, 25536.489270214865, 25598.23205303844, 25977.090801821847, 26253.606195907458], "value": 20367.634909946162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.85188091299364, 354.0, 375.7576363245707, 386.127352184064, 406.0660480893943, 14937.626559336022, 15236.390544378211, 15984.290819199894, 20771.376858694264, 20831.375058748225, 19709.90145049276, 20108.296209632666, 20712.27507037254, 20721.171153153893, 20964.790352096476, 5679.602427830054, 5850.824475265738, 6095.3599872013465, 6101.328853826098, 6128.0, 5183.948160518385, 6019.488343490809, 6058.242719660043, 6074.635521868702, 6078.969605151968, 4145.54399016108, 4395.011122497444, 6315.873682526347, 6599.67001649918, 6646.93353066468, 5749.0, 6043.335233124353, 6700.195976482804, 6707.396334329909, 6710.7315707371645, 5882.735276912549, 5917.349091599921, 5940.851478713067, 5949.315828679714, 5962.0162673158875, 12568.685782855411, 12742.490300388066, 23452.882735586212, 23793.0, 25099.62350564743, 2027.3715148304072, 2174.1303478608525, 2471.4068623530225, 2522.84465633692, 2790.1350581319653, 9445.622175112987, 9511.0, 9612.711618651452, 10110.797784044351, 10124.139448146916, 1790.2570433270178, 1814.129217975379, 1860.283790740561, 1872.5786697992978, 1884.6230753849286, 109318.45340773245, 119879.4006029973, 120527.3973630135, 120532.7946720539, 120752.0, 10918.0, 11242.550297988153, 11250.718732031764, 11419.0, 11559.884401155881, 14082.436702531784, 14095.0, 14158.29208539569, 14168.433262669378, 14175.503857364944, 8216.46592971455, 8391.790205244917, 8392.580370981426, 8397.160283971676, 8467.110953349933, 8392.202740739742, 8419.621117049748, 8423.0, 8559.95720021396, 8600.268977136888, 4207.200631879933, 4313.180495705806, 4331.40564144927, 4335.458067741532, 4356.825726970949, 1795.5690634247687, 1829.6980948504563, 1832.2762508808946, 1874.8593855460622, 1881.8021069409563, 831.821158450936, 882.250087425683, 905.4341036851968, 930.5626355612851, 953.6172549802814, 20050.398488045383, 20567.8971605144, 21737.0, 21754.673679894815, 21853.781462185492, 872.3239489395769, 894.4677916639589, 902.6118768929292, 912.3248795890993, 918.0, 10901.781964360669, 11141.944290278496, 11309.491072901574, 11338.716532086764, 11350.262232954832, 573162.0, 577101.0, 586923.0, 587288.0169586423, 587294.0, 122823.0, 128917.35541322234, 128977.71022289657, 129667.0, 131604.0, 923.5705396990297, 956.4309236004566, 968.651285537206, 970.8301047316692, 974.1768205866032, 18242.81757182411, 18920.621587568447, 19052.523686907938, 19058.142383593047, 19125.90437047806, 56209.0, 56845.71577142088, 57050.14424783549, 57256.278341907644, 57785.0, 48905.755471222416, 78310.6084469574, 79637.60181199056, 82212.0, 82577.58711206405, 7729.652165652672, 7866.449348545547, 7972.681092756225, 8052.154523775153, 8218.876716849132, 10191.050980235428, 10636.30863993838, 13143.73712525725, 13242.668933276746, 13366.799498007733, 10895.455227238765, 11054.00513953748, 11294.60468883585, 11319.09447244235, 11471.483783229607, 10799.082078023455, 11008.614698485515, 11157.13615538915, 11162.609308674157, 11189.216754827085, 8186.590670466572, 9348.719538413858, 9888.0, 9964.55159517838, 10029.648962286285, 7082.3979961703835, 7265.418766498562, 7356.117265928123, 7399.038125043709, 7516.962415187889, 8902.465852048897, 9520.66677666306, 9663.222729982062, 9832.754181145528, 9864.950675246579], "value": 9318.117404313512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.2782683437529, 1360.9591712248637, 1553.2311505804628, 1724.9223784929677, 1937.2154277517611, 7736.303732664059, 7776.455648104635, 8280.29617482514, 8798.120187981198, 8835.204831565157, 8712.30301575874, 8773.60518776655, 8774.122587741223, 8778.0, 8778.2099611035, 2338.1465764995783, 2363.917262895799, 2366.3965688749345, 2367.763223677636, 2368.7394386617457, 2315.340128063502, 2336.170659415908, 2370.992328260491, 2371.620540713486, 2380.75002124777, 2330.3009097270838, 2350.4946436516148, 2352.212008976986, 2357.2574638988663, 2363.2555744940373, 2027.2093883385344, 2305.101010605865, 2315.6989591353185, 2328.6739856420113, 2333.171724037976, 2312.0, 2318.988405057981, 2321.814254859607, 2323.94190145246, 2328.988355058231, 8666.52334121623, 8831.911680883173, 8851.77870553235, 8861.42400743956, 8885.4668719877, 4846.539578740014, 5133.897322053575, 5293.232481290192, 5296.841094767163, 5310.0, 3473.8263086845554, 3560.181158333598, 3563.002359339389, 3565.6612621800887, 3567.02276961189, 1081.621432498627, 1097.0510508410248, 1110.5613282753347, 1118.6867677050438, 1119.7424592343725, 11438.19932604718, 11536.826947595793, 11543.307401556018, 11544.422778861024, 11562.05167682244, 4382.780860957003, 4465.106978604292, 4471.776411179428, 4558.452985641744, 4586.862394128181, 9055.456672599665, 9061.54692265384, 9066.410683305565, 9069.410488318239, 9095.181433671001, 5154.226865970059, 5162.92255616166, 5171.741412929338, 5172.250023746611, 5186.455422180692, 4045.3931910213705, 4350.71720338177, 4396.296592545177, 4465.665075119314, 4822.348982887335, 3702.5742039665784, 3764.8117594120185, 3826.5025546678753, 3837.9232415351535, 3846.519185101862, 1080.9081228095542, 1109.944502774858, 1160.5647882044234, 1175.2595864605244, 1189.79178643737, 842.1957031035347, 862.3920136304016, 896.8654701794652, 908.5502676175336, 936.4334577580465, 5616.943830561724, 5682.886342273131, 5944.603018290698, 5999.220101386792, 6008.948434024029, 918.6049998500708, 940.1162906867522, 955.3360414511986, 960.8078384323163, 1008.1531513528671, 3477.8608855646, 4093.467849179647, 4102.630763231324, 4148.979255103705, 4326.697131200785, 10586.735331616772, 10725.463726813628, 10807.83788243177, 10822.0, 10857.891421085687, 10756.946215268874, 10757.408342541079, 10758.838617420744, 10771.353718776898, 10845.783084338269, 8064.798380040546, 8259.8348033039, 8267.793305167419, 8279.58602069894, 8287.337013038943, 5760.855978600569, 6070.089486577049, 6130.233720784902, 6139.0, 6204.410580994799, 9357.53212339394, 9766.511674416393, 9880.555375007998, 10037.598496060367, 10125.189984801345, 10014.248931330034, 10179.745506362104, 10258.948705256425, 10280.2803803736, 10294.0, 7164.462665300019, 7205.88308812135, 7501.699932002659, 7549.547027178387, 7659.69361225567, 8277.0, 8329.750107496784, 8340.0, 8374.371922105745, 8402.453840500348, 7478.326950574475, 7558.470907036454, 7571.091469023752, 7635.5800430974605, 7733.265339792711, 7420.962895185489, 7523.924760752322, 7569.091708994956, 7592.734254301073, 7740.922590774246, 6727.831804204934, 6963.1296087989, 6964.025036494996, 6974.546654467444, 6975.162980442176, 5061.468545802785, 5079.888156580669, 5249.721476996236, 5289.523942845162, 5403.189521571796, 5149.794008239778, 5190.755777638976, 5194.194899790538, 5213.76538055796, 5366.275552800322], "value": 4556.4965328488315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.9458005688891, 289.2926793988697, 290.66718607194775, 299.41315022555784, 301.7374883851049, 5029.773660185291, 5060.5951523878, 5072.416672082707, 5125.6412051156385, 5219.817306394277, 4377.7154484958455, 5222.996776853305, 5249.842504724855, 5257.737113144347, 5264.868378290545, 3541.9645803541894, 3711.1093337598986, 3954.762714237155, 3977.184677141194, 3980.8304474061706, 3725.795081270529, 3754.0, 3965.286248475273, 3967.583403742609, 4011.8135616089303, 2990.9551356729667, 3740.532433445819, 3914.3345631242755, 3939.5863434339267, 3947.250022495731, 3260.510923361503, 3393.778239833658, 3838.846446142151, 3893.3914277434187, 3894.4353068804867, 3338.6327503974544, 3353.815540145291, 3362.5124356968104, 3371.9494207586904, 3386.5597472328686, 4433.844815431445, 4911.361523002022, 4991.652253891429, 5033.521815427529, 5078.4413714491375, 3511.6488351164935, 4335.764307172472, 4399.538048504893, 4411.492678342, 4449.709584220572, 4569.47451043131, 5416.079266524661, 5419.918701219485, 5440.898687747986, 5470.425605311425, 2816.5919237722383, 2925.2594706149807, 3536.257385948954, 3661.6085887362897, 3698.2973235085246, 5391.622586418913, 5656.66256908426, 5672.631278966854, 5690.715464226772, 5720.795215516592, 3702.81485925708, 3707.2770809692393, 3727.589965103836, 3731.458938453909, 3737.0, 3636.61815509373, 3775.131719704483, 3802.239552089593, 3807.638274363931, 3809.9238015240094, 3882.9223415532097, 4336.436263285753, 4365.410669559632, 4374.62815660666, 4416.359627854007, 4993.275974983607, 5319.0213480451075, 5411.756470958738, 5419.430959749248, 5427.0, 1051.0645525482328, 1166.2069792540983, 1269.771441140585, 1288.8195652608642, 1289.9548515801903, 642.996785016072, 744.7616762636013, 802.193795235796, 855.7304449098514, 876.8334016536837, 4690.742009189527, 4740.502247264057, 4970.446131016341, 5035.420926593415, 5085.7457127144235, 4807.855764327076, 5279.841604751864, 5459.0, 5560.833175004756, 5580.1629755537, 4346.195953748566, 4800.303955926371, 4852.708837469763, 5083.848014231126, 5088.567471764942, 2472.5425796227755, 2614.830036047651, 2874.8131371460786, 2960.0167887515418, 2965.9258518536776, 4873.975630121898, 5516.448355164452, 5792.420757924258, 5797.681127537941, 5845.853853653693, 5387.24578559002, 5699.487046165865, 5707.3721890592005, 5712.2288491054005, 5736.71316434185, 4586.793594288199, 4998.925016124761, 5775.27809023872, 5777.88444231113, 5780.277465316835, 4500.842470513648, 5546.809010440934, 5581.358143813513, 5586.452602597299, 5598.468145526169, 4891.364122664031, 4933.161362568444, 5448.147629805885, 5541.944580554143, 5558.249636299048, 5532.28080349552, 5778.653280803165, 5792.333881603669, 5821.534277257724, 5826.475617194473, 2746.986265068662, 3745.943810842785, 3747.9063023424633, 3752.962470375261, 3758.3047136279874, 4952.529509696573, 5338.772082420987, 5589.469000444951, 5630.5214056805635, 5643.407442218508, 4600.470945841137, 5239.790408383622, 5421.674699518042, 5424.945750542444, 5460.0, 4544.954550454586, 5200.349956255468, 5419.6206265562605, 5436.320459942507, 5456.61803673739, 4563.429571303587, 5362.276092727432, 5410.620291825717, 5424.403315635356, 5425.647332923348, 5483.287172667528, 5484.204790305464, 5484.643498172606, 5542.11326187808, 5550.361708403424, 4829.227323628203, 5178.249153872743, 5352.678839269656, 5386.811461598825, 5440.721430463917], "value": 3927.183492795749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.7012310014444, 742.3170682971669, 748.2891253309358, 778.828657695307, 818.5457071325419, 15379.769303460444, 16289.266982985764, 16293.59266018347, 16320.591985200375, 16381.017138971654, 14547.490837820678, 14644.414223431077, 14654.120752754816, 14660.340284687189, 14681.412743490275, 715.4133610439442, 736.7163641997815, 742.940564754821, 865.4720620421538, 878.6221924572448, 884.2572239318971, 899.9920089499736, 901.5086777706166, 903.471469190521, 906.9410488318272, 935.3452583191759, 954.1460392948308, 955.0544960489135, 956.268454632207, 956.9760755981087, 945.7493764152505, 946.1673727120125, 947.209080417852, 947.2847999760171, 949.9715008549755, 548.6653141583631, 576.1357963055417, 680.9489288303348, 711.121764620693, 715.0132816712954, 14802.40790368384, 15019.849801501954, 15020.624484387869, 15084.39662413502, 15115.732640103963, 13807.0, 14204.218767967757, 14278.214698191596, 14330.713385732332, 14354.0, 10926.180536459718, 12768.872311276955, 12806.29565373904, 12830.935845320808, 13206.537771178058, 4484.2376795944765, 4631.073785242965, 4631.652626053059, 4633.513481084505, 4689.0, 117166.82833171645, 121116.39441802734, 125517.82062883356, 125726.0, 125814.37092814568, 10773.407462589634, 11092.389918554396, 11345.567577261148, 11357.261777984404, 11547.249428787101, 22439.21462748796, 22463.88768056182, 22472.763997979942, 22487.437814054778, 22523.0, 7850.646720897459, 8074.717384891501, 8173.0, 8207.835843283101, 8211.17888211174, 4392.670549708785, 4529.343245229489, 4607.76961151941, 4642.953570464252, 4758.7858546364805, 3200.6159260888844, 3253.0, 3310.6358300586917, 3324.5678061852286, 3333.033420308132, 636.8821767972939, 640.8077576726963, 641.0896526931768, 655.220287857448, 658.649767975648, 590.4656286061122, 618.9226346706662, 633.740166531729, 641.9743210271537, 649.0912722188879, 6825.448677971455, 8433.156684331518, 8716.520591367409, 8970.506622135714, 8997.981509631387, 508.01619675168524, 573.2604939627917, 636.6084857812413, 660.9490909453991, 671.684308375063, 4245.405643209953, 4626.773904915201, 4655.0, 4940.184869496565, 5058.747062646853, 101122.0, 105531.0, 132410.33794831156, 161360.15919522432, 168029.0, 136402.0, 140882.2955885214, 141503.0, 142507.0, 142993.0, 101686.49156754169, 106327.0, 107336.46331768291, 107507.0, 111775.58692956572, 8990.505522196341, 9454.14912657864, 9766.218702503924, 9965.451900145561, 9997.450140242356, 51570.484295156566, 59455.56805399325, 61505.0, 62569.0, 63505.0, 93996.59005115066, 95021.0, 95136.0, 95815.52092239494, 98008.0, 12677.328727005619, 13016.15394999322, 13258.270795106362, 13315.80157785804, 13477.258750768802, 14410.855891441372, 14499.275036248357, 14779.408823647364, 15041.774373384627, 15292.405937004998, 13694.726105477635, 13862.861371386158, 13884.841832152802, 14005.439782408997, 14201.0, 10978.286411383235, 13153.145045572008, 13395.933020334836, 13428.19430834153, 13803.930980345034, 13433.26117063571, 13492.730145397234, 13645.317734113056, 13943.930280348939, 14150.929245353707, 10899.564017439214, 10900.454977251264, 10999.120070394509, 11162.107031437303, 11599.246049006788, 9748.366356186825, 10920.726981825517, 11433.428328583705, 11503.309801411942, 11662.416879156179], "value": 7918.778271886026, "unit": "score"}], "name": "dromaeo_css", "value": 7295.5828435174735, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 113.0, 113.0, 111.0, 112.0, 110.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 104.0, 126.0, 102.0, 126.0, 93.0, 130.0, 173.0, 136.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 199.0, 265.0, 195.0, 185.0, 181.0, 184.0, 184.0, 182.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 86.0, 64.0, 83.0, 78.0, 83.0, 108.0, 57.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 91.0, 69.0, 67.0, 69.0, 93.0, 69.0, 70.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 81.0, 89.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 92.0, 92.0, 94.0, 93.0, 93.0, 93.0, 94.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 135.0, 104.0, 84.0, 85.0, 85.0, 87.0, 86.0, 86.0, 85.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 52.0, 52.0, 51.0, 53.0, 52.0, 54.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 68.0, 75.0, 73.0, 70.0, 70.0, 69.0, 71.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 86.0, 87.0, 85.0, 84.0, 84.0, 88.0, 90.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 143.0, 141.0, 145.0, 149.0, 150.0, 143.0, 136.0, 191.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 172.0, 167.0, 165.0, 167.0, 168.0, 165.0, 168.0, 168.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1450.3999999999999, "alertThreshold": 2.0}]} 00:58:27 INFO - Return code: 0 00:58:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:58:27 INFO - # TBPL SUCCESS # 00:58:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:58:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:58:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:58:27 INFO - 2016-09-22 00:58:27.681 screenresolution[1678:11430] starting screenresolution argv=screenresolution get 00:58:27 INFO - 2016-09-22 00:58:27.684 screenresolution[1678:11430] Display 0: 1600x1200x32@60 00:58:27 INFO - 2016-09-22 00:58:27.690 screenresolution[1679:11433] starting screenresolution argv=screenresolution list 00:58:27 INFO - Available Modes on Display 0 00:58:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:58:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:58:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:58:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:58:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:58:27 INFO - Intel Iris: 00:58:27 INFO - Chipset Model: Intel Iris 00:58:27 INFO - Type: GPU 00:58:27 INFO - Bus: Built-In 00:58:27 INFO - VRAM (Dynamic, Max): 1536 MB 00:58:27 INFO - Vendor: Intel (0x8086) 00:58:27 INFO - Device ID: 0x0a2e 00:58:27 INFO - Revision ID: 0x0009 00:58:27 INFO - Displays: 00:58:27 INFO - Display: 00:58:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:58:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:58:27 INFO - Display Serial Number: 1600x1200 60 00:58:27 INFO - Main Display: Yes 00:58:27 INFO - Mirror: Off 00:58:27 INFO - Online: Yes 00:58:27 INFO - Rotation: Supported 00:58:27 INFO - Return code: 0 00:58:27 INFO - Running post-action listener: _resource_record_post_action 00:58:27 INFO - [mozharness: 2016-09-22 07:58:27.924909Z] Finished run-tests step (success) 00:58:27 INFO - Running post-run listener: _resource_record_post_run 00:58:27 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32693248; Write bytes: 705847808; Read time: 306; Write time: 1869 00:58:27 INFO - TinderboxPrint: CPU usage
54.1% 00:58:27 INFO - TinderboxPrint: I/O read bytes / time
32,693,248 / 306 00:58:27 INFO - TinderboxPrint: I/O write bytes / time
705,847,808 / 1,869 00:58:27 INFO - TinderboxPrint: CPU idle
2,226.2 (45.9%) 00:58:27 INFO - TinderboxPrint: CPU system
982.9 (20.3%) 00:58:27 INFO - TinderboxPrint: CPU user
1,636.6 (33.8%) 00:58:27 INFO - TinderboxPrint: Swap in / out
434,040,832 / 0 00:58:27 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401922560; Write bytes: 397489152; Read time: 29967; Write time: 711 00:58:28 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30567424; Write bytes: 295554560; Read time: 282; Write time: 1123 00:58:28 INFO - Running post-run listener: _upload_blobber_files 00:58:28 INFO - Blob upload gear active. 00:58:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:58:28 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 00:58:28 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'] 00:58:28 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 00:58:28 INFO - (blobuploader) - INFO - Open directory for files ... 00:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:30 INFO - (blobuploader) - INFO - Done attempting. 00:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:58:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:31 INFO - (blobuploader) - INFO - Done attempting. 00:58:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:58:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:33 INFO - (blobuploader) - INFO - Done attempting. 00:58:33 INFO - (blobuploader) - INFO - Iteration through files over. 00:58:33 INFO - Return code: 0 00:58:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:58:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:58:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f04c16b77f7c0970ee084b67a42e5779cbd115b9a0c1b8779738aa8bd0737f9c61cd9c884c9f9fb2b32a86756527f74d23a0039cf126316d3f3dba844105fd85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/206274893717ac1456c0abf166bf3cc6a5394b4e8e4ffae85172accf7ab328d3ddd482a86f3de0f6e59de1835dd2762e43d662a13368f6a6e3d5a9d5a37406dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee7c9f49ab311391faac8949289a123d39e57d9aaf1ee0ddc2bf411ff4d3517590d87c1827631596e5524298a50da8ccf6ccb212565b7a4c9b9d3821421d1e14"} 00:58:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:58:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:58:33 INFO - Contents: 00:58:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f04c16b77f7c0970ee084b67a42e5779cbd115b9a0c1b8779738aa8bd0737f9c61cd9c884c9f9fb2b32a86756527f74d23a0039cf126316d3f3dba844105fd85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/206274893717ac1456c0abf166bf3cc6a5394b4e8e4ffae85172accf7ab328d3ddd482a86f3de0f6e59de1835dd2762e43d662a13368f6a6e3d5a9d5a37406dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee7c9f49ab311391faac8949289a123d39e57d9aaf1ee0ddc2bf411ff4d3517590d87c1827631596e5524298a50da8ccf6ccb212565b7a4c9b9d3821421d1e14"} 00:58:33 INFO - Running post-run listener: copy_logs_to_upload_dir 00:58:33 INFO - Copying logs to upload dir... 00:58:33 INFO - mkdir: /builds/slave/test/build/upload/logs 00:58:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.503662 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-22 00:58:33.580935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 00:58:33.584964) ========= 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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f04c16b77f7c0970ee084b67a42e5779cbd115b9a0c1b8779738aa8bd0737f9c61cd9c884c9f9fb2b32a86756527f74d23a0039cf126316d3f3dba844105fd85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/206274893717ac1456c0abf166bf3cc6a5394b4e8e4ffae85172accf7ab328d3ddd482a86f3de0f6e59de1835dd2762e43d662a13368f6a6e3d5a9d5a37406dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee7c9f49ab311391faac8949289a123d39e57d9aaf1ee0ddc2bf411ff4d3517590d87c1827631596e5524298a50da8ccf6ccb212565b7a4c9b9d3821421d1e14"} build_url:https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011135 build_url: 'https://queue.taskcluster.net/v1/task/GtXeFYqFTVuPD074xhpFoQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f04c16b77f7c0970ee084b67a42e5779cbd115b9a0c1b8779738aa8bd0737f9c61cd9c884c9f9fb2b32a86756527f74d23a0039cf126316d3f3dba844105fd85", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/206274893717ac1456c0abf166bf3cc6a5394b4e8e4ffae85172accf7ab328d3ddd482a86f3de0f6e59de1835dd2762e43d662a13368f6a6e3d5a9d5a37406dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ee7c9f49ab311391faac8949289a123d39e57d9aaf1ee0ddc2bf411ff4d3517590d87c1827631596e5524298a50da8ccf6ccb212565b7a4c9b9d3821421d1e14"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 00:58:33.617889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:58:33.618236) ========= 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.8XwZ8wUkX8/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.SHqlAeAlpc/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 00:58:33.666481) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 00:58:33.666811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 00:58:33.667129) ========= ========= Total master_lag: 0.25 =========