builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0261 starttime: 1473380887.41 results: success (0) buildid: 20160908153031 builduid: ae1721cabca0425aa754c629b9885d63 revision: 4cb8b7cc27e113f269ab8ecede30f832ffede2dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.408317) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.408777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.409093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.440818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.441178) ========= 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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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-08 17:28:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 152M=0s 2016-09-08 17:28:07 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124447 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.591497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.591914) ========= 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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.020618 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:07.645085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-08 17:28:07.648537) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4cb8b7cc27e113f269ab8ecede30f832ffede2dc --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 4cb8b7cc27e113f269ab8ecede30f832ffede2dc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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-08 17:28:07,727 truncating revision to first 12 chars 2016-09-08 17:28:07,727 Setting DEBUG logging. 2016-09-08 17:28:07,727 attempt 1/10 2016-09-08 17:28:07,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4cb8b7cc27e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 17:28:09,486 unpacking tar archive at: autoland-4cb8b7cc27e1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.031981 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-08 17:28:09.706799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:09.707191) ========= script_repo_revision: 4cb8b7cc27e113f269ab8ecede30f832ffede2dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:09.707683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:09.708007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 17:28:09.727162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-08 17:28:09.727687) ========= /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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:09 INFO - MultiFileLogger online at 20160908 17:28:09 in /builds/slave/test 17:28:09 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 17:28:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:28:09 INFO - {'append_to_log': False, 17:28:09 INFO - 'base_work_dir': '/builds/slave/test', 17:28:09 INFO - 'blob_upload_branch': 'Autoland', 17:28:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:28:09 INFO - 'branch': 'Autoland', 17:28:09 INFO - 'buildbot_json_path': 'buildprops.json', 17:28:09 INFO - 'config_files': ('talos/mac_config.py',), 17:28:09 INFO - 'default_actions': ('clobber', 17:28:09 INFO - 'read-buildbot-config', 17:28:09 INFO - 'download-and-extract', 17:28:09 INFO - 'populate-webroot', 17:28:09 INFO - 'create-virtualenv', 17:28:09 INFO - 'install', 17:28:09 INFO - 'run-tests'), 17:28:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:28:09 INFO - 'download_minidump_stackwalk': True, 17:28:09 INFO - 'download_symbols': 'ondemand', 17:28:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:28:09 INFO - 'tooltool.py': '/tools/tooltool.py', 17:28:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:28:09 INFO - '/tools/misc-python/virtualenv.py')}, 17:28:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:28:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:28:09 INFO - 'installer_path': 'installer.exe', 17:28:09 INFO - 'log_level': 'info', 17:28:09 INFO - 'log_name': 'talos', 17:28:09 INFO - 'log_to_console': True, 17:28:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:28:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:28:09 INFO - 'opt_config_files': (), 17:28:09 INFO - 'pip_index': False, 17:28:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:28:09 INFO - 'cmd': ('bash', 17:28:09 INFO - '-c', 17:28:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:28:09 INFO - 'enabled': True, 17:28:09 INFO - 'halt_on_failure': False, 17:28:09 INFO - 'name': 'check_screen_resolution'},), 17:28:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:28:09 INFO - 'cmd': ('bash', 17:28:09 INFO - '-c', 17:28:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:28:09 INFO - 'enabled': True, 17:28:09 INFO - 'halt_on_failure': False, 17:28:09 INFO - 'name': 'check_screen_resolution'},), 17:28:09 INFO - 'run_cmd_checks_enabled': True, 17:28:09 INFO - 'sps_profile': False, 17:28:09 INFO - 'sps_profile_interval': 0, 17:28:09 INFO - 'suite': 'dromaeojs', 17:28:09 INFO - 'system_bits': '32', 17:28:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:28:09 INFO - 'title': 't-yosemite-r7-0261', 17:28:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:28:09 INFO - 'use_talos_json': True, 17:28:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:28:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:28:09 INFO - 'work_dir': 'build'} 17:28:09 INFO - [mozharness: 2016-09-09 00:28:09.916650Z] Running clobber step. 17:28:09 INFO - Running pre-action listener: _resource_record_pre_action 17:28:09 INFO - Running main action method: clobber 17:28:09 INFO - rmtree: /builds/slave/test/build 17:28:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:28:11 INFO - Running post-action listener: _resource_record_post_action 17:28:11 INFO - [mozharness: 2016-09-09 00:28:11.335878Z] Finished clobber step (success) 17:28:11 INFO - [mozharness: 2016-09-09 00:28:11.336049Z] Running read-buildbot-config step. 17:28:11 INFO - Running pre-action listener: _resource_record_pre_action 17:28:11 INFO - Running main action method: read_buildbot_config 17:28:11 INFO - Using buildbot properties: 17:28:11 INFO - { 17:28:11 INFO - "project": "", 17:28:11 INFO - "product": "firefox", 17:28:11 INFO - "script_repo_revision": "production", 17:28:11 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 17:28:11 INFO - "repository": "", 17:28:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 17:28:11 INFO - "buildid": "20160908153031", 17:28:11 INFO - "pgo_build": "False", 17:28:11 INFO - "basedir": "/builds/slave/test", 17:28:11 INFO - "buildnumber": 179, 17:28:11 INFO - "slavename": "t-yosemite-r7-0261", 17:28:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:28:11 INFO - "platform": "yosemite_r7", 17:28:11 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:28:11 INFO - "branch": "autoland", 17:28:11 INFO - "repo_path": "integration/autoland", 17:28:11 INFO - "revision": "4cb8b7cc27e113f269ab8ecede30f832ffede2dc", 17:28:11 INFO - "stage_platform": "macosx64", 17:28:11 INFO - "builduid": "ae1721cabca0425aa754c629b9885d63", 17:28:11 INFO - "slavebuilddir": "test" 17:28:11 INFO - } 17:28:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 17:28:11 INFO - Running post-action listener: _resource_record_post_action 17:28:11 INFO - [mozharness: 2016-09-09 00:28:11.339270Z] Finished read-buildbot-config step (success) 17:28:11 INFO - [mozharness: 2016-09-09 00:28:11.339390Z] Running download-and-extract step. 17:28:11 INFO - Running pre-action listener: _resource_record_pre_action 17:28:11 INFO - Running main action method: download_and_extract 17:28:11 INFO - mkdir: /builds/slave/test/build/tests 17:28:11 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')]} 17:28:11 INFO - trying https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 17:28:11 INFO - Downloading https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 17:28:12 INFO - Downloaded 1199 bytes. 17:28:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 17:28:12 INFO - Using the following test package requirements: 17:28:12 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:28:12 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 17:28:12 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 17:28:12 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'jsshell-mac.zip'], 17:28:12 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 17:28:12 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 17:28:12 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 17:28:12 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 17:28:12 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 17:28:12 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 17:28:12 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 17:28:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:28:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:28:13 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:28:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:28:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 17:28:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:28:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 17:28:28 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 17:28:28 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')]} 17:28:28 INFO - trying https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:28:28 INFO - Downloading https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 17:28:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 17:28:31 INFO - Downloaded 111538116 bytes. 17:28:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:28:31 INFO - mkdir: /builds/slave/test/properties 17:28:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:28:31 INFO - Writing to file /builds/slave/test/properties/build_url 17:28:31 INFO - Contents: 17:28:31 INFO - build_url:https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 17:28:32 INFO - Running post-action listener: _resource_record_post_action 17:28:32 INFO - Running post-action listener: set_extra_try_arguments 17:28:32 INFO - [mozharness: 2016-09-09 00:28:32.273180Z] Finished download-and-extract step (success) 17:28:32 INFO - [mozharness: 2016-09-09 00:28:32.273322Z] Running populate-webroot step. 17:28:32 INFO - Running pre-action listener: _resource_record_pre_action 17:28:32 INFO - Running main action method: populate_webroot 17:28:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:28:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:28:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:28:32 INFO - '--tppagecycles', 17:28:32 INFO - '7'], 17:28:32 INFO - 'tests': ['tsvgm']}}, 17:28:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:28:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:28:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:28:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:28:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:28:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['damp', 'tps']}, 17:28:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'tests': ['damp', 'tps']}, 17:28:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['dromaeo_dom']}, 17:28:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:28:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['basic_compositor_video']}, 17:28:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:28:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'other-e10s': {'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['a11yr', 17:28:32 INFO - 'ts_paint', 17:28:32 INFO - 'tpaint', 17:28:32 INFO - 'sessionrestore', 17:28:32 INFO - 'sessionrestore_no_auto_restore', 17:28:32 INFO - 'tabpaint']}, 17:28:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['tsvgx', 17:28:32 INFO - 'tsvgr_opacity', 17:28:32 INFO - 'tart', 17:28:32 INFO - 'tscrollx', 17:28:32 INFO - 'cart']}, 17:28:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:28:32 INFO - 'tsvgr_opacity', 17:28:32 INFO - 'tart', 17:28:32 INFO - 'tscrollx', 17:28:32 INFO - 'cart']}, 17:28:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'talos_options': ['--disable-e10s'], 17:28:32 INFO - 'tests': ['tp5o']}, 17:28:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'tests': ['tp5o']}, 17:28:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'talos_options': ['--disable-e10s', 17:28:32 INFO - '--xperf_path', 17:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:32 INFO - 'tests': ['tp5n']}, 17:28:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:28:32 INFO - 'talos_options': ['--xperf_path', 17:28:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:28:32 INFO - 'tests': ['tp5n']}}, 17:28:32 INFO - 'talos.zip': {'path': '', 17:28:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:28:32 INFO - Running post-action listener: _resource_record_post_action 17:28:32 INFO - [mozharness: 2016-09-09 00:28:32.291559Z] Finished populate-webroot step (success) 17:28:32 INFO - [mozharness: 2016-09-09 00:28:32.291649Z] Running create-virtualenv step. 17:28:32 INFO - Running pre-action listener: _resource_record_pre_action 17:28:32 INFO - Running main action method: create_virtualenv 17:28:32 INFO - Creating virtualenv /builds/slave/test/build/venv 17:28:32 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 17:28:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:28:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:28:32 INFO - Using real prefix '/tools/python27' 17:28:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:28:33 INFO - Installing distribute.............................................................................................................................................................................................done. 17:28:35 INFO - Installing pip.................done. 17:28:35 INFO - Return code: 0 17:28:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:35 INFO - 'HOME': '/Users/cltbld', 17:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:35 INFO - 'LOGNAME': 'cltbld', 17:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:35 INFO - 'MOZ_NO_REMOTE': '1', 17:28:35 INFO - 'NO_EM_RESTART': '1', 17:28:35 INFO - 'PAGER': '/bin/cat', 17:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:35 INFO - 'PWD': '/builds/slave/test', 17:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:36 INFO - 'SHELL': '/bin/bash', 17:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:36 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:36 INFO - 'USER': 'cltbld', 17:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:36 INFO - 'XPC_FLAGS': '0x0', 17:28:36 INFO - 'XPC_SERVICE_NAME': '0', 17:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:36 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 17:28:36 INFO - Cleaning up... 17:28:36 INFO - Return code: 0 17:28:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:36 INFO - 'HOME': '/Users/cltbld', 17:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:36 INFO - 'LOGNAME': 'cltbld', 17:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:36 INFO - 'MOZ_NO_REMOTE': '1', 17:28:36 INFO - 'NO_EM_RESTART': '1', 17:28:36 INFO - 'PAGER': '/bin/cat', 17:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:36 INFO - 'PWD': '/builds/slave/test', 17:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:36 INFO - 'SHELL': '/bin/bash', 17:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:36 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:36 INFO - 'USER': 'cltbld', 17:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:36 INFO - 'XPC_FLAGS': '0x0', 17:28:36 INFO - 'XPC_SERVICE_NAME': '0', 17:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:36 INFO - Downloading/unpacking psutil>=3.1.1 17:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:28:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:39 INFO - Installing collected packages: psutil 17:28:39 INFO - Running setup.py install for psutil 17:28:39 INFO - building 'psutil._psutil_osx' extension 17:28:39 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 17:28:39 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 17:28:39 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 17:28:40 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 17:28:40 INFO - building 'psutil._psutil_posix' extension 17:28:40 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 17:28:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:28:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:28:40 INFO - ^ 17:28:40 INFO - 1 warning generated. 17:28:40 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 17:28:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:28:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:28:40 INFO - Successfully installed psutil 17:28:40 INFO - Cleaning up... 17:28:40 INFO - Return code: 0 17:28:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:28:40 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')]} 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:40 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')]} 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:40 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:40 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 17:28:40 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 17:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:40 INFO - 'HOME': '/Users/cltbld', 17:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:40 INFO - 'LOGNAME': 'cltbld', 17:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:40 INFO - 'MOZ_NO_REMOTE': '1', 17:28:40 INFO - 'NO_EM_RESTART': '1', 17:28:40 INFO - 'PAGER': '/bin/cat', 17:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:40 INFO - 'PWD': '/builds/slave/test', 17:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:40 INFO - 'SHELL': '/bin/bash', 17:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:40 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:40 INFO - 'USER': 'cltbld', 17:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:40 INFO - 'XPC_FLAGS': '0x0', 17:28:40 INFO - 'XPC_SERVICE_NAME': '0', 17:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:28:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:28:43 INFO - Installing collected packages: mozsystemmonitor 17:28:43 INFO - Running setup.py install for mozsystemmonitor 17:28:43 INFO - Successfully installed mozsystemmonitor 17:28:43 INFO - Cleaning up... 17:28:43 INFO - Return code: 0 17:28:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:43 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:43 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 17:28:43 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 17:28:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:43 INFO - 'HOME': '/Users/cltbld', 17:28:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:43 INFO - 'LOGNAME': 'cltbld', 17:28:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:43 INFO - 'MOZ_NO_REMOTE': '1', 17:28:43 INFO - 'NO_EM_RESTART': '1', 17:28:43 INFO - 'PAGER': '/bin/cat', 17:28:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:43 INFO - 'PWD': '/builds/slave/test', 17:28:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:43 INFO - 'SHELL': '/bin/bash', 17:28:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:43 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:43 INFO - 'USER': 'cltbld', 17:28:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:43 INFO - 'XPC_FLAGS': '0x0', 17:28:43 INFO - 'XPC_SERVICE_NAME': '0', 17:28:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:43 INFO - Downloading/unpacking jsonschema==2.5.1 17:28:43 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 17:28:43 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 17:28:43 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 17:28:43 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 17:28:43 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 17:28:43 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 17:28:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:28:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:28:46 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 17:28:46 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 17:28:46 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 17:28:46 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 17:28:46 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 17:28:46 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 17:28:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:28:46 INFO - warning: no files found matching '*.txt' 17:28:46 INFO - no previously-included directories found matching 'build' 17:28:46 INFO - no previously-included directories found matching 'dist' 17:28:46 INFO - no previously-included directories found matching '.git*' 17:28:46 INFO - Installing collected packages: jsonschema, functools32 17:28:46 INFO - Running setup.py install for functools32 17:28:46 INFO - warning: no files found matching '*.txt' 17:28:46 INFO - no previously-included directories found matching 'build' 17:28:46 INFO - no previously-included directories found matching 'dist' 17:28:46 INFO - no previously-included directories found matching '.git*' 17:28:46 INFO - Successfully installed jsonschema functools32 17:28:46 INFO - Cleaning up... 17:28:46 INFO - Return code: 0 17:28:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:46 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:46 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 17:28:46 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 17:28:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:46 INFO - 'HOME': '/Users/cltbld', 17:28:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:46 INFO - 'LOGNAME': 'cltbld', 17:28:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:46 INFO - 'MOZ_NO_REMOTE': '1', 17:28:46 INFO - 'NO_EM_RESTART': '1', 17:28:46 INFO - 'PAGER': '/bin/cat', 17:28:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:46 INFO - 'PWD': '/builds/slave/test', 17:28:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:46 INFO - 'SHELL': '/bin/bash', 17:28:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:46 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:46 INFO - 'USER': 'cltbld', 17:28:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:46 INFO - 'XPC_FLAGS': '0x0', 17:28:46 INFO - 'XPC_SERVICE_NAME': '0', 17:28:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:28:47 INFO - Cleaning up... 17:28:47 INFO - Return code: 0 17:28:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:47 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:47 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 17:28:47 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 17:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:47 INFO - 'HOME': '/Users/cltbld', 17:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:47 INFO - 'LOGNAME': 'cltbld', 17:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:47 INFO - 'MOZ_NO_REMOTE': '1', 17:28:47 INFO - 'NO_EM_RESTART': '1', 17:28:47 INFO - 'PAGER': '/bin/cat', 17:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:47 INFO - 'PWD': '/builds/slave/test', 17:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:47 INFO - 'SHELL': '/bin/bash', 17:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:47 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:47 INFO - 'USER': 'cltbld', 17:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:47 INFO - 'XPC_FLAGS': '0x0', 17:28:47 INFO - 'XPC_SERVICE_NAME': '0', 17:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:47 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:47 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 17:28:47 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 17:28:47 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 17:28:47 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 17:28:47 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 17:28:47 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 17:28:49 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:50 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 17:28:51 INFO - Downloading docopt-0.6.1.tar.gz 17:28:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:51 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:51 INFO - Running setup.py install for blobuploader 17:28:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:51 INFO - Running setup.py install for requests 17:28:51 INFO - Running setup.py install for docopt 17:28:52 INFO - Successfully installed blobuploader requests docopt 17:28:52 INFO - Cleaning up... 17:28:52 INFO - Return code: 0 17:28:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:52 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:52 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 17:28:52 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 17:28:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:52 INFO - 'HOME': '/Users/cltbld', 17:28:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:52 INFO - 'LOGNAME': 'cltbld', 17:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:52 INFO - 'MOZ_NO_REMOTE': '1', 17:28:52 INFO - 'NO_EM_RESTART': '1', 17:28:52 INFO - 'PAGER': '/bin/cat', 17:28:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:52 INFO - 'PWD': '/builds/slave/test', 17:28:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:52 INFO - 'SHELL': '/bin/bash', 17:28:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:52 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:52 INFO - 'USER': 'cltbld', 17:28:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:52 INFO - 'XPC_FLAGS': '0x0', 17:28:52 INFO - 'XPC_SERVICE_NAME': '0', 17:28:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-JK3Nm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-hEFBdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BL2hlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MTcMF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-fy302B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:52 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-1BSlCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-J4gHKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-SPPbyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-VsJHH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-8vnQQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-WoVMPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Fye5zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-1j11zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-fHjgh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:53 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-VKqlwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:54 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-YuXMcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:54 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-D4qb50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:54 INFO - Running setup.py install for manifestparser 17:28:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:54 INFO - Running setup.py install for mozcrash 17:28:54 INFO - Running setup.py install for mozdebug 17:28:54 INFO - Running setup.py install for mozdevice 17:28:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:54 INFO - Running setup.py install for mozfile 17:28:54 INFO - Running setup.py install for mozhttpd 17:28:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Running setup.py install for mozinfo 17:28:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Running setup.py install for mozInstall 17:28:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Running setup.py install for mozleak 17:28:55 INFO - Running setup.py install for mozlog 17:28:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Running setup.py install for moznetwork 17:28:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:55 INFO - Running setup.py install for mozprocess 17:28:56 INFO - Running setup.py install for mozprofile 17:28:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:56 INFO - Running setup.py install for mozrunner 17:28:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:56 INFO - Running setup.py install for mozscreenshot 17:28:56 INFO - Running setup.py install for moztest 17:28:56 INFO - Running setup.py install for mozversion 17:28:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:56 INFO - Cleaning up... 17:28:56 INFO - Return code: 0 17:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:56 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')]} 17:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:56 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')]} 17:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:56 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:28:56 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 17:28:56 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 17:28:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:28:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:28:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:28:56 INFO - 'HOME': '/Users/cltbld', 17:28:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:28:56 INFO - 'LOGNAME': 'cltbld', 17:28:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:56 INFO - 'MOZ_NO_REMOTE': '1', 17:28:56 INFO - 'NO_EM_RESTART': '1', 17:28:56 INFO - 'PAGER': '/bin/cat', 17:28:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:28:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:56 INFO - 'PWD': '/builds/slave/test', 17:28:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:28:56 INFO - 'SHELL': '/bin/bash', 17:28:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:28:56 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:28:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:28:56 INFO - 'USER': 'cltbld', 17:28:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:28:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:28:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:56 INFO - 'XPC_FLAGS': '0x0', 17:28:56 INFO - 'XPC_SERVICE_NAME': '0', 17:28:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-_5b8Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-aW14tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BxpOeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BfRaP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-vfVI1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-wtPAZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-nZPuTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-V4yc_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:57 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)) 17:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:57 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Eoozue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ynJYt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-oOvvvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-VsvyYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-XSkI6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-hXeT6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MqsLSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-jy4oN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:58 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)) 17:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:58 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-mlFlsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:58 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)) 17:28:58 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)) 17:28:58 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)) 17:28:58 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)) 17:28:58 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)) 17:28:58 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)) 17:28:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:01 INFO - Downloading blessings-1.6.tar.gz 17:29:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:29:01 INFO - Installing collected packages: blessings 17:29:01 INFO - Running setup.py install for blessings 17:29:01 INFO - Successfully installed blessings 17:29:01 INFO - Cleaning up... 17:29:01 INFO - Return code: 0 17:29:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:29:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:02 INFO - Reading from file tmpfile_stdout 17:29:02 INFO - Current package versions: 17:29:02 INFO - blessings == 1.6 17:29:02 INFO - blobuploader == 1.2.4 17:29:02 INFO - docopt == 0.6.1 17:29:02 INFO - functools32 == 3.2.3-2 17:29:02 INFO - jsonschema == 2.5.1 17:29:02 INFO - manifestparser == 1.1 17:29:02 INFO - mozInstall == 1.12 17:29:02 INFO - mozcrash == 0.17 17:29:02 INFO - mozdebug == 0.1 17:29:02 INFO - mozdevice == 0.48 17:29:02 INFO - mozfile == 1.2 17:29:02 INFO - mozhttpd == 0.7 17:29:02 INFO - mozinfo == 0.9 17:29:02 INFO - mozleak == 0.1 17:29:02 INFO - mozlog == 3.3 17:29:02 INFO - moznetwork == 0.27 17:29:02 INFO - mozprocess == 0.23 17:29:02 INFO - mozprofile == 0.28 17:29:02 INFO - mozrunner == 6.12 17:29:02 INFO - mozscreenshot == 0.1 17:29:02 INFO - mozsystemmonitor == 0.3 17:29:02 INFO - moztest == 0.7 17:29:02 INFO - mozversion == 1.4 17:29:02 INFO - psutil == 3.1.1 17:29:02 INFO - requests == 1.2.3 17:29:02 INFO - wsgiref == 0.1.2 17:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:02 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:29:02 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 17:29:02 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 17:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:02 INFO - 'HOME': '/Users/cltbld', 17:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:02 INFO - 'LOGNAME': 'cltbld', 17:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:02 INFO - 'MOZ_NO_REMOTE': '1', 17:29:02 INFO - 'NO_EM_RESTART': '1', 17:29:02 INFO - 'PAGER': '/bin/cat', 17:29:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:02 INFO - 'PWD': '/builds/slave/test', 17:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:02 INFO - 'SHELL': '/bin/bash', 17:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:29:02 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:02 INFO - 'USER': 'cltbld', 17:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:02 INFO - 'XPC_FLAGS': '0x0', 17:29:02 INFO - 'XPC_SERVICE_NAME': '0', 17:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 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)) 17:29:02 INFO - Cleaning up... 17:29:02 INFO - Return code: 0 17:29:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:02 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 0x1026bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102754618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f9b55b720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, '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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 17:29:02 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 17:29:02 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 17:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:02 INFO - 'HOME': '/Users/cltbld', 17:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:02 INFO - 'LOGNAME': 'cltbld', 17:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:02 INFO - 'MOZ_NO_REMOTE': '1', 17:29:02 INFO - 'NO_EM_RESTART': '1', 17:29:02 INFO - 'PAGER': '/bin/cat', 17:29:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:02 INFO - 'PWD': '/builds/slave/test', 17:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:02 INFO - 'SHELL': '/bin/bash', 17:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:29:02 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:02 INFO - 'USER': 'cltbld', 17:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:02 INFO - 'XPC_FLAGS': '0x0', 17:29:02 INFO - 'XPC_SERVICE_NAME': '0', 17:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:29:02 INFO - Cleaning up... 17:29:02 INFO - Return code: 0 17:29:02 INFO - Running post-action listener: _resource_record_post_action 17:29:02 INFO - Running post-action listener: _start_resource_monitoring 17:29:02 INFO - Starting resource monitoring. 17:29:02 INFO - [mozharness: 2016-09-09 00:29:02.634867Z] Finished create-virtualenv step (success) 17:29:02 INFO - [mozharness: 2016-09-09 00:29:02.636015Z] Running install step. 17:29:02 INFO - Running pre-action listener: _resource_record_pre_action 17:29:02 INFO - Running main action method: install 17:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:02 INFO - Reading from file tmpfile_stdout 17:29:02 INFO - Detecting whether we're running mozinstall >=1.0... 17:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:29:02 INFO - Reading from file tmpfile_stdout 17:29:02 INFO - Output received: 17:29:02 INFO - Usage: mozinstall [options] installer 17:29:02 INFO - Options: 17:29:02 INFO - -h, --help show this help message and exit 17:29:02 INFO - -d DEST, --destination=DEST 17:29:02 INFO - Directory to install application into. [default: 17:29:02 INFO - "/builds/slave/test"] 17:29:02 INFO - --app=APP Application being installed. [default: firefox] 17:29:02 INFO - mkdir: /builds/slave/test/build/application 17:29:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:29:37 INFO - Reading from file tmpfile_stdout 17:29:37 INFO - Output received: 17:29:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:29:37 INFO - Running post-action listener: _resource_record_post_action 17:29:37 INFO - [mozharness: 2016-09-09 00:29:37.232155Z] Finished install step (success) 17:29:37 INFO - [mozharness: 2016-09-09 00:29:37.232368Z] Running run-tests step. 17:29:37 INFO - Running pre-action listener: _resource_record_pre_action 17:29:37 INFO - Running main action method: run_tests 17:29:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:37 INFO - 2016-09-08 17:29:37.247 screenresolution[3173:93863] starting screenresolution argv=screenresolution get 17:29:37 INFO - 2016-09-08 17:29:37.249 screenresolution[3173:93863] Display 0: 1600x1200x32@60 17:29:37 INFO - 2016-09-08 17:29:37.255 screenresolution[3174:93865] starting screenresolution argv=screenresolution list 17:29:37 INFO - Available Modes on Display 0 17:29:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:37 INFO - Intel Iris: 17:29:37 INFO - Chipset Model: Intel Iris 17:29:37 INFO - Type: GPU 17:29:37 INFO - Bus: Built-In 17:29:37 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:37 INFO - Vendor: Intel (0x8086) 17:29:37 INFO - Device ID: 0x0a2e 17:29:37 INFO - Revision ID: 0x0009 17:29:37 INFO - Displays: 17:29:37 INFO - Display: 17:29:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:37 INFO - Display Serial Number: 1600x1200 60 17:29:37 INFO - Main Display: Yes 17:29:37 INFO - Mirror: Off 17:29:37 INFO - Online: Yes 17:29:37 INFO - Rotation: Supported 17:29:37 INFO - Return code: 0 17:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:29:37 INFO - Python 2.7.3 17:29:37 INFO - Return code: 0 17:29:37 INFO - grabbing minidump binary from tooltool 17:29:37 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')]} 17:29:37 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 0x102623d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10261bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:29:37 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 17:29:37 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 17:29:37 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 17:29:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:29:37 INFO - Return code: 0 17:29:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:29:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:29:37 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/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 17:29:37 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/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --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 17:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iXTAEx41DH/Render', 17:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:37 INFO - 'HOME': '/Users/cltbld', 17:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:37 INFO - 'LOGNAME': 'cltbld', 17:29:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:29:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:37 INFO - 'MOZ_NO_REMOTE': '1', 17:29:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:29:37 INFO - 'NO_EM_RESTART': '1', 17:29:37 INFO - 'PAGER': '/bin/cat', 17:29:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:37 INFO - 'PWD': '/builds/slave/test', 17:29:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:37 INFO - 'SHELL': '/bin/bash', 17:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQUHyVfOqJ/Listeners', 17:29:37 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 17:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:37 INFO - 'USER': 'cltbld', 17:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:37 INFO - 'XPC_FLAGS': '0x0', 17:29:37 INFO - 'XPC_SERVICE_NAME': '0', 17:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:37 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/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 17:29:37 INFO - mozversion application_buildid: 20160908153031 17:29:37 INFO - mozversion application_changeset: 4cb8b7cc27e113f269ab8ecede30f832ffede2dc 17:29:37 INFO - mozversion application_display_name: Nightly 17:29:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:29:37 INFO - mozversion application_name: Firefox 17:29:37 INFO - mozversion application_remotingname: firefox 17:29:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:29:37 INFO - mozversion application_vendor: Mozilla 17:29:37 INFO - mozversion application_version: 51.0a1 17:29:37 INFO - mozversion platform_buildid: 20160908153031 17:29:37 INFO - mozversion platform_changeset: 4cb8b7cc27e113f269ab8ecede30f832ffede2dc 17:29:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:29:37 INFO - mozversion platform_version: 51.0a1 17:29:37 INFO - using testdate: 1473380977 17:29:37 INFO - actual date: 1473380977 17:29:37 INFO - starting webserver on 'localhost:51956' 17:29:37 INFO - SUITE-START | Running 2 tests 17:29:37 INFO - TEST-START | dromaeo_css 17:29:37 INFO - operating with platform_type : mac_ 17:29:37 INFO - Initialising browser for dromaeo_css test... 17:29:37 INFO - TEST-INFO | started process 3184 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpKX1Ju1/profile http://localhost:51956/getInfo.html) 17:29:40 INFO - PROCESS | 3184 | __metrics Screen width/height:1600/1200 17:29:40 INFO - PROCESS | 3184 | colorDepth:24 17:29:40 INFO - PROCESS | 3184 | Browser inner width/height: 1024/689 17:29:40 INFO - PROCESS | 3184 | __metrics 17:29:40 INFO - PROCESS | 3184 | 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" 17:29:40 INFO - PROCESS | 3184 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:40 INFO - TEST-INFO | 3184: exit 0 17:29:40 INFO - Browser initialized. 17:29:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:29:40 INFO - TEST-INFO | started process 3187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpKX1Ju1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:52 INFO - PROCESS | 3187 | RSS: Main: 232267776 17:29:52 INFO - PROCESS | 3187 | 17:30:44 INFO - PROCESS | 3187 | 1473381044668 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] 17:32:55 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51956/tests/dromaeo/cssquery-ext.html) 17:32:57 INFO - PROCESS | 3187 | RSS: Main: 344616960 17:32:57 INFO - PROCESS | 3187 | 17:36:00 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-ext.html (next: http://localhost:51956/tests/dromaeo/cssquery-jquery.html) 17:36:01 INFO - PROCESS | 3187 | RSS: Main: 368029696 17:36:01 INFO - PROCESS | 3187 | 17:39:03 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51956/tests/dromaeo/cssquery-mootools.html) 17:39:04 INFO - PROCESS | 3187 | RSS: Main: 334483456 17:39:04 INFO - PROCESS | 3187 | 17:42:06 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51956/tests/dromaeo/cssquery-prototype.html) 17:42:07 INFO - PROCESS | 3187 | RSS: Main: 347873280 17:42:07 INFO - PROCESS | 3187 | 17:45:10 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51956/tests/dromaeo/cssquery-yui.html) 17:45:11 INFO - PROCESS | 3187 | RSS: Main: 328245248 17:45:11 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | Cycle 1(1): loaded http://localhost:51956/tests/dromaeo/cssquery-yui.html (next: http://localhost:51956/tests/dromaeo/cssquery-dojo.html) 17:48:14 INFO - PROCESS | 3187 | RSS: Main: 483733504 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | __start_tp_report 17:48:14 INFO - PROCESS | 3187 | _x_x_mozilla_page_load 17:48:14 INFO - PROCESS | 3187 | _x_x_mozilla_page_load_details 17:48:14 INFO - PROCESS | 3187 | |i|pagename|runs| 17:48:14 INFO - PROCESS | 3187 | |0;dojo.html;3321.767476276661;3323.0363194673546;3334.733221342293;3368.258983023734;3389.6610338966107;5619.466150715686;5672.035753921833;5717.514011309038;5733.369329373765;5737.909797138546;4603.309503574474;5710.5717071219615;5788.797392091277;5808.59339846211;5860.794872179475;5115.53960143587;5138.2806407103035;5209.557187639036;5219.634625576211;5287.550558202557;5315.229291752694;5321.707306098163;5329;5337.439568845273;5353.491418315254;5150.536451719363;5207.739613019372;5212.791488340462;5227.7908883644795;5251.396089449724;5216.061109000379;5218.843434696965;5244.632875698702;5244.632875698702;5246.160614301732;5135.204043373283;5154.871128221787;5164.664296820694;5179.792808287664;5196.844094677166;5639.971800140973;5661.886762264731;5709.600327977043;5738.196652468658;5773.422657734235;4746.881327966794;6224.844378890564;6248.31268560458;6252.843678908018;6274.215723034621;5907.320658124285;6194.163787888668;6211.751529938797;6245.7501699931945;6277.811665650038;5809.50619197373;5822.272215973004;5827.184194212814;5829.271341082364;5831.504322132581;4779.224412713987;5060.797568097309;5897.967855625248;6330.240371155491;6331.873362532723;6022;6115.327313995457;6129.111278864629;6139.062858969336;6190.226221722285;6274.152989346379;6282.089097080898;6288.968555157195;6291.811245662638;6301.590396624205;6164.106204600397;6171.7531298748445;6226.688665566703;6230.190075290274;6237.438630523275;6121.418465245794;6154.78458253959;6154.861350650144;6234.906476402857;6236.18929539166;4920.40955085392;4951.455339912607;4965.0566392385335;4971.90056198874;4996.250562415594;3740.887773366749;4430.401895744098;4447.599716025573;4462.665300102505;4477.686561940633;5600.4959553640365;5626.240457538262;5694.97152514243;5754.165645981309;5778.508826749773;6240.188775459252;6255.718492667841;6270.3416141305415;6276.435120839146;6308.495320374359;5715.533802264544;5740.138979153077;5760.164776107441;5769.85575360611;5795.971020144957;5334.973325133349;5398.028354896078;5444.373897001817;5447.373552041487;5474.315710536183;6238.937610623836;6263.248410190807;6298.622082675054;6301.212348456443;6315.147455093504;6203.565750397609;6221;6255.311915689362;6299.748010079546;6323.399277068671;6334.208223972004;6344.524160687874;6362.204724409449;6380.170577824853;6387.073874288295;6077.726502307319;6211.937880621317;6226.782062627786;6231.781887633911;6241.96879015602;6159.6612186330185;6225.937740622717;6236.968815155895;6241.282252541016;6243.531735119975;6080.543959202989;6104.3075792339105;6105.682175298917;6140.4473597376455;6171.352008039091;4815.253635686474;5439.401665816677;6077.453029227214;6079.05774604937;6102.054181601681;5775.931452681268;5945.613535120204;5952.97023514897;5954.166416701752;5967.731452084753;5946.643201407929;6031.728572214173;6079.483243924316;6099.329073801967;6124.350421260821;5946.732397042057;5956.523478121827;5977.342492325927;5980.760769569169;6018.638881667114 17:48:14 INFO - PROCESS | 3187 | |1;ext.html;445.5922830609991;476.8712447639135;507.9085764562377;519.4104691175517;530.1914580265095;30677.38645227094;40137.799311003444;41379;41431.71365726852;41552.58447415525;42439.575604243946;42737.572624273824;42757.78621106898;42924;43046.13907721844;9729.173020293283;9935.205183585333;9938.204943604494;9938.403695778241;9951.452670103141;8811.64753409866;9013.369064165478;11897.7620447591;12203.877961220363;12212.69468263296;12145.878541214563;12231.633051008439;12249.387530623479;12257.019438444948;12286.93856530716;8879.245264152554;12153.0277577794;12219.205751626116;12237.632871013884;12246.93876530616;8788.604512796875;8976.012638609747;8982.28141748665;11700.941495292554;12015;40726;41207.79396103;41250.76247712573;41301.79349103265;41485.79257103725;3318.900432987014;3406.2506248625264;3521.8591256349714;3880.9029774255587;3881.1849511602595;29669;31111.75552977878;31299.84350078235;31923.201919951956;31940.20149496258;3224.742020638343;3261.951070733941;3280.343931213743;3280.3767284215924;3362.1930736623035;412188;463431;464029.23736863845;464775;466183.338166614;47998.5200148001;57822.7108864453;58230.12654810181;58239.417605824245;58366.8326633465;61927.6903615479;62017.68991155105;62086.689566551875;62090;62206.68896655488;16101.677966440606;16345.346186152421;16348.509544713677;16374.83625163757;16380.508584742476;11383.601573944872;11610.70973225676;12627.873721262853;12633.87366126327;12664.620061398173;16084.678306433805;16214.270357833926;16371.345146194019;16631.91892526982;16661.91697539656;7032.472564557678;7056.858862822714;7090.787276381717;7109.1824440189;7155.463340249502;826.3554427546524;925.9166674999283;933.5332333833084;1021.6066814276409;1059.4490864750287;27528;29522;30441.84779076135;30457.23856903595;30496.69503304983;985.5417230987625;997.2869398380193;1047.7433028907967;1079.4386918802336;1079.8272276435732;14507.782383264259;14816.62958426048;15366.923165384102;15398.845086618549;15867;572813;573511;578313;580904.190958085;583368;57014.714926425106;57171.42828571661;57272.28183154512;57278.42721572731;57410.71294643584;1224.1859163656247;1286.4596869314723;1364.7270545890863;1400.250865786799;1401.8808401286005;27776.861115694293;28795.136145915658;30286.69713302927;31066.534001989538;31407.685923140478;40441.59558404378;48957.020859583325;49453.50546494489;49498;49773.50226497689;507819.4609026931;514141;514399;516461;517342;25323;26227.344316392242;26263.080792172183;26876.462470750866;26899.86550067237;46275.84310392267;46723;47656.5234347666;47718.568442946766;48326.55020349395;38539;38610.613893861824;38865.222695545366;40482;40969.79515102405;38216.80891595524;38225.61774382332;38500;39778;39829.80085099556;37013.259734805695;37620.435693465166;38239.235215296096;38349.424758629204;38379;32451.02646920596;33372.499412509314;34159.658403416644;34289;34516.309673806885;25006.499870002863;25076.498470030132;25259.989600415778;25330.89411388338;25677.871610642575 17:48:14 INFO - PROCESS | 3187 | |2;jquery.html;350.92104276537765;361.6401680328073;368.24142266930124;382.3022983055924;400.98997525061867;15308.540743777676;15641.296141673623;20337.28819491318;21627.3511794646;22031.66952495714;18098.185581648824;20372.185112595478;20534.281300154496;21121.366359009255;21173.258935937247;5928.466438020567;6256.061590761399;6275.341089185638;6275.780347687832;6287.874242515147;5909.11363295507;6102.786402475915;6114.571979961404;6171.969140154293;6179.81460556184;6138.570300078974;6143.44708976192;6146.539009574278;6156.630602163862;6157.091301696466;5593.57363872212;5719.885602287952;6123.326434092246;6131.63210207389;6139.293981192175;5186.196139598368;5315.7873685052555;5321.201819727034;5321.467853214647;5325.227841962933;12886.226826390446;13605.91152707781;13617.863821361758;13620.863791362059;16126;2273.658951157323;2273.8971598774747;2399.6280576510667;2549.235229431163;2791.6091747155415;8124.959375203145;10084.647037353658;10148.847767283496;10415.583376664925;10569.73575660607;1787.7765279340083;1838.4117082533594;1875.6530041942285;1903.5146037760421;1907.3705677126516;126653.73346266511;131471;134940.22888512217;139918.43588820886;151304.243478783;18824.623507530046;19944.800551994584;20466;21398.893005534872;21512.031958561904;28978.985735499155;30170.24574385658;32616.510752338734;33927.83036084853;33928.1517962048;10313.020263074995;10906.61826836057;10934.781304373868;10995.285306455055;11129.666110016713;7233.602151881591;8853.955730221307;9060.456372617664;9075.455472671661;9266;8368.456050356708;9317.34778565494;9510.476923769122;9582.760430989281;9740.512974351253;3032.9090127296217;3150.5431712401573;3649.5183275373;3660.871869484555;3672.4491326301268;780.3094261578431;823.9011318641801;922.9340112170454;1000.8748906386702;1031.783325501653;19421.611567768567;22296.55406891853;22313.107475701116;22352;22511.774882250967;895.4806212396794;898.667493027584;966.709987003896;972.2513664478454;990.8860481044773;11250.831237531444;11395.829062564067;11402.030827379765;11727.706807329714;11768.94115529417;442879;511112;533358;536350.3182484063;539164;133464;135440;136705;138337.3083134578;139563;962.5524131278848;982.7739619887323;1023.8413045977736;1026.2457094035879;1026.3944272879037;19916.348935872677;20409.693854591897;20616.278430254868;20621.58756824825;20721;55706.44293557013;56893;57158.142627861445;58794;59050;83470;84301;85107.57446212976;85129.57435212785;85297.72053419327;8071.257076800064;8092.87860682102;8095.959520202361;8301.045379781403;8399.874001889855;10093.444860532447;12772.1059525836;13236.801447978096;13664;13881.958853085856;11565.132615053737;11578.421078946187;11874.643760687193;11972.281663100242;12011;10964.616238431936;11453.828192577284;11527.365994870363;11962;12030.458629361525;11482.425878705864;11747.941260293645;11790.764184716429;11868.287902725864;11902.523899043941;8258.263486457678;8262.710805121791;8311.085780564254;8344.123866993878;8451.28164106058;9625.759356015875;11659.883401166218;11953.521859125538;11982.10134239918;12006.519739210335 17:48:14 INFO - PROCESS | 3187 | |3;mootools.html;1353.289523000424;1518.06638917066;1545.9227038648069;1750.3348727483553;1901.8668693191482;7718.691252349906;8592.785180370494;8845.159709827572;8870.068642792503;8931.955340223307;8714.041455439896;8775.297976161908;8787.12128787121;8787.736367908972;8812.559372031388;2337.7311609164994;2403.843750156243;2403.9759602404015;2409.084547871815;2409.2170044735444;2333.265021518225;2383.7735415135535;2384.666146739458;2388.9880550597222;2395.2335252719135;2355.1756885090253;2373.6558199061124;2385.940351491209;2394.784469397754;2396.065534441569;2338.5790557699606;2363.7163540375177;2371.7983971362455;2372.8694921779384;2388;2328.8020518255967;2366.988165059181;2367.775061369184;2370.608849539824;2380.6548050532574;8575.571221438966;8759.211670949646;8811.867821982676;8862.158094980967;8868.423552469068;5232.790688372461;5412.4587541245955;5414.756335964852;5418.674879507243;5423.349198096214;3076.415481058592;3597;3621.8189090545366;3689.18837855674;3700.611435799256;1031.4224034540607;1054.3094273251033;1774.902380369079;1832.679281125811;1889.461503471504;11225.831612525819;11498.712532186762;11600.941995290053;11727.882721172764;11823.34971576563;4156.771377574262;4404.295312749945;4498.820047198075;4576.244919588231;4607.976960115178;8076.273135417723;9140.177384035336;9149.405288656217;9157.77105572366;9167.633294668138;4458.7324760514475;5200.271961925334;5249.317588713443;5258.421573626898;5259.053370393366;4020.6582440492884;4379.255526560492;4956.504349565014;4977.004599080198;5006.374203224597;3683.2136413839266;3750.887473375803;3808.961910380861;3844.8654297100024;3847.2690188864026;1138.8576427946507;1147.2198904744687;1152.5793085523724;1162.3955543117531;1163.4822503985815;812.7114874219567;882.5349919134206;892.9285657147412;916.093067862811;939.0515579264992;5513.173024046345;5558.749856256478;5902.911456328158;5994.710549515165;6036.124761909498;436.3302330922019;446.792241607654;454.5295619034284;455.70151550734323;456.792159567396;3796.6528325068193;3832.616738326201;3951.3480275754755;3986.521617405872;3989.1423343981182;9116.8632470513;10326.380417174994;10917.344959302467;10922.617708380169;10924.672259832218;10365.896341036643;10861.294015888941;10867.728306792393;10883.67348979532;10886.23796334249;6704.3295670433545;8280.337572994145;8295.875561866576;8299.419040667095;8301.460405073773;5490.588205884655;5616.915746263891;5787.971060144672;5912.46787789101;5918.053111502139;9956.850647240153;9963.202943764336;10003.2997690161;10035.749106272402;10058.8491172631;9746.26902982265;10060.69817905464;10098.596056157672;10138.898611013796;10338.741531461474;6454.903176452263;6684.331566843277;6805.93194068053;6860.348266914635;6920.515563910478;8381.413301068867;8528.74413767588;8536.189062039097;8545.529995850287;8546.444481108709;7349.485536012642;7469.514481558898;7526.698932042876;7695.730649427243;7729.497582657109;7253.310935461122;7360.411167106511;7379.778606641809;7383.963080184565;7607.581583012766;6794.524383293122;6948.305169483214;6959.234484206834;6964;6966.5471744336455;4874.073925954199;5080;5093.770780314969;5167.741612919263;5196.454372291007;4909.165441874961;5158.690478571298;5171.250843138694;5215.191645294985;5376.596755243294 17:48:14 INFO - PROCESS | 3187 | |4;prototype.html;293.87363433723505;298.09082298988085;307.5770815129198;308.5341134886321;309.7351764241572;4699.671023028381;4967.354243948282;5237.84286471406;5242.397124330703;5327.72134687675;3898.3567711327596;4433.778311084441;4980.501949805027;5163.218689552098;5174.689518628885;3985.6612187964056;4002.0990029735935;4017.0760725033115;4017.292650623488;4020.7386519876113;3767.227718317752;4010.498687664042;4019.799010049486;4030.476038115041;4036.1725846201457;3916.295066887959;3987.4018897165365;3998.6001399860074;3999.9200015999663;4006.3589825627905;3387.61042480113;3944.921101577981;3993.820278087493;3994.62051105146;4013.578574249691;3415.641357657435;3427.1946092668204;3443.276911848515;3456.2914602506426;3469.2887957968555;4458.665600080007;4562.726236425825;4734.55021772931;5015.949840501585;5167;4502.279635258343;4502.909941801146;4510.1656193604285;4514.503404625489;4532.27483602622;5487.725613719298;5514.889702205934;5537.612367134302;5544.77820887164;5599.600099975006;3184.9681503185134;3718.758280711745;3736.40217565191;3742.850285988557;3770.9057273568105;4624.439181830039;5701.600887937804;5804.651720896717;5895.4399332063385;5899.73451194693;3830.961690383116;3852.57621661617;3865.2849222893856;3868.1876805871084;3881.165549406891;3607.3867442534834;3837.2517359114704;3845.307844587945;3887.280853042196;3924.4309575111447;3952.3676211805973;4067.9593204067583;4455.309427038814;4481.439820022497;4560.726356418625;5032.72320022395;5214.817481388133;5498.45015498455;5530;5593.105103183552;1244.023441598359;1265.9619112327987;1274.5029438518984;1279.6672865055152;1283.6906355517506;771.5833449937084;793.738066438074;798.7843282313859;811.1685522339532;835.4319063037193;3703.148275896559;3713.721470889694;3971.3050216212046;4314.223439780807;4321.913561728811;3907.628775266345;4683.587952204617;4697.459792123881;4731.929021064687;4787.928181077286;3559.7864128152396;3935.4490371348033;4266.658667306608;4274.636655884285;4317.892052698708;2340.742518322983;2371.8221133415063;2447.706275246982;2456.5679976823176;2457.6482934386017;3900.7464514806447;4083.754974701468;4780.330753694486;4826.855194344175;4927.501473953462;3664.486971823947;3923.6664883485223;4075.206908960048;4478.507364189936;4699.295105734167;4350.760708161081;4720.929186062281;4722.899268789699;4886;4889.242167463977;4387.758673273001;4407.713498622579;4561.954380456285;4627.177421772649;4682.836100736458;3588.3391033491766;3921.7645941812893;4003.8398464062275;4021.5777343379696;4636.406784741852;4163.75017498951;4421.270490369053;4618.907621847611;4818.494058123987;4880.975595122001;3209.1759251858216;3217.6299725531862;3231.8060916345094;3235.320582677664;3238.757093218065;3879.7866117362687;4556.794944227451;4568.88577785558;4609.308603709336;4614.630829533562;3424.229548351601;3684.834182461742;4072.6538244249573;4476.462824461086;4485.416895803524;3793.520526994419;4000.2999475092324;4142.337226043818;4150.900011496896;4166.2919102582355;3890.024131539431;4442.844500442469;4818.518148185293;5050.878630975073;5086.304258742724;5463.153211252104;5525.171224316385;5541.3904470507405;5559.777608895599;5586.497215250647;4163.562825903236;4613.838515652071;4735.668503204881;5079.72061536619;5431.646942948696 17:48:14 INFO - PROCESS | 3187 | |5;yui.html;717.7057406463348;763.6449051191197;766.1113108793796;766.5975362934461;791.7980914866708;15360.308786104624;16215.027098374076;16292;16314.918425407886;16348.264328105233;14615.78076328856;14742.189179595118;14744.483943061994;14759.335829887681;14766;676.4689718570922;696.0325148044197;696.52984235641;697.7069630755095;846.3018010141627;676.3169199108886;840.3949156607264;864.7881269089082;870.212457725756;873.5675840458981;899.2176806178634;905.8052518708477;910.512875611548;912.3248795891026;912.7672443526891;902.6975963052419;903.5391950105494;904.0507467159522;905.112989270512;905.4069584422214;526.1029943945601;544.8801263721975;669.9816279255552;670.1723371636026;673.0005941177347;12371.381430928417;12420.316882571455;14337.928310358486;14934.954553181282;14939.028963117471;14330.92834535831;14848.466793771833;14870.330835112338;14939.253037348199;15007;11479.770404591945;11717.765644687059;11745.11911606633;11780.941095294555;12207.389630518439;3778.622137786227;3804.809759512041;3844.9807750961345;3953.367461206222;3957.08986933007;110325.44837275843;111890.44054779674;112260;112301;113021;10062.19502439803;10752.301100428447;10871.619493317696;10917.781644367069;11366.374849383197;21496.89251553732;21599.67600485994;21660.675089873665;21775.346739597837;21789;7825.569593672289;7849.450538462367;7897.644605992744;7915.525068495794;8066.475679080841;4329.307310830252;4444.933326000048;4522.321651752263;4538.954610453853;4564.3838081859185;3619.8552057917914;3761.6990640748672;3764.962350376516;3765.0963768695315;3766.9058273542832;549.8075673514238;666.3935818405228;678.0270312102149;679.6058286193995;682.8702546516146;607.4654304212353;641.4002907281613;643.4787821864305;659.8977158540434;666.2737615998585;9458;9491.715248542554;9637.71086867395;9642.903570964201;9660.420374777535;642.7043559962469;643.6717274190197;662.1392190152782;666.213867636194;688.944884409246;4409.125611001512;4540.273556230987;4573.931391029138;4663.790129444184;4735.715857048519;155632;156747;158747;164126;167657.3234267666;137537.36640572525;137576;144388;144926.27536862248;145881;103578.48210758898;119907.80092199141;123013;123309.38345308216;124184;9404.717858464257;9837.950810245902;9860.704178874645;9969.35199212049;10026.398416094766;47601;62586.68706656437;63748.40628984127;65177;67168.3283167162;88519.55740221258;91031.0896891049;92527;93079;97830.53254201334;11278.661640150809;13495.25776082325;13560.38978246001;13606.115602485806;13738.793918091436;14850.925745371203;15015.32431040584;15132.773008404663;15489.14809685478;15704.371825126867;13711.588652340446;13882.305884705522;14106.506272280421;14116;14142.858571414154;13729.794053089412;13888.861111388756;13985.160890346611;14081.225532595805;14467.565973020826;12627.494900203888;12829.550965716155;13447.193168409927;13872.791908121588;14172.433102675777;8480.83038339242;10853.475107596376;11365.886341136484;11483.885161148282;11735.295882247092;10963.71555855423;11389.330793283378;11394.772104558027;11525.769484610093;11605.187636865337 17:48:14 INFO - PROCESS | 3187 | __end_tp_report 17:48:14 INFO - PROCESS | 3187 | __start_cc_report 17:48:14 INFO - PROCESS | 3187 | _x_x_mozilla_cycle_collect,1589 17:48:14 INFO - PROCESS | 3187 | __end_cc_report 17:48:14 INFO - PROCESS | 3187 | __startTimestamp1473382094971__endTimestamp 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | ------- Summary: start ------- 17:48:14 INFO - PROCESS | 3187 | Number of tests: 6 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#0] dojo.html Cycles:165 Average:5707.96 Median:5907.32 stddev:660.85 (11.2%) stddev-sans-first:635.81 17:48:14 INFO - PROCESS | 3187 | Values: 3321.8 3323.0 3334.7 3368.3 3389.7 5619.5 5672.0 5717.5 5733.4 5737.9 4603.3 5710.6 5788.8 5808.6 5860.8 5115.5 5138.3 5209.6 5219.6 5287.6 5315.2 5321.7 5329.0 5337.4 5353.5 5150.5 5207.7 5212.8 5227.8 5251.4 5216.1 5218.8 5244.6 5244.6 5246.2 5135.2 5154.9 5164.7 5179.8 5196.8 5640.0 5661.9 5709.6 5738.2 5773.4 4746.9 6224.8 6248.3 6252.8 6274.2 5907.3 6194.2 6211.8 6245.8 6277.8 5809.5 5822.3 5827.2 5829.3 5831.5 4779.2 5060.8 5898.0 6330.2 6331.9 6022.0 6115.3 6129.1 6139.1 6190.2 6274.2 6282.1 6289.0 6291.8 6301.6 6164.1 6171.8 6226.7 6230.2 6237.4 6121.4 6154.8 6154.9 6234.9 6236.2 4920.4 4951.5 4965.1 4971.9 4996.3 3740.9 4430.4 4447.6 4462.7 4477.7 5600.5 5626.2 5695.0 5754.2 5778.5 6240.2 6255.7 6270.3 6276.4 6308.5 5715.5 5740.1 5760.2 5769.9 5796.0 5335.0 5398.0 5444.4 5447.4 5474.3 6238.9 6263.2 6298.6 6301.2 6315.1 6203.6 6221.0 6255.3 6299.7 6323.4 6334.2 6344.5 6362.2 6380.2 6387.1 6077.7 6211.9 6226.8 6231.8 6242.0 6159.7 6225.9 6237.0 6241.3 6243.5 6080.5 6104.3 6105.7 6140.4 6171.4 4815.3 5439.4 6077.5 6079.1 6102.1 5775.9 5945.6 5953.0 5954.2 5967.7 5946.6 6031.7 6079.5 6099.3 6124.4 5946.7 5956.5 5977.3 5980.8 6018.6 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#1] ext.html Cycles:180 Average:65672.97 Median:38519.50 stddev:137892.23 (358.0%) stddev-sans-first:138192.09 17:48:14 INFO - PROCESS | 3187 | Values: 445.6 476.9 507.9 519.4 530.2 30677.4 40137.8 41379.0 41431.7 41552.6 42439.6 42737.6 42757.8 42924.0 43046.1 9729.2 9935.2 9938.2 9938.4 9951.5 8811.6 9013.4 11897.8 12203.9 12212.7 12145.9 12231.6 12249.4 12257.0 12286.9 8879.2 12153.0 12219.2 12237.6 12246.9 8788.6 8976.0 8982.3 11700.9 12015.0 40726.0 41207.8 41250.8 41301.8 41485.8 3318.9 3406.3 3521.9 3880.9 3881.2 29669.0 31111.8 31299.8 31923.2 31940.2 3224.7 3262.0 3280.3 3280.4 3362.2 412188.0 463431.0 464029.2 464775.0 466183.3 47998.5 57822.7 58230.1 58239.4 58366.8 61927.7 62017.7 62086.7 62090.0 62206.7 16101.7 16345.3 16348.5 16374.8 16380.5 11383.6 11610.7 12627.9 12633.9 12664.6 16084.7 16214.3 16371.3 16631.9 16661.9 7032.5 7056.9 7090.8 7109.2 7155.5 826.4 925.9 933.5 1021.6 1059.4 27528.0 29522.0 30441.8 30457.2 30496.7 985.5 997.3 1047.7 1079.4 1079.8 14507.8 14816.6 15366.9 15398.8 15867.0 572813.0 573511.0 578313.0 580904.2 583368.0 57014.7 57171.4 57272.3 57278.4 57410.7 1224.2 1286.5 1364.7 1400.3 1401.9 27776.9 28795.1 30286.7 31066.5 31407.7 40441.6 48957.0 49453.5 49498.0 49773.5 507819.5 514141.0 514399.0 516461.0 517342.0 25323.0 26227.3 26263.1 26876.5 26899.9 46275.8 46723.0 47656.5 47718.6 48326.6 38539.0 38610.6 38865.2 40482.0 40969.8 38216.8 38225.6 38500.0 39778.0 39829.8 37013.3 37620.4 38239.2 38349.4 38379.0 32451.0 33372.5 34159.7 34289.0 34516.3 25006.5 25076.5 25260.0 25330.9 25677.9 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#2] jquery.html Cycles:180 Average:34524.17 Median:2474.43 stddev:87481.15 (3535.4%) stddev-sans-first:87688.93 17:48:14 INFO - PROCESS | 3187 | Values: 350.9 361.6 368.2 382.3 401.0 15308.5 15641.3 20337.3 21627.4 22031.7 18098.2 20372.2 20534.3 21121.4 21173.3 5928.5 6256.1 6275.3 6275.8 6287.9 5909.1 6102.8 6114.6 6172.0 6179.8 6138.6 6143.4 6146.5 6156.6 6157.1 5593.6 5719.9 6123.3 6131.6 6139.3 5186.2 5315.8 5321.2 5321.5 5325.2 12886.2 13605.9 13617.9 13620.9 16126.0 2273.7 2273.9 2399.6 2549.2 2791.6 8125.0 10084.6 10148.8 10415.6 10569.7 1787.8 1838.4 1875.7 1903.5 1907.4 126653.7 131471.0 134940.2 139918.4 151304.2 18824.6 19944.8 20466.0 21398.9 21512.0 28979.0 30170.2 32616.5 33927.8 33928.2 10313.0 10906.6 10934.8 10995.3 11129.7 7233.6 8854.0 9060.5 9075.5 9266.0 8368.5 9317.3 9510.5 9582.8 9740.5 3032.9 3150.5 3649.5 3660.9 3672.4 780.3 823.9 922.9 1000.9 1031.8 19421.6 22296.6 22313.1 22352.0 22511.8 895.5 898.7 966.7 972.3 990.9 11250.8 11395.8 11402.0 11727.7 11768.9 442879.0 511112.0 533358.0 536350.3 539164.0 133464.0 135440.0 136705.0 138337.3 139563.0 962.6 982.8 1023.8 1026.2 1026.4 19916.3 20409.7 20616.3 20621.6 20721.0 55706.4 56893.0 57158.1 58794.0 59050.0 83470.0 84301.0 85107.6 85129.6 85297.7 8071.3 8092.9 8096.0 8301.0 8399.9 10093.4 12772.1 13236.8 13664.0 13882.0 11565.1 11578.4 11874.6 11972.3 12011.0 10964.6 11453.8 11527.4 11962.0 12030.5 11482.4 11747.9 11790.8 11868.3 11902.5 8258.3 8262.7 8311.1 8344.1 8451.3 9625.8 11659.9 11953.5 11982.1 12006.5 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#3] mootools.html Cycles:180 Average:5643.71 Median:4932.83 stddev:3163.79 (64.1%) stddev-sans-first:3156.23 17:48:14 INFO - PROCESS | 3187 | Values: 1353.3 1518.1 1545.9 1750.3 1901.9 7718.7 8592.8 8845.2 8870.1 8932.0 8714.0 8775.3 8787.1 8787.7 8812.6 2337.7 2403.8 2404.0 2409.1 2409.2 2333.3 2383.8 2384.7 2389.0 2395.2 2355.2 2373.7 2385.9 2394.8 2396.1 2338.6 2363.7 2371.8 2372.9 2388.0 2328.8 2367.0 2367.8 2370.6 2380.7 8575.6 8759.2 8811.9 8862.2 8868.4 5232.8 5412.5 5414.8 5418.7 5423.3 3076.4 3597.0 3621.8 3689.2 3700.6 1031.4 1054.3 1774.9 1832.7 1889.5 11225.8 11498.7 11600.9 11727.9 11823.3 4156.8 4404.3 4498.8 4576.2 4608.0 8076.3 9140.2 9149.4 9157.8 9167.6 4458.7 5200.3 5249.3 5258.4 5259.1 4020.7 4379.3 4956.5 4977.0 5006.4 3683.2 3750.9 3809.0 3844.9 3847.3 1138.9 1147.2 1152.6 1162.4 1163.5 812.7 882.5 892.9 916.1 939.1 5513.2 5558.7 5902.9 5994.7 6036.1 436.3 446.8 454.5 455.7 456.8 3796.7 3832.6 3951.3 3986.5 3989.1 9116.9 10326.4 10917.3 10922.6 10924.7 10365.9 10861.3 10867.7 10883.7 10886.2 6704.3 8280.3 8295.9 8299.4 8301.5 5490.6 5616.9 5788.0 5912.5 5918.1 9956.9 9963.2 10003.3 10035.7 10058.8 9746.3 10060.7 10098.6 10138.9 10338.7 6454.9 6684.3 6805.9 6860.3 6920.5 8381.4 8528.7 8536.2 8545.5 8546.4 7349.5 7469.5 7526.7 7695.7 7729.5 7253.3 7360.4 7379.8 7384.0 7607.6 6794.5 6948.3 6959.2 6964.0 6966.5 4874.1 5080.0 5093.8 5167.7 5196.5 4909.2 5158.7 5171.3 5215.2 5376.6 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#4] prototype.html Cycles:180 Average:4033.88 Median:4270.65 stddev:1206.56 (28.3%) stddev-sans-first:1176.83 17:48:14 INFO - PROCESS | 3187 | Values: 293.9 298.1 307.6 308.5 309.7 4699.7 4967.4 5237.8 5242.4 5327.7 3898.4 4433.8 4980.5 5163.2 5174.7 3985.7 4002.1 4017.1 4017.3 4020.7 3767.2 4010.5 4019.8 4030.5 4036.2 3916.3 3987.4 3998.6 3999.9 4006.4 3387.6 3944.9 3993.8 3994.6 4013.6 3415.6 3427.2 3443.3 3456.3 3469.3 4458.7 4562.7 4734.6 5015.9 5167.0 4502.3 4502.9 4510.2 4514.5 4532.3 5487.7 5514.9 5537.6 5544.8 5599.6 3185.0 3718.8 3736.4 3742.9 3770.9 4624.4 5701.6 5804.7 5895.4 5899.7 3831.0 3852.6 3865.3 3868.2 3881.2 3607.4 3837.3 3845.3 3887.3 3924.4 3952.4 4068.0 4455.3 4481.4 4560.7 5032.7 5214.8 5498.5 5530.0 5593.1 1244.0 1266.0 1274.5 1279.7 1283.7 771.6 793.7 798.8 811.2 835.4 3703.1 3713.7 3971.3 4314.2 4321.9 3907.6 4683.6 4697.5 4731.9 4787.9 3559.8 3935.4 4266.7 4274.6 4317.9 2340.7 2371.8 2447.7 2456.6 2457.6 3900.7 4083.8 4780.3 4826.9 4927.5 3664.5 3923.7 4075.2 4478.5 4699.3 4350.8 4720.9 4722.9 4886.0 4889.2 4387.8 4407.7 4562.0 4627.2 4682.8 3588.3 3921.8 4003.8 4021.6 4636.4 4163.8 4421.3 4618.9 4818.5 4881.0 3209.2 3217.6 3231.8 3235.3 3238.8 3879.8 4556.8 4568.9 4609.3 4614.6 3424.2 3684.8 4072.7 4476.5 4485.4 3793.5 4000.3 4142.3 4150.9 4166.3 3890.0 4442.8 4818.5 5050.9 5086.3 5463.2 5525.2 5541.4 5559.8 5586.5 4163.6 4613.8 4735.7 5079.7 5431.6 17:48:14 INFO - PROCESS | 3187 | 17:48:14 INFO - PROCESS | 3187 | [#5] yui.html Cycles:180 Average:25931.90 Median:3690.78 stddev:42298.30 (1146.1%) stddev-sans-first:42374.59 17:48:14 INFO - PROCESS | 3187 | Values: 717.7 763.6 766.1 766.6 791.8 15360.3 16215.0 16292.0 16314.9 16348.3 14615.8 14742.2 14744.5 14759.3 14766.0 676.5 696.0 696.5 697.7 846.3 676.3 840.4 864.8 870.2 873.6 899.2 905.8 910.5 912.3 912.8 902.7 903.5 904.1 905.1 905.4 526.1 544.9 670.0 670.2 673.0 12371.4 12420.3 14337.9 14935.0 14939.0 14330.9 14848.5 14870.3 14939.3 15007.0 11479.8 11717.8 11745.1 11780.9 12207.4 3778.6 3804.8 3845.0 3953.4 3957.1 110325.4 111890.4 112260.0 112301.0 113021.0 10062.2 10752.3 10871.6 10917.8 11366.4 21496.9 21599.7 21660.7 21775.3 21789.0 7825.6 7849.5 7897.6 7915.5 8066.5 4329.3 4444.9 4522.3 4539.0 4564.4 3619.9 3761.7 3765.0 3765.1 3766.9 549.8 666.4 678.0 679.6 682.9 607.5 641.4 643.5 659.9 666.3 9458.0 9491.7 9637.7 9642.9 9660.4 642.7 643.7 662.1 666.2 688.9 4409.1 4540.3 4573.9 4663.8 4735.7 155632.0 156747.0 158747.0 164126.0 167657.3 137537.4 137576.0 144388.0 144926.3 145881.0 103578.5 119907.8 123013.0 123309.4 124184.0 9404.7 9838.0 9860.7 9969.4 10026.4 47601.0 62586.7 63748.4 65177.0 67168.3 88519.6 91031.1 92527.0 93079.0 97830.5 11278.7 13495.3 13560.4 13606.1 13738.8 14850.9 15015.3 15132.8 15489.1 15704.4 13711.6 13882.3 14106.5 14116.0 14142.9 13729.8 13888.9 13985.2 14081.2 14467.6 12627.5 12829.6 13447.2 13872.8 14172.4 8480.8 10853.5 11365.9 11483.9 11735.3 10963.7 11389.3 11394.8 11525.8 11605.2 17:48:14 INFO - PROCESS | 3187 | -------- Summary: end -------- 17:48:14 INFO - PROCESS | 3187 | 17:48:15 INFO - TEST-INFO | 3187: exit 0 17:48:15 INFO - TEST-OK | dromaeo_css | took 1117738ms 17:48:15 INFO - TEST-START | kraken 17:48:15 INFO - operating with platform_type : mac_ 17:48:15 INFO - Initialising browser for kraken test... 17:48:15 INFO - TEST-INFO | started process 3191 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpt7cQW3/profile http://localhost:51956/getInfo.html) 17:48:17 INFO - PROCESS | 3191 | __metrics Screen width/height:1600/1200 17:48:17 INFO - PROCESS | 3191 | colorDepth:24 17:48:17 INFO - PROCESS | 3191 | Browser inner width/height: 1024/689 17:48:17 INFO - PROCESS | 3191 | __metrics 17:48:18 INFO - PROCESS | 3191 | 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" 17:48:18 INFO - PROCESS | 3191 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:48:18 INFO - TEST-INFO | 3191: exit 0 17:48:18 INFO - Browser initialized. 17:48:18 INFO - Running cycle 1/1 for kraken test... 17:48:18 INFO - TEST-INFO | started process 3192 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpt7cQW3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:30 INFO - PROCESS | 3192 | RSS: Main: 232435712 17:48:30 INFO - PROCESS | 3192 | 17:48:33 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51956/tests/kraken/driver.html?testName=audio-beat-detection) 17:48:34 INFO - PROCESS | 3192 | RSS: Main: 292233216 17:48:34 INFO - PROCESS | 3192 | 17:48:36 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51956/tests/kraken/driver.html?testName=audio-dft) 17:48:37 INFO - PROCESS | 3192 | RSS: Main: 289730560 17:48:37 INFO - PROCESS | 3192 | 17:48:40 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51956/tests/kraken/driver.html?testName=audio-fft) 17:48:41 INFO - PROCESS | 3192 | RSS: Main: 376619008 17:48:41 INFO - PROCESS | 3192 | 17:48:43 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51956/tests/kraken/driver.html?testName=audio-oscillator) 17:48:44 INFO - PROCESS | 3192 | RSS: Main: 279109632 17:48:44 INFO - PROCESS | 3192 | 17:48:46 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:48:46 INFO - PROCESS | 3192 | RSS: Main: 283987968 17:48:46 INFO - PROCESS | 3192 | 17:48:49 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51956/tests/kraken/driver.html?testName=imaging-darkroom) 17:48:50 INFO - PROCESS | 3192 | RSS: Main: 321544192 17:48:50 INFO - PROCESS | 3192 | 17:48:53 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51956/tests/kraken/driver.html?testName=imaging-desaturate) 17:48:53 INFO - PROCESS | 3192 | RSS: Main: 322560000 17:48:53 INFO - PROCESS | 3192 | 17:48:56 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51956/tests/kraken/driver.html?testName=json-parse-financial) 17:48:57 INFO - PROCESS | 3192 | RSS: Main: 322269184 17:48:57 INFO - PROCESS | 3192 | 17:48:58 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:48:59 INFO - PROCESS | 3192 | RSS: Main: 297902080 17:48:59 INFO - PROCESS | 3192 | 17:49:01 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:49:01 INFO - PROCESS | 3192 | RSS: Main: 303009792 17:49:01 INFO - PROCESS | 3192 | 17:49:04 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:49:04 INFO - PROCESS | 3192 | RSS: Main: 303030272 17:49:04 INFO - PROCESS | 3192 | 17:49:07 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:49:08 INFO - PROCESS | 3192 | RSS: Main: 317800448 17:49:08 INFO - PROCESS | 3192 | 17:49:11 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:49:11 INFO - PROCESS | 3192 | RSS: Main: 313982976 17:49:11 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | Cycle 1(1): loaded http://localhost:51956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51956/tests/kraken/driver.html?testName=ai-astar) 17:49:13 INFO - PROCESS | 3192 | RSS: Main: 357707776 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | __start_tp_report 17:49:13 INFO - PROCESS | 3192 | _x_x_mozilla_page_load 17:49:13 INFO - PROCESS | 3192 | _x_x_mozilla_page_load_details 17:49:13 INFO - PROCESS | 3192 | |i|pagename|runs| 17:49:13 INFO - PROCESS | 3192 | |0;ai-astar;114;114;118;115;113;114;114;113;113;122 17:49:13 INFO - PROCESS | 3192 | |1;audio-beat-detection;151;110;134;164;107;134;134;107;160;107 17:49:13 INFO - PROCESS | 3192 | |2;audio-dft;184;187;186;184;183;183;182;182;184;185 17:49:13 INFO - PROCESS | 3192 | |3;audio-fft;77;87;109;186;58;58;57;65;147;58 17:49:13 INFO - PROCESS | 3192 | |4;audio-oscillator;83;83;138;70;71;77;123;70;70;123 17:49:13 INFO - PROCESS | 3192 | |5;imaging-gaussian-blur;87;86;88;86;88;84;89;85;87;85 17:49:13 INFO - PROCESS | 3192 | |6;imaging-darkroom;96;97;97;97;97;98;97;97;96;98 17:49:13 INFO - PROCESS | 3192 | |7;imaging-desaturate;85;85;84;84;83;81;83;85;84;84 17:49:13 INFO - PROCESS | 3192 | |8;json-parse-financial;54;54;54;54;53;53;55;54;54;54 17:49:13 INFO - PROCESS | 3192 | |9;json-stringify-tinderbox;63;66;65;76;71;77;72;74;70;72 17:49:13 INFO - PROCESS | 3192 | |10;stanford-crypto-aes;84;86;86;86;82;84;87;85;97;109 17:49:13 INFO - PROCESS | 3192 | |11;stanford-crypto-ccm;140;140;140;151;149;135;138;145;180;150 17:49:13 INFO - PROCESS | 3192 | |12;stanford-crypto-pbkdf2;169;169;172;172;170;169;167;168;169;171 17:49:13 INFO - PROCESS | 3192 | |13;stanford-crypto-sha256-iterative;67;67;68;68;67;67;68;66;66;66 17:49:13 INFO - PROCESS | 3192 | __end_tp_report 17:49:13 INFO - PROCESS | 3192 | __start_cc_report 17:49:13 INFO - PROCESS | 3192 | _x_x_mozilla_cycle_collect,2093 17:49:13 INFO - PROCESS | 3192 | __end_cc_report 17:49:13 INFO - PROCESS | 3192 | __startTimestamp1473382153944__endTimestamp 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | ------- Summary: start ------- 17:49:13 INFO - PROCESS | 3192 | Number of tests: 14 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:2.87 (2.5%) stddev-sans-first:3.02 17:49:13 INFO - PROCESS | 3192 | Values: 114.0 114.0 118.0 115.0 113.0 114.0 114.0 113.0 113.0 122.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#1] audio-beat-detection Cycles:10 Average:130.80 Median:134.00 stddev:22.42 (16.7%) stddev-sans-first:22.56 17:49:13 INFO - PROCESS | 3192 | Values: 151.0 110.0 134.0 164.0 107.0 134.0 134.0 107.0 160.0 107.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.63 (0.9%) stddev-sans-first:1.73 17:49:13 INFO - PROCESS | 3192 | Values: 184.0 187.0 186.0 184.0 183.0 183.0 182.0 182.0 184.0 185.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#3] audio-fft Cycles:10 Average:90.20 Median:58.00 stddev:44.46 (76.7%) stddev-sans-first:46.90 17:49:13 INFO - PROCESS | 3192 | Values: 77.0 87.0 109.0 186.0 58.0 58.0 57.0 65.0 147.0 58.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:70.50 stddev:26.47 (37.5%) stddev-sans-first:27.92 17:49:13 INFO - PROCESS | 3192 | Values: 83.0 83.0 138.0 70.0 71.0 77.0 123.0 70.0 70.0 123.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:1.58 (1.8%) stddev-sans-first:1.67 17:49:13 INFO - PROCESS | 3192 | Values: 87.0 86.0 88.0 86.0 88.0 84.0 89.0 85.0 87.0 85.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:49:13 INFO - PROCESS | 3192 | Values: 96.0 97.0 97.0 97.0 97.0 98.0 97.0 97.0 96.0 98.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 17:49:13 INFO - PROCESS | 3192 | Values: 85.0 85.0 84.0 84.0 83.0 81.0 83.0 85.0 84.0 84.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 17:49:13 INFO - PROCESS | 3192 | Values: 54.0 54.0 54.0 54.0 53.0 53.0 55.0 54.0 54.0 54.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:72.00 stddev:4.67 (6.5%) stddev-sans-first:4.07 17:49:13 INFO - PROCESS | 3192 | Values: 63.0 66.0 65.0 76.0 71.0 77.0 72.0 74.0 70.0 72.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:86.00 stddev:8.22 (9.6%) stddev-sans-first:8.55 17:49:13 INFO - PROCESS | 3192 | Values: 84.0 86.0 86.0 86.0 82.0 84.0 87.0 85.0 97.0 109.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:147.00 stddev:12.88 (8.8%) stddev-sans-first:13.43 17:49:13 INFO - PROCESS | 3192 | Values: 140.0 140.0 140.0 151.0 149.0 135.0 138.0 145.0 180.0 150.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:1.65 (1.0%) stddev-sans-first:1.73 17:49:13 INFO - PROCESS | 3192 | Values: 169.0 169.0 172.0 172.0 170.0 169.0 167.0 168.0 169.0 171.0 17:49:13 INFO - PROCESS | 3192 | 17:49:13 INFO - PROCESS | 3192 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 17:49:13 INFO - PROCESS | 3192 | Values: 67.0 67.0 68.0 68.0 67.0 67.0 68.0 66.0 66.0 66.0 17:49:13 INFO - PROCESS | 3192 | -------- Summary: end -------- 17:49:13 INFO - PROCESS | 3192 | 17:49:14 INFO - TEST-INFO | 3192: exit 0 17:49:14 INFO - TEST-OK | kraken | took 59222ms 17:49:14 INFO - SUITE-END | took 1176s 17:49:15 INFO - Completed test suite (00:19:37) 17:49:15 INFO - javascript benchmark 17:49:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.767476276661, 3323.0363194673546, 3334.733221342293, 3368.258983023734, 3389.6610338966107, 5619.466150715686, 5672.035753921833, 5717.514011309038, 5733.369329373765, 5737.909797138546, 4603.309503574474, 5710.5717071219615, 5788.797392091277, 5808.59339846211, 5860.794872179475, 5115.53960143587, 5138.2806407103035, 5209.557187639036, 5219.634625576211, 5287.550558202557, 5315.229291752694, 5321.707306098163, 5329.0, 5337.439568845273, 5353.491418315254, 5150.536451719363, 5207.739613019372, 5212.791488340462, 5227.7908883644795, 5251.396089449724, 5216.061109000379, 5218.843434696965, 5244.632875698702, 5244.632875698702, 5246.160614301732, 5135.204043373283, 5154.871128221787, 5164.664296820694, 5179.792808287664, 5196.844094677166, 5639.971800140973, 5661.886762264731, 5709.600327977043, 5738.196652468658, 5773.422657734235, 4746.881327966794, 6224.844378890564, 6248.31268560458, 6252.843678908018, 6274.215723034621, 5907.320658124285, 6194.163787888668, 6211.751529938797, 6245.7501699931945, 6277.811665650038, 5809.50619197373, 5822.272215973004, 5827.184194212814, 5829.271341082364, 5831.504322132581, 4779.224412713987, 5060.797568097309, 5897.967855625248, 6330.240371155491, 6331.873362532723, 6022.0, 6115.327313995457, 6129.111278864629, 6139.062858969336, 6190.226221722285, 6274.152989346379, 6282.089097080898, 6288.968555157195, 6291.811245662638, 6301.590396624205, 6164.106204600397, 6171.7531298748445, 6226.688665566703, 6230.190075290274, 6237.438630523275, 6121.418465245794, 6154.78458253959, 6154.861350650144, 6234.906476402857, 6236.18929539166, 4920.40955085392, 4951.455339912607, 4965.0566392385335, 4971.90056198874, 4996.250562415594, 3740.887773366749, 4430.401895744098, 4447.599716025573, 4462.665300102505, 4477.686561940633, 5600.4959553640365, 5626.240457538262, 5694.97152514243, 5754.165645981309, 5778.508826749773, 6240.188775459252, 6255.718492667841, 6270.3416141305415, 6276.435120839146, 6308.495320374359, 5715.533802264544, 5740.138979153077, 5760.164776107441, 5769.85575360611, 5795.971020144957, 5334.973325133349, 5398.028354896078, 5444.373897001817, 5447.373552041487, 5474.315710536183, 6238.937610623836, 6263.248410190807, 6298.622082675054, 6301.212348456443, 6315.147455093504, 6203.565750397609, 6221.0, 6255.311915689362, 6299.748010079546, 6323.399277068671, 6334.208223972004, 6344.524160687874, 6362.204724409449, 6380.170577824853, 6387.073874288295, 6077.726502307319, 6211.937880621317, 6226.782062627786, 6231.781887633911, 6241.96879015602, 6159.6612186330185, 6225.937740622717, 6236.968815155895, 6241.282252541016, 6243.531735119975, 6080.543959202989, 6104.3075792339105, 6105.682175298917, 6140.4473597376455, 6171.352008039091, 4815.253635686474, 5439.401665816677, 6077.453029227214, 6079.05774604937, 6102.054181601681, 5775.931452681268, 5945.613535120204, 5952.97023514897, 5954.166416701752, 5967.731452084753, 5946.643201407929, 6031.728572214173, 6079.483243924316, 6099.329073801967, 6124.350421260821, 5946.732397042057, 5956.523478121827, 5977.342492325927, 5980.760769569169, 6018.638881667114], "value": 5666.9992412653655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.5922830609991, 476.8712447639135, 507.9085764562377, 519.4104691175517, 530.1914580265095, 30677.38645227094, 40137.799311003444, 41379.0, 41431.71365726852, 41552.58447415525, 42439.575604243946, 42737.572624273824, 42757.78621106898, 42924.0, 43046.13907721844, 9729.173020293283, 9935.205183585333, 9938.204943604494, 9938.403695778241, 9951.452670103141, 8811.64753409866, 9013.369064165478, 11897.7620447591, 12203.877961220363, 12212.69468263296, 12145.878541214563, 12231.633051008439, 12249.387530623479, 12257.019438444948, 12286.93856530716, 8879.245264152554, 12153.0277577794, 12219.205751626116, 12237.632871013884, 12246.93876530616, 8788.604512796875, 8976.012638609747, 8982.28141748665, 11700.941495292554, 12015.0, 40726.0, 41207.79396103, 41250.76247712573, 41301.79349103265, 41485.79257103725, 3318.900432987014, 3406.2506248625264, 3521.8591256349714, 3880.9029774255587, 3881.1849511602595, 29669.0, 31111.75552977878, 31299.84350078235, 31923.201919951956, 31940.20149496258, 3224.742020638343, 3261.951070733941, 3280.343931213743, 3280.3767284215924, 3362.1930736623035, 412188.0, 463431.0, 464029.23736863845, 464775.0, 466183.338166614, 47998.5200148001, 57822.7108864453, 58230.12654810181, 58239.417605824245, 58366.8326633465, 61927.6903615479, 62017.68991155105, 62086.689566551875, 62090.0, 62206.68896655488, 16101.677966440606, 16345.346186152421, 16348.509544713677, 16374.83625163757, 16380.508584742476, 11383.601573944872, 11610.70973225676, 12627.873721262853, 12633.87366126327, 12664.620061398173, 16084.678306433805, 16214.270357833926, 16371.345146194019, 16631.91892526982, 16661.91697539656, 7032.472564557678, 7056.858862822714, 7090.787276381717, 7109.1824440189, 7155.463340249502, 826.3554427546524, 925.9166674999283, 933.5332333833084, 1021.6066814276409, 1059.4490864750287, 27528.0, 29522.0, 30441.84779076135, 30457.23856903595, 30496.69503304983, 985.5417230987625, 997.2869398380193, 1047.7433028907967, 1079.4386918802336, 1079.8272276435732, 14507.782383264259, 14816.62958426048, 15366.923165384102, 15398.845086618549, 15867.0, 572813.0, 573511.0, 578313.0, 580904.190958085, 583368.0, 57014.714926425106, 57171.42828571661, 57272.28183154512, 57278.42721572731, 57410.71294643584, 1224.1859163656247, 1286.4596869314723, 1364.7270545890863, 1400.250865786799, 1401.8808401286005, 27776.861115694293, 28795.136145915658, 30286.69713302927, 31066.534001989538, 31407.685923140478, 40441.59558404378, 48957.020859583325, 49453.50546494489, 49498.0, 49773.50226497689, 507819.4609026931, 514141.0, 514399.0, 516461.0, 517342.0, 25323.0, 26227.344316392242, 26263.080792172183, 26876.462470750866, 26899.86550067237, 46275.84310392267, 46723.0, 47656.5234347666, 47718.568442946766, 48326.55020349395, 38539.0, 38610.613893861824, 38865.222695545366, 40482.0, 40969.79515102405, 38216.80891595524, 38225.61774382332, 38500.0, 39778.0, 39829.80085099556, 37013.259734805695, 37620.435693465166, 38239.235215296096, 38349.424758629204, 38379.0, 32451.02646920596, 33372.499412509314, 34159.658403416644, 34289.0, 34516.309673806885, 25006.499870002863, 25076.498470030132, 25259.989600415778, 25330.89411388338, 25677.871610642575], "value": 19951.709485940144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.92104276537765, 361.6401680328073, 368.24142266930124, 382.3022983055924, 400.98997525061867, 15308.540743777676, 15641.296141673623, 20337.28819491318, 21627.3511794646, 22031.66952495714, 18098.185581648824, 20372.185112595478, 20534.281300154496, 21121.366359009255, 21173.258935937247, 5928.466438020567, 6256.061590761399, 6275.341089185638, 6275.780347687832, 6287.874242515147, 5909.11363295507, 6102.786402475915, 6114.571979961404, 6171.969140154293, 6179.81460556184, 6138.570300078974, 6143.44708976192, 6146.539009574278, 6156.630602163862, 6157.091301696466, 5593.57363872212, 5719.885602287952, 6123.326434092246, 6131.63210207389, 6139.293981192175, 5186.196139598368, 5315.7873685052555, 5321.201819727034, 5321.467853214647, 5325.227841962933, 12886.226826390446, 13605.91152707781, 13617.863821361758, 13620.863791362059, 16126.0, 2273.658951157323, 2273.8971598774747, 2399.6280576510667, 2549.235229431163, 2791.6091747155415, 8124.959375203145, 10084.647037353658, 10148.847767283496, 10415.583376664925, 10569.73575660607, 1787.7765279340083, 1838.4117082533594, 1875.6530041942285, 1903.5146037760421, 1907.3705677126516, 126653.73346266511, 131471.0, 134940.22888512217, 139918.43588820886, 151304.243478783, 18824.623507530046, 19944.800551994584, 20466.0, 21398.893005534872, 21512.031958561904, 28978.985735499155, 30170.24574385658, 32616.510752338734, 33927.83036084853, 33928.1517962048, 10313.020263074995, 10906.61826836057, 10934.781304373868, 10995.285306455055, 11129.666110016713, 7233.602151881591, 8853.955730221307, 9060.456372617664, 9075.455472671661, 9266.0, 8368.456050356708, 9317.34778565494, 9510.476923769122, 9582.760430989281, 9740.512974351253, 3032.9090127296217, 3150.5431712401573, 3649.5183275373, 3660.871869484555, 3672.4491326301268, 780.3094261578431, 823.9011318641801, 922.9340112170454, 1000.8748906386702, 1031.783325501653, 19421.611567768567, 22296.55406891853, 22313.107475701116, 22352.0, 22511.774882250967, 895.4806212396794, 898.667493027584, 966.709987003896, 972.2513664478454, 990.8860481044773, 11250.831237531444, 11395.829062564067, 11402.030827379765, 11727.706807329714, 11768.94115529417, 442879.0, 511112.0, 533358.0, 536350.3182484063, 539164.0, 133464.0, 135440.0, 136705.0, 138337.3083134578, 139563.0, 962.5524131278848, 982.7739619887323, 1023.8413045977736, 1026.2457094035879, 1026.3944272879037, 19916.348935872677, 20409.693854591897, 20616.278430254868, 20621.58756824825, 20721.0, 55706.44293557013, 56893.0, 57158.142627861445, 58794.0, 59050.0, 83470.0, 84301.0, 85107.57446212976, 85129.57435212785, 85297.72053419327, 8071.257076800064, 8092.87860682102, 8095.959520202361, 8301.045379781403, 8399.874001889855, 10093.444860532447, 12772.1059525836, 13236.801447978096, 13664.0, 13881.958853085856, 11565.132615053737, 11578.421078946187, 11874.643760687193, 11972.281663100242, 12011.0, 10964.616238431936, 11453.828192577284, 11527.365994870363, 11962.0, 12030.458629361525, 11482.425878705864, 11747.941260293645, 11790.764184716429, 11868.287902725864, 11902.523899043941, 8258.263486457678, 8262.710805121791, 8311.085780564254, 8344.123866993878, 8451.28164106058, 9625.759356015875, 11659.883401166218, 11953.521859125538, 11982.10134239918, 12006.519739210335], "value": 10416.05530469405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.289523000424, 1518.06638917066, 1545.9227038648069, 1750.3348727483553, 1901.8668693191482, 7718.691252349906, 8592.785180370494, 8845.159709827572, 8870.068642792503, 8931.955340223307, 8714.041455439896, 8775.297976161908, 8787.12128787121, 8787.736367908972, 8812.559372031388, 2337.7311609164994, 2403.843750156243, 2403.9759602404015, 2409.084547871815, 2409.2170044735444, 2333.265021518225, 2383.7735415135535, 2384.666146739458, 2388.9880550597222, 2395.2335252719135, 2355.1756885090253, 2373.6558199061124, 2385.940351491209, 2394.784469397754, 2396.065534441569, 2338.5790557699606, 2363.7163540375177, 2371.7983971362455, 2372.8694921779384, 2388.0, 2328.8020518255967, 2366.988165059181, 2367.775061369184, 2370.608849539824, 2380.6548050532574, 8575.571221438966, 8759.211670949646, 8811.867821982676, 8862.158094980967, 8868.423552469068, 5232.790688372461, 5412.4587541245955, 5414.756335964852, 5418.674879507243, 5423.349198096214, 3076.415481058592, 3597.0, 3621.8189090545366, 3689.18837855674, 3700.611435799256, 1031.4224034540607, 1054.3094273251033, 1774.902380369079, 1832.679281125811, 1889.461503471504, 11225.831612525819, 11498.712532186762, 11600.941995290053, 11727.882721172764, 11823.34971576563, 4156.771377574262, 4404.295312749945, 4498.820047198075, 4576.244919588231, 4607.976960115178, 8076.273135417723, 9140.177384035336, 9149.405288656217, 9157.77105572366, 9167.633294668138, 4458.7324760514475, 5200.271961925334, 5249.317588713443, 5258.421573626898, 5259.053370393366, 4020.6582440492884, 4379.255526560492, 4956.504349565014, 4977.004599080198, 5006.374203224597, 3683.2136413839266, 3750.887473375803, 3808.961910380861, 3844.8654297100024, 3847.2690188864026, 1138.8576427946507, 1147.2198904744687, 1152.5793085523724, 1162.3955543117531, 1163.4822503985815, 812.7114874219567, 882.5349919134206, 892.9285657147412, 916.093067862811, 939.0515579264992, 5513.173024046345, 5558.749856256478, 5902.911456328158, 5994.710549515165, 6036.124761909498, 436.3302330922019, 446.792241607654, 454.5295619034284, 455.70151550734323, 456.792159567396, 3796.6528325068193, 3832.616738326201, 3951.3480275754755, 3986.521617405872, 3989.1423343981182, 9116.8632470513, 10326.380417174994, 10917.344959302467, 10922.617708380169, 10924.672259832218, 10365.896341036643, 10861.294015888941, 10867.728306792393, 10883.67348979532, 10886.23796334249, 6704.3295670433545, 8280.337572994145, 8295.875561866576, 8299.419040667095, 8301.460405073773, 5490.588205884655, 5616.915746263891, 5787.971060144672, 5912.46787789101, 5918.053111502139, 9956.850647240153, 9963.202943764336, 10003.2997690161, 10035.749106272402, 10058.8491172631, 9746.26902982265, 10060.69817905464, 10098.596056157672, 10138.898611013796, 10338.741531461474, 6454.903176452263, 6684.331566843277, 6805.93194068053, 6860.348266914635, 6920.515563910478, 8381.413301068867, 8528.74413767588, 8536.189062039097, 8545.529995850287, 8546.444481108709, 7349.485536012642, 7469.514481558898, 7526.698932042876, 7695.730649427243, 7729.497582657109, 7253.310935461122, 7360.411167106511, 7379.778606641809, 7383.963080184565, 7607.581583012766, 6794.524383293122, 6948.305169483214, 6959.234484206834, 6964.0, 6966.5471744336455, 4874.073925954199, 5080.0, 5093.770780314969, 5167.741612919263, 5196.454372291007, 4909.165441874961, 5158.690478571298, 5171.250843138694, 5215.191645294985, 5376.596755243294], "value": 4491.945760900574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.87363433723505, 298.09082298988085, 307.5770815129198, 308.5341134886321, 309.7351764241572, 4699.671023028381, 4967.354243948282, 5237.84286471406, 5242.397124330703, 5327.72134687675, 3898.3567711327596, 4433.778311084441, 4980.501949805027, 5163.218689552098, 5174.689518628885, 3985.6612187964056, 4002.0990029735935, 4017.0760725033115, 4017.292650623488, 4020.7386519876113, 3767.227718317752, 4010.498687664042, 4019.799010049486, 4030.476038115041, 4036.1725846201457, 3916.295066887959, 3987.4018897165365, 3998.6001399860074, 3999.9200015999663, 4006.3589825627905, 3387.61042480113, 3944.921101577981, 3993.820278087493, 3994.62051105146, 4013.578574249691, 3415.641357657435, 3427.1946092668204, 3443.276911848515, 3456.2914602506426, 3469.2887957968555, 4458.665600080007, 4562.726236425825, 4734.55021772931, 5015.949840501585, 5167.0, 4502.279635258343, 4502.909941801146, 4510.1656193604285, 4514.503404625489, 4532.27483602622, 5487.725613719298, 5514.889702205934, 5537.612367134302, 5544.77820887164, 5599.600099975006, 3184.9681503185134, 3718.758280711745, 3736.40217565191, 3742.850285988557, 3770.9057273568105, 4624.439181830039, 5701.600887937804, 5804.651720896717, 5895.4399332063385, 5899.73451194693, 3830.961690383116, 3852.57621661617, 3865.2849222893856, 3868.1876805871084, 3881.165549406891, 3607.3867442534834, 3837.2517359114704, 3845.307844587945, 3887.280853042196, 3924.4309575111447, 3952.3676211805973, 4067.9593204067583, 4455.309427038814, 4481.439820022497, 4560.726356418625, 5032.72320022395, 5214.817481388133, 5498.45015498455, 5530.0, 5593.105103183552, 1244.023441598359, 1265.9619112327987, 1274.5029438518984, 1279.6672865055152, 1283.6906355517506, 771.5833449937084, 793.738066438074, 798.7843282313859, 811.1685522339532, 835.4319063037193, 3703.148275896559, 3713.721470889694, 3971.3050216212046, 4314.223439780807, 4321.913561728811, 3907.628775266345, 4683.587952204617, 4697.459792123881, 4731.929021064687, 4787.928181077286, 3559.7864128152396, 3935.4490371348033, 4266.658667306608, 4274.636655884285, 4317.892052698708, 2340.742518322983, 2371.8221133415063, 2447.706275246982, 2456.5679976823176, 2457.6482934386017, 3900.7464514806447, 4083.754974701468, 4780.330753694486, 4826.855194344175, 4927.501473953462, 3664.486971823947, 3923.6664883485223, 4075.206908960048, 4478.507364189936, 4699.295105734167, 4350.760708161081, 4720.929186062281, 4722.899268789699, 4886.0, 4889.242167463977, 4387.758673273001, 4407.713498622579, 4561.954380456285, 4627.177421772649, 4682.836100736458, 3588.3391033491766, 3921.7645941812893, 4003.8398464062275, 4021.5777343379696, 4636.406784741852, 4163.75017498951, 4421.270490369053, 4618.907621847611, 4818.494058123987, 4880.975595122001, 3209.1759251858216, 3217.6299725531862, 3231.8060916345094, 3235.320582677664, 3238.757093218065, 3879.7866117362687, 4556.794944227451, 4568.88577785558, 4609.308603709336, 4614.630829533562, 3424.229548351601, 3684.834182461742, 4072.6538244249573, 4476.462824461086, 4485.416895803524, 3793.520526994419, 4000.2999475092324, 4142.337226043818, 4150.900011496896, 4166.2919102582355, 3890.024131539431, 4442.844500442469, 4818.518148185293, 5050.878630975073, 5086.304258742724, 5463.153211252104, 5525.171224316385, 5541.3904470507405, 5559.777608895599, 5586.497215250647, 4163.562825903236, 4613.838515652071, 4735.668503204881, 5079.72061536619, 5431.646942948696], "value": 3664.4565656887394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.7057406463348, 763.6449051191197, 766.1113108793796, 766.5975362934461, 791.7980914866708, 15360.308786104624, 16215.027098374076, 16292.0, 16314.918425407886, 16348.264328105233, 14615.78076328856, 14742.189179595118, 14744.483943061994, 14759.335829887681, 14766.0, 676.4689718570922, 696.0325148044197, 696.52984235641, 697.7069630755095, 846.3018010141627, 676.3169199108886, 840.3949156607264, 864.7881269089082, 870.212457725756, 873.5675840458981, 899.2176806178634, 905.8052518708477, 910.512875611548, 912.3248795891026, 912.7672443526891, 902.6975963052419, 903.5391950105494, 904.0507467159522, 905.112989270512, 905.4069584422214, 526.1029943945601, 544.8801263721975, 669.9816279255552, 670.1723371636026, 673.0005941177347, 12371.381430928417, 12420.316882571455, 14337.928310358486, 14934.954553181282, 14939.028963117471, 14330.92834535831, 14848.466793771833, 14870.330835112338, 14939.253037348199, 15007.0, 11479.770404591945, 11717.765644687059, 11745.11911606633, 11780.941095294555, 12207.389630518439, 3778.622137786227, 3804.809759512041, 3844.9807750961345, 3953.367461206222, 3957.08986933007, 110325.44837275843, 111890.44054779674, 112260.0, 112301.0, 113021.0, 10062.19502439803, 10752.301100428447, 10871.619493317696, 10917.781644367069, 11366.374849383197, 21496.89251553732, 21599.67600485994, 21660.675089873665, 21775.346739597837, 21789.0, 7825.569593672289, 7849.450538462367, 7897.644605992744, 7915.525068495794, 8066.475679080841, 4329.307310830252, 4444.933326000048, 4522.321651752263, 4538.954610453853, 4564.3838081859185, 3619.8552057917914, 3761.6990640748672, 3764.962350376516, 3765.0963768695315, 3766.9058273542832, 549.8075673514238, 666.3935818405228, 678.0270312102149, 679.6058286193995, 682.8702546516146, 607.4654304212353, 641.4002907281613, 643.4787821864305, 659.8977158540434, 666.2737615998585, 9458.0, 9491.715248542554, 9637.71086867395, 9642.903570964201, 9660.420374777535, 642.7043559962469, 643.6717274190197, 662.1392190152782, 666.213867636194, 688.944884409246, 4409.125611001512, 4540.273556230987, 4573.931391029138, 4663.790129444184, 4735.715857048519, 155632.0, 156747.0, 158747.0, 164126.0, 167657.3234267666, 137537.36640572525, 137576.0, 144388.0, 144926.27536862248, 145881.0, 103578.48210758898, 119907.80092199141, 123013.0, 123309.38345308216, 124184.0, 9404.717858464257, 9837.950810245902, 9860.704178874645, 9969.35199212049, 10026.398416094766, 47601.0, 62586.68706656437, 63748.40628984127, 65177.0, 67168.3283167162, 88519.55740221258, 91031.0896891049, 92527.0, 93079.0, 97830.53254201334, 11278.661640150809, 13495.25776082325, 13560.38978246001, 13606.115602485806, 13738.793918091436, 14850.925745371203, 15015.32431040584, 15132.773008404663, 15489.14809685478, 15704.371825126867, 13711.588652340446, 13882.305884705522, 14106.506272280421, 14116.0, 14142.858571414154, 13729.794053089412, 13888.861111388756, 13985.160890346611, 14081.225532595805, 14467.565973020826, 12627.494900203888, 12829.550965716155, 13447.193168409927, 13872.791908121588, 14172.433102675777, 8480.83038339242, 10853.475107596376, 11365.886341136484, 11483.885161148282, 11735.295882247092, 10963.71555855423, 11389.330793283378, 11394.772104558027, 11525.769484610093, 11605.187636865337], "value": 7904.544006871141, "unit": "score"}], "name": "dromaeo_css", "value": 7315.3522682701105, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 115.0, 113.0, 114.0, 114.0, 113.0, 113.0, 122.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 110.0, 134.0, 164.0, 107.0, 134.0, 134.0, 107.0, 160.0, 107.0], "value": 130.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 186.0, 184.0, 183.0, 183.0, 182.0, 182.0, 184.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 109.0, 186.0, 58.0, 58.0, 57.0, 65.0, 147.0, 58.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 138.0, 70.0, 71.0, 77.0, 123.0, 70.0, 70.0, 123.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 86.0, 88.0, 84.0, 89.0, 85.0, 87.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 97.0, 98.0, 97.0, 97.0, 96.0, 98.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 83.0, 81.0, 83.0, 85.0, 84.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 76.0, 71.0, 77.0, 72.0, 74.0, 70.0, 72.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 86.0, 82.0, 84.0, 87.0, 85.0, 97.0, 109.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 140.0, 151.0, 149.0, 135.0, 138.0, 145.0, 180.0, 150.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 172.0, 172.0, 170.0, 169.0, 167.0, 168.0, 169.0, 171.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 66.0, 66.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1474.5999999999997, "alertThreshold": 2.0}]} 17:49:15 INFO - Return code: 0 17:49:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:49:15 INFO - # TBPL SUCCESS # 17:49:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:49:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:49:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:49:15 INFO - 2016-09-08 17:49:15.286 screenresolution[3196:96040] starting screenresolution argv=screenresolution get 17:49:15 INFO - 2016-09-08 17:49:15.289 screenresolution[3196:96040] Display 0: 1600x1200x32@60 17:49:15 INFO - 2016-09-08 17:49:15.295 screenresolution[3197:96043] starting screenresolution argv=screenresolution list 17:49:15 INFO - Available Modes on Display 0 17:49:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:49:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:49:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:49:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:49:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:49:15 INFO - Intel Iris: 17:49:15 INFO - Chipset Model: Intel Iris 17:49:15 INFO - Type: GPU 17:49:15 INFO - Bus: Built-In 17:49:15 INFO - VRAM (Dynamic, Max): 1536 MB 17:49:15 INFO - Vendor: Intel (0x8086) 17:49:15 INFO - Device ID: 0x0a2e 17:49:15 INFO - Revision ID: 0x0009 17:49:15 INFO - Displays: 17:49:15 INFO - Display: 17:49:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:49:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:49:15 INFO - Display Serial Number: 1600x1200 60 17:49:15 INFO - Main Display: Yes 17:49:15 INFO - Mirror: Off 17:49:15 INFO - Online: Yes 17:49:15 INFO - Rotation: Supported 17:49:15 INFO - Return code: 0 17:49:15 INFO - Running post-action listener: _resource_record_post_action 17:49:15 INFO - [mozharness: 2016-09-09 00:49:15.529571Z] Finished run-tests step (success) 17:49:15 INFO - Running post-run listener: _resource_record_post_run 17:49:15 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 0; Write bytes: 706399744; Read time: 0; Write time: 1989 17:49:15 INFO - TinderboxPrint: CPU usage
53.6% 17:49:15 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:49:15 INFO - TinderboxPrint: I/O write bytes / time
706,399,744 / 1,989 17:49:15 INFO - TinderboxPrint: CPU idle
2,249.9 (46.4%) 17:49:15 INFO - TinderboxPrint: CPU system
966.4 (19.9%) 17:49:15 INFO - TinderboxPrint: CPU user
1,633.4 (33.7%) 17:49:15 INFO - TinderboxPrint: Swap in / out
405,102,592 / 0 17:49:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396167680; Write bytes: 390866944; Read time: 29619; Write time: 830 17:49:15 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 0; Write bytes: 295818752; Read time: 0; Write time: 1107 17:49:16 INFO - Running post-run listener: _upload_blobber_files 17:49:16 INFO - Blob upload gear active. 17:49:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:49:16 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 17:49:16 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'] 17:49:16 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 17:49:16 INFO - (blobuploader) - INFO - Open directory for files ... 17:49:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:49:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:49:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:17 INFO - (blobuploader) - INFO - Done attempting. 17:49:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:49:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:49:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:18 INFO - (blobuploader) - INFO - Done attempting. 17:49:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:49:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:49:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:20 INFO - (blobuploader) - INFO - Done attempting. 17:49:20 INFO - (blobuploader) - INFO - Iteration through files over. 17:49:20 INFO - Return code: 0 17:49:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:49:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:49:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f9645cdb6ad1a2f3fa6dd235f03d4b38ba94b876e813c72b8950dcb6ec14837e689452802023b023b8ee001fda845ea810005a641ac8c6b297d47fefa7d23ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/131b444fc6ebe75fe3d4031be42c05760fc940e858d00b8753619c14a834108c370d1cea3606fc3a70435f128747762dcf0440af452cce8d61c5a817e2ec7a22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d803c4e0c2534285c3bcf8bc81350d03ad5caa47d4eace63e4b613ba014a7b7e33cafc3de7b975cb36d79a06ad6450017f30e9f3c060dee48f2d52731877266"} 17:49:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:49:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:49:20 INFO - Contents: 17:49:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f9645cdb6ad1a2f3fa6dd235f03d4b38ba94b876e813c72b8950dcb6ec14837e689452802023b023b8ee001fda845ea810005a641ac8c6b297d47fefa7d23ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/131b444fc6ebe75fe3d4031be42c05760fc940e858d00b8753619c14a834108c370d1cea3606fc3a70435f128747762dcf0440af452cce8d61c5a817e2ec7a22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d803c4e0c2534285c3bcf8bc81350d03ad5caa47d4eace63e4b613ba014a7b7e33cafc3de7b975cb36d79a06ad6450017f30e9f3c060dee48f2d52731877266"} 17:49:20 INFO - Running post-run listener: copy_logs_to_upload_dir 17:49:20 INFO - Copying logs to upload dir... 17:49:20 INFO - mkdir: /builds/slave/test/build/upload/logs 17:49:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.179283 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-08 17:49:20.950216) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 17:49:20.953723) ========= 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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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/6f9645cdb6ad1a2f3fa6dd235f03d4b38ba94b876e813c72b8950dcb6ec14837e689452802023b023b8ee001fda845ea810005a641ac8c6b297d47fefa7d23ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/131b444fc6ebe75fe3d4031be42c05760fc940e858d00b8753619c14a834108c370d1cea3606fc3a70435f128747762dcf0440af452cce8d61c5a817e2ec7a22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d803c4e0c2534285c3bcf8bc81350d03ad5caa47d4eace63e4b613ba014a7b7e33cafc3de7b975cb36d79a06ad6450017f30e9f3c060dee48f2d52731877266"} build_url:https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011636 build_url: 'https://queue.taskcluster.net/v1/task/W6G-0OJPRt2Ha_EZEF2W2A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6f9645cdb6ad1a2f3fa6dd235f03d4b38ba94b876e813c72b8950dcb6ec14837e689452802023b023b8ee001fda845ea810005a641ac8c6b297d47fefa7d23ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/131b444fc6ebe75fe3d4031be42c05760fc940e858d00b8753619c14a834108c370d1cea3606fc3a70435f128747762dcf0440af452cce8d61c5a817e2ec7a22", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9d803c4e0c2534285c3bcf8bc81350d03ad5caa47d4eace63e4b613ba014a7b7e33cafc3de7b975cb36d79a06ad6450017f30e9f3c060dee48f2d52731877266"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 17:49:20.987468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:49:20.987839) ========= 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.iXTAEx41DH/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.MQUHyVfOqJ/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005549 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 17:49:21.037334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 17:49:21.037699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 17:49:21.038041) ========= ========= Total master_lag: 0.19 =========