builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0271 starttime: 1475132708.51 results: success (0) buildid: 20160928222120 builduid: 63fcb066df8b48dfb0ed4cfd4ee5baf2 revision: 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:08.513797) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:08.514250) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:08.514530) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:08.574854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:08.575227) ========= 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.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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-29 00:05:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 190M=0s 2016-09-29 00:05:09 (190 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.516227 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:09.118986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:09.119287) ========= 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.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.029145 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:09.189872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-29 00:05:09.190238) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 --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 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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-29 00:05:09,279 truncating revision to first 12 chars 2016-09-29 00:05:09,280 Setting DEBUG logging. 2016-09-29 00:05:09,280 attempt 1/10 2016-09-29 00:05:09,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/9ec418dcac3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 00:05:10,263 unpacking tar archive at: autoland-9ec418dcac3f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264790 ========= master_lag: 2.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-09-29 00:05:12.812895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:12.813183) ========= script_repo_revision: 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:12.813602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:12.813892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 00:05:12.987662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-29 00:05:12.988149) ========= /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.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 00:05:13 INFO - MultiFileLogger online at 20160929 00:05:13 in /builds/slave/test 00:05:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:05:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:05:13 INFO - {'append_to_log': False, 00:05:13 INFO - 'base_work_dir': '/builds/slave/test', 00:05:13 INFO - 'blob_upload_branch': 'Autoland', 00:05:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:05:13 INFO - 'branch': 'Autoland', 00:05:13 INFO - 'buildbot_json_path': 'buildprops.json', 00:05:13 INFO - 'config_files': ('talos/mac_config.py',), 00:05:13 INFO - 'default_actions': ('clobber', 00:05:13 INFO - 'read-buildbot-config', 00:05:13 INFO - 'download-and-extract', 00:05:13 INFO - 'populate-webroot', 00:05:13 INFO - 'create-virtualenv', 00:05:13 INFO - 'install', 00:05:13 INFO - 'run-tests'), 00:05:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:05:13 INFO - 'download_minidump_stackwalk': True, 00:05:13 INFO - 'download_symbols': 'ondemand', 00:05:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:05:13 INFO - 'tooltool.py': '/tools/tooltool.py', 00:05:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:05:13 INFO - '/tools/misc-python/virtualenv.py')}, 00:05:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:05:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:05:13 INFO - 'installer_path': 'installer.exe', 00:05:13 INFO - 'log_level': 'info', 00:05:13 INFO - 'log_name': 'talos', 00:05:13 INFO - 'log_to_console': True, 00:05:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:05:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:05:13 INFO - 'opt_config_files': (), 00:05:13 INFO - 'pip_index': False, 00:05:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:05:13 INFO - 'cmd': ('bash', 00:05:13 INFO - '-c', 00:05:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:05:13 INFO - 'enabled': True, 00:05:13 INFO - 'halt_on_failure': False, 00:05:13 INFO - 'name': 'check_screen_resolution'},), 00:05:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:05:13 INFO - 'cmd': ('bash', 00:05:13 INFO - '-c', 00:05:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:05:13 INFO - 'enabled': True, 00:05:13 INFO - 'halt_on_failure': False, 00:05:13 INFO - 'name': 'check_screen_resolution'},), 00:05:13 INFO - 'run_cmd_checks_enabled': True, 00:05:13 INFO - 'sps_profile': False, 00:05:13 INFO - 'sps_profile_interval': 0, 00:05:13 INFO - 'suite': 'dromaeojs', 00:05:13 INFO - 'system_bits': '32', 00:05:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:05:13 INFO - 'title': 't-yosemite-r7-0271', 00:05:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:05:13 INFO - 'use_talos_json': True, 00:05:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:05:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:05:13 INFO - 'work_dir': 'build'} 00:05:13 INFO - [mozharness: 2016-09-29 07:05:13.215352Z] Running clobber step. 00:05:13 INFO - Running pre-action listener: _resource_record_pre_action 00:05:13 INFO - Running main action method: clobber 00:05:13 INFO - rmtree: /builds/slave/test/build 00:05:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:05:15 INFO - Running post-action listener: _resource_record_post_action 00:05:15 INFO - [mozharness: 2016-09-29 07:05:15.277779Z] Finished clobber step (success) 00:05:15 INFO - [mozharness: 2016-09-29 07:05:15.277915Z] Running read-buildbot-config step. 00:05:15 INFO - Running pre-action listener: _resource_record_pre_action 00:05:15 INFO - Running main action method: read_buildbot_config 00:05:15 INFO - Using buildbot properties: 00:05:15 INFO - { 00:05:15 INFO - "project": "", 00:05:15 INFO - "product": "firefox", 00:05:15 INFO - "script_repo_revision": "production", 00:05:15 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 00:05:15 INFO - "repository": "", 00:05:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 00:05:15 INFO - "buildid": "20160928222120", 00:05:15 INFO - "pgo_build": "False", 00:05:15 INFO - "basedir": "/builds/slave/test", 00:05:15 INFO - "buildnumber": 205, 00:05:15 INFO - "slavename": "t-yosemite-r7-0271", 00:05:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 00:05:15 INFO - "platform": "yosemite_r7", 00:05:15 INFO - "scheduler": "tests-autoland-macosx64-talos", 00:05:15 INFO - "branch": "autoland", 00:05:15 INFO - "repo_path": "integration/autoland", 00:05:15 INFO - "revision": "9ec418dcac3f0611f612bdad7d2fc0f0b23de043", 00:05:15 INFO - "stage_platform": "macosx64", 00:05:15 INFO - "builduid": "63fcb066df8b48dfb0ed4cfd4ee5baf2", 00:05:15 INFO - "slavebuilddir": "test" 00:05:15 INFO - } 00:05:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:05:15 INFO - Running post-action listener: _resource_record_post_action 00:05:15 INFO - [mozharness: 2016-09-29 07:05:15.281398Z] Finished read-buildbot-config step (success) 00:05:15 INFO - [mozharness: 2016-09-29 07:05:15.281535Z] Running download-and-extract step. 00:05:15 INFO - Running pre-action listener: _resource_record_pre_action 00:05:15 INFO - Running main action method: download_and_extract 00:05:15 INFO - mkdir: /builds/slave/test/build/tests 00:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:15 INFO - trying https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:05:15 INFO - Downloading https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 00:05:16 INFO - Downloaded 1199 bytes. 00:05:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:05:16 INFO - Using the following test package requirements: 00:05:16 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:05:16 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:05:16 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:05:16 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'jsshell-mac.zip'], 00:05:16 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:05:16 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:05:16 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:05:16 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:05:16 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:05:16 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:05:16 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:05:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:05:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:05:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:05:16 INFO - Fetch https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:05:17 INFO - Http code: 200 00:05:17 INFO - Content-Encoding: None 00:05:17 INFO - Content-Type: application/zip 00:05:17 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 00:05:17 INFO - x-amz-cf-id: MabXvISTdJDJX_tanvkzUC__9P8eSI4EbAeL_fwHhQxFteqbGffRZw== 00:05:17 INFO - x-amz-version-id: 1b9uhj2HH0RdiuEvnscG_mp3eLrO.RAk 00:05:17 INFO - x-cache: Hit from cloudfront 00:05:17 INFO - Expected file size: 16472770 00:05:17 INFO - Obtained file size: 16472770 00:05:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:05:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:05:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:05:24 INFO - Fetch https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:05:24 INFO - Http code: 200 00:05:24 INFO - Content-Encoding: None 00:05:24 INFO - Content-Type: application/zip 00:05:24 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 00:05:24 INFO - x-amz-cf-id: NDlAiuy_emi_yADiyEXQ9o05X7C-QBldzIKQMNtUWHS9fCCGWUZEDA== 00:05:24 INFO - x-amz-version-id: 1b9uhj2HH0RdiuEvnscG_mp3eLrO.RAk 00:05:24 INFO - x-cache: Hit from cloudfront 00:05:25 INFO - Expected file size: 16472770 00:05:25 INFO - Obtained file size: 16472770 00:05:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:05:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:05:31 INFO - Fetch https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:05:32 INFO - Http code: 200 00:05:32 INFO - Content-Encoding: None 00:05:32 INFO - Content-Type: application/zip 00:05:32 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 00:05:32 INFO - x-amz-cf-id: IXBrdbrTeEViytAci0T6ScUJLI41dZ7HNIPZHSnjWPatO816KhEtEA== 00:05:32 INFO - x-amz-version-id: WIXPAsqSizeVMgHrURo5e55dLZ.8cM.S 00:05:32 INFO - x-cache: Hit from cloudfront 00:05:32 INFO - Expected file size: 14414067 00:05:32 INFO - Obtained file size: 14414067 00:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:32 INFO - trying https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 00:05:36 INFO - Downloaded 111797880 bytes. 00:05:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:05:36 INFO - mkdir: /builds/slave/test/properties 00:05:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:05:36 INFO - Writing to file /builds/slave/test/properties/build_url 00:05:36 INFO - Contents: 00:05:36 INFO - build_url:https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:05:37 INFO - Running post-action listener: _resource_record_post_action 00:05:37 INFO - Running post-action listener: set_extra_try_arguments 00:05:37 INFO - [mozharness: 2016-09-29 07:05:37.620518Z] Finished download-and-extract step (success) 00:05:37 INFO - [mozharness: 2016-09-29 07:05:37.620676Z] Running populate-webroot step. 00:05:37 INFO - Running pre-action listener: _resource_record_pre_action 00:05:37 INFO - Running main action method: populate_webroot 00:05:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:05:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:05:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:05:37 INFO - '--tppagecycles', 00:05:37 INFO - '7'], 00:05:37 INFO - 'tests': ['tsvgm']}}, 00:05:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:05:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:05:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:05:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:05:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['damp', 'tps']}, 00:05:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'tests': ['damp', 'tps']}, 00:05:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['dromaeo_dom']}, 00:05:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:05:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['basic_compositor_video']}, 00:05:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:05:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'other-e10s': {'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['a11yr', 00:05:37 INFO - 'ts_paint', 00:05:37 INFO - 'tpaint', 00:05:37 INFO - 'sessionrestore', 00:05:37 INFO - 'sessionrestore_no_auto_restore', 00:05:37 INFO - 'tabpaint']}, 00:05:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['tsvgx', 00:05:37 INFO - 'tsvgr_opacity', 00:05:37 INFO - 'tart', 00:05:37 INFO - 'tscrollx', 00:05:37 INFO - 'cart']}, 00:05:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:05:37 INFO - 'tsvgr_opacity', 00:05:37 INFO - 'tart', 00:05:37 INFO - 'tscrollx', 00:05:37 INFO - 'cart']}, 00:05:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'talos_options': ['--disable-e10s'], 00:05:37 INFO - 'tests': ['tp5o']}, 00:05:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'tests': ['tp5o']}, 00:05:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'talos_options': ['--disable-e10s', 00:05:37 INFO - '--xperf_path', 00:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:37 INFO - 'tests': ['tp5n']}, 00:05:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:37 INFO - 'talos_options': ['--xperf_path', 00:05:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:37 INFO - 'tests': ['tp5n']}}, 00:05:37 INFO - 'talos.zip': {'path': '', 00:05:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:05:37 INFO - Running post-action listener: _resource_record_post_action 00:05:37 INFO - [mozharness: 2016-09-29 07:05:37.639656Z] Finished populate-webroot step (success) 00:05:37 INFO - [mozharness: 2016-09-29 07:05:37.639764Z] Running create-virtualenv step. 00:05:37 INFO - Running pre-action listener: _resource_record_pre_action 00:05:37 INFO - Running main action method: create_virtualenv 00:05:37 INFO - Creating virtualenv /builds/slave/test/build/venv 00:05:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:05:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:05:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:05:37 INFO - Using real prefix '/tools/python27' 00:05:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:05:38 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:41 INFO - Installing pip.................done. 00:05:41 INFO - Return code: 0 00:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:05:41 INFO - Reading from file tmpfile_stdout 00:05:41 INFO - Output received: 00:05:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:05:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:41 INFO - 'HOME': '/Users/cltbld', 00:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:41 INFO - 'LOGNAME': 'cltbld', 00:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:41 INFO - 'MOZ_NO_REMOTE': '1', 00:05:41 INFO - 'NO_EM_RESTART': '1', 00:05:41 INFO - 'PAGER': '/bin/cat', 00:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:41 INFO - 'PWD': '/builds/slave/test', 00:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:41 INFO - 'SHELL': '/bin/bash', 00:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:41 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:41 INFO - 'USER': 'cltbld', 00:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:41 INFO - 'XPC_FLAGS': '0x0', 00:05:41 INFO - 'XPC_SERVICE_NAME': '0', 00:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:05:41 INFO - Cleaning up... 00:05:41 INFO - Return code: 0 00:05:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:41 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:41 INFO - 'HOME': '/Users/cltbld', 00:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:41 INFO - 'LOGNAME': 'cltbld', 00:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:41 INFO - 'MOZ_NO_REMOTE': '1', 00:05:41 INFO - 'NO_EM_RESTART': '1', 00:05:41 INFO - 'PAGER': '/bin/cat', 00:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:41 INFO - 'PWD': '/builds/slave/test', 00:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:41 INFO - 'SHELL': '/bin/bash', 00:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:41 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:41 INFO - 'USER': 'cltbld', 00:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:41 INFO - 'XPC_FLAGS': '0x0', 00:05:41 INFO - 'XPC_SERVICE_NAME': '0', 00:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:42 INFO - Downloading/unpacking psutil>=3.1.1 00:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:45 INFO - Installing collected packages: psutil 00:05:45 INFO - Running setup.py install for psutil 00:05:45 INFO - building 'psutil._psutil_osx' extension 00:05:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:05:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:05:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:05:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 00:05:46 INFO - building 'psutil._psutil_posix' extension 00:05:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 00:05:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:05:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:05:46 INFO - ^ 00:05:46 INFO - 1 warning generated. 00:05:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 00:05:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:47 INFO - Successfully installed psutil 00:05:47 INFO - Cleaning up... 00:05:47 INFO - Return code: 0 00:05:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:05: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 mozsystemmonitor==0.3 00:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:47 INFO - 'HOME': '/Users/cltbld', 00:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:47 INFO - 'LOGNAME': 'cltbld', 00:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:47 INFO - 'MOZ_NO_REMOTE': '1', 00:05:47 INFO - 'NO_EM_RESTART': '1', 00:05:47 INFO - 'PAGER': '/bin/cat', 00:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:47 INFO - 'PWD': '/builds/slave/test', 00:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:47 INFO - 'SHELL': '/bin/bash', 00:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:47 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:47 INFO - 'USER': 'cltbld', 00:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:47 INFO - 'XPC_FLAGS': '0x0', 00:05:47 INFO - 'XPC_SERVICE_NAME': '0', 00:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:05:49 INFO - Installing collected packages: mozsystemmonitor 00:05:49 INFO - Running setup.py install for mozsystemmonitor 00:05:50 INFO - Successfully installed mozsystemmonitor 00:05:50 INFO - Cleaning up... 00:05:50 INFO - Return code: 0 00:05:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:50 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:50 INFO - 'HOME': '/Users/cltbld', 00:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:50 INFO - 'LOGNAME': 'cltbld', 00:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:50 INFO - 'MOZ_NO_REMOTE': '1', 00:05:50 INFO - 'NO_EM_RESTART': '1', 00:05:50 INFO - 'PAGER': '/bin/cat', 00:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:50 INFO - 'PWD': '/builds/slave/test', 00:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:50 INFO - 'SHELL': '/bin/bash', 00:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:50 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:50 INFO - 'USER': 'cltbld', 00:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:50 INFO - 'XPC_FLAGS': '0x0', 00:05:50 INFO - 'XPC_SERVICE_NAME': '0', 00:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:50 INFO - Downloading/unpacking jsonschema==2.5.1 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:05:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:53 INFO - Downloading functools32-3.2.3-2.tar.gz 00:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:05:53 INFO - warning: no files found matching '*.txt' 00:05:53 INFO - no previously-included directories found matching 'build' 00:05:53 INFO - no previously-included directories found matching 'dist' 00:05:53 INFO - no previously-included directories found matching '.git*' 00:05:53 INFO - Installing collected packages: jsonschema, functools32 00:05:53 INFO - Running setup.py install for functools32 00:05:53 INFO - warning: no files found matching '*.txt' 00:05:53 INFO - no previously-included directories found matching 'build' 00:05:53 INFO - no previously-included directories found matching 'dist' 00:05:53 INFO - no previously-included directories found matching '.git*' 00:05:53 INFO - Successfully installed jsonschema functools32 00:05:53 INFO - Cleaning up... 00:05:53 INFO - Return code: 0 00:05:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:53 INFO - 'HOME': '/Users/cltbld', 00:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:53 INFO - 'LOGNAME': 'cltbld', 00:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:53 INFO - 'MOZ_NO_REMOTE': '1', 00:05:53 INFO - 'NO_EM_RESTART': '1', 00:05:53 INFO - 'PAGER': '/bin/cat', 00:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:53 INFO - 'PWD': '/builds/slave/test', 00:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:53 INFO - 'SHELL': '/bin/bash', 00:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:53 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:53 INFO - 'USER': 'cltbld', 00:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:53 INFO - 'XPC_FLAGS': '0x0', 00:05:53 INFO - 'XPC_SERVICE_NAME': '0', 00:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:05:53 INFO - Cleaning up... 00:05:53 INFO - Return code: 0 00:05:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:53 INFO - 'HOME': '/Users/cltbld', 00:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:53 INFO - 'LOGNAME': 'cltbld', 00:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:53 INFO - 'MOZ_NO_REMOTE': '1', 00:05:53 INFO - 'NO_EM_RESTART': '1', 00:05:53 INFO - 'PAGER': '/bin/cat', 00:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:53 INFO - 'PWD': '/builds/slave/test', 00:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:53 INFO - 'SHELL': '/bin/bash', 00:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:53 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:53 INFO - 'USER': 'cltbld', 00:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:53 INFO - 'XPC_FLAGS': '0x0', 00:05:53 INFO - 'XPC_SERVICE_NAME': '0', 00:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:54 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:56 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:57 INFO - Downloading docopt-0.6.1.tar.gz 00:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:57 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:57 INFO - Running setup.py install for blobuploader 00:05:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:58 INFO - Running setup.py install for requests 00:05:58 INFO - Running setup.py install for docopt 00:05:58 INFO - Successfully installed blobuploader requests docopt 00:05:58 INFO - Cleaning up... 00:05:58 INFO - Return code: 0 00:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:58 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:58 INFO - 'HOME': '/Users/cltbld', 00:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:58 INFO - 'LOGNAME': 'cltbld', 00:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:58 INFO - 'MOZ_NO_REMOTE': '1', 00:05:58 INFO - 'NO_EM_RESTART': '1', 00:05:58 INFO - 'PAGER': '/bin/cat', 00:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:58 INFO - 'PWD': '/builds/slave/test', 00:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:58 INFO - 'SHELL': '/bin/bash', 00:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:05:58 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:58 INFO - 'USER': 'cltbld', 00:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:58 INFO - 'XPC_FLAGS': '0x0', 00:05:58 INFO - 'XPC_SERVICE_NAME': '0', 00:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-oIQ_SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-iI8co2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-GOBmKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-tNmjQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-ZQ09gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Tr42BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-03zpTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Dh259v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:59 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-9SOoF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-_x1y2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-DrEh2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-fueEmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-lYIGSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-WINu6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-M8Hy85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-F3csXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:06:00 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-RV_6dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:06:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:06:00 INFO - Running setup.py install for manifestparser 00:06:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:06:01 INFO - Running setup.py install for mozcrash 00:06:01 INFO - Running setup.py install for mozdebug 00:06:01 INFO - Running setup.py install for mozdevice 00:06:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:06:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:06:01 INFO - Running setup.py install for mozfile 00:06:01 INFO - Running setup.py install for mozhttpd 00:06:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:06:01 INFO - Running setup.py install for mozinfo 00:06:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:06:01 INFO - Running setup.py install for mozInstall 00:06:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Running setup.py install for mozleak 00:06:02 INFO - Running setup.py install for mozlog 00:06:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Running setup.py install for moznetwork 00:06:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Running setup.py install for mozprocess 00:06:02 INFO - Running setup.py install for mozprofile 00:06:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Running setup.py install for mozrunner 00:06:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:06:02 INFO - Running setup.py install for mozscreenshot 00:06:03 INFO - Running setup.py install for moztest 00:06:03 INFO - Running setup.py install for mozversion 00:06:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:06:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:06:03 INFO - Cleaning up... 00:06:03 INFO - Return code: 0 00:06:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:03 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:06:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:06:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:06:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:06:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:03 INFO - 'HOME': '/Users/cltbld', 00:06:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:03 INFO - 'LOGNAME': 'cltbld', 00:06:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:03 INFO - 'MOZ_NO_REMOTE': '1', 00:06:03 INFO - 'NO_EM_RESTART': '1', 00:06:03 INFO - 'PAGER': '/bin/cat', 00:06:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:03 INFO - 'PWD': '/builds/slave/test', 00:06:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:03 INFO - 'SHELL': '/bin/bash', 00:06:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:06:03 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:06:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:03 INFO - 'USER': 'cltbld', 00:06:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:03 INFO - 'XPC_FLAGS': '0x0', 00:06:03 INFO - 'XPC_SERVICE_NAME': '0', 00:06:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:06:03 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-0ed4Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:06:03 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-GJtrwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:06:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:06:03 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-WTUu2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-oHii0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-nkz2zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-nPP3kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-OUjewu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-HIVlJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-BBRpYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-cRfybE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-gHxqVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-23ViOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:06:04 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-iaQA1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:06:05 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-cAx76g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:05 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-5sPpgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:06:05 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-6TYrzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:06:05 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-8zKr6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:06:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:06:07 INFO - Downloading blessings-1.6.tar.gz 00:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:06:08 INFO - Installing collected packages: blessings 00:06:08 INFO - Running setup.py install for blessings 00:06:08 INFO - Successfully installed blessings 00:06:08 INFO - Cleaning up... 00:06:08 INFO - Return code: 0 00:06:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:06:08 INFO - Reading from file tmpfile_stdout 00:06:08 INFO - Current package versions: 00:06:08 INFO - blessings == 1.6 00:06:08 INFO - blobuploader == 1.2.4 00:06:08 INFO - docopt == 0.6.1 00:06:08 INFO - functools32 == 3.2.3-2 00:06:08 INFO - jsonschema == 2.5.1 00:06:08 INFO - manifestparser == 1.1 00:06:08 INFO - mozInstall == 1.12 00:06:08 INFO - mozcrash == 0.17 00:06:08 INFO - mozdebug == 0.1 00:06:08 INFO - mozdevice == 0.48 00:06:08 INFO - mozfile == 1.2 00:06:08 INFO - mozhttpd == 0.7 00:06:08 INFO - mozinfo == 0.9 00:06:08 INFO - mozleak == 0.1 00:06:08 INFO - mozlog == 3.4 00:06:08 INFO - moznetwork == 0.27 00:06:08 INFO - mozprocess == 0.23 00:06:08 INFO - mozprofile == 0.28 00:06:08 INFO - mozrunner == 6.12 00:06:08 INFO - mozscreenshot == 0.1 00:06:08 INFO - mozsystemmonitor == 0.3 00:06:08 INFO - moztest == 0.7 00:06:08 INFO - mozversion == 1.4 00:06:08 INFO - psutil == 3.1.1 00:06:08 INFO - requests == 1.2.3 00:06:08 INFO - wsgiref == 0.1.2 00:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:08 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:08 INFO - 'HOME': '/Users/cltbld', 00:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:08 INFO - 'LOGNAME': 'cltbld', 00:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:08 INFO - 'MOZ_NO_REMOTE': '1', 00:06:08 INFO - 'NO_EM_RESTART': '1', 00:06:08 INFO - 'PAGER': '/bin/cat', 00:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:08 INFO - 'PWD': '/builds/slave/test', 00:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:08 INFO - 'SHELL': '/bin/bash', 00:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:06:08 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:08 INFO - 'USER': 'cltbld', 00:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:08 INFO - 'XPC_FLAGS': '0x0', 00:06:08 INFO - 'XPC_SERVICE_NAME': '0', 00:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:06:08 INFO - Cleaning up... 00:06:08 INFO - Return code: 0 00:06:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:06:08 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 0x1093b5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10932b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9813cb7e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, '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.EOp4zIIhYe/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.CqEhXRx89a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:08 INFO - 'HOME': '/Users/cltbld', 00:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:08 INFO - 'LOGNAME': 'cltbld', 00:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:08 INFO - 'MOZ_NO_REMOTE': '1', 00:06:08 INFO - 'NO_EM_RESTART': '1', 00:06:08 INFO - 'PAGER': '/bin/cat', 00:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:08 INFO - 'PWD': '/builds/slave/test', 00:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:08 INFO - 'SHELL': '/bin/bash', 00:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:06:08 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:08 INFO - 'USER': 'cltbld', 00:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:08 INFO - 'XPC_FLAGS': '0x0', 00:06:08 INFO - 'XPC_SERVICE_NAME': '0', 00:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:06:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:06:09 INFO - Cleaning up... 00:06:09 INFO - Return code: 0 00:06:09 INFO - Running post-action listener: _resource_record_post_action 00:06:09 INFO - Running post-action listener: _start_resource_monitoring 00:06:09 INFO - Starting resource monitoring. 00:06:09 INFO - [mozharness: 2016-09-29 07:06:09.209379Z] Finished create-virtualenv step (success) 00:06:09 INFO - [mozharness: 2016-09-29 07:06:09.210331Z] Running install step. 00:06:09 INFO - Running pre-action listener: _resource_record_pre_action 00:06:09 INFO - Running main action method: install 00:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:06:09 INFO - Reading from file tmpfile_stdout 00:06:09 INFO - Detecting whether we're running mozinstall >=1.0... 00:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:06:09 INFO - Reading from file tmpfile_stdout 00:06:09 INFO - Output received: 00:06:09 INFO - Usage: mozinstall [options] installer 00:06:09 INFO - Options: 00:06:09 INFO - -h, --help show this help message and exit 00:06:09 INFO - -d DEST, --destination=DEST 00:06:09 INFO - Directory to install application into. [default: 00:06:09 INFO - "/builds/slave/test"] 00:06:09 INFO - --app=APP Application being installed. [default: firefox] 00:06:09 INFO - mkdir: /builds/slave/test/build/application 00:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:06:44 INFO - Reading from file tmpfile_stdout 00:06:44 INFO - Output received: 00:06:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:06:44 INFO - Running post-action listener: _resource_record_post_action 00:06:44 INFO - [mozharness: 2016-09-29 07:06:44.092515Z] Finished install step (success) 00:06:44 INFO - [mozharness: 2016-09-29 07:06:44.092645Z] Running run-tests step. 00:06:44 INFO - Running pre-action listener: _resource_record_pre_action 00:06:44 INFO - Running main action method: run_tests 00:06:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:06:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:06:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:06:44 INFO - 2016-09-29 00:06:44.107 screenresolution[1650:8510] starting screenresolution argv=screenresolution get 00:06:44 INFO - 2016-09-29 00:06:44.109 screenresolution[1650:8510] Display 0: 1600x1200x32@60 00:06:44 INFO - 2016-09-29 00:06:44.115 screenresolution[1651:8512] starting screenresolution argv=screenresolution list 00:06:44 INFO - Available Modes on Display 0 00:06:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:06:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:06:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:06:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:06:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:06:44 INFO - Intel Iris: 00:06:44 INFO - Chipset Model: Intel Iris 00:06:44 INFO - Type: GPU 00:06:44 INFO - Bus: Built-In 00:06:44 INFO - VRAM (Dynamic, Max): 1536 MB 00:06:44 INFO - Vendor: Intel (0x8086) 00:06:44 INFO - Device ID: 0x0a2e 00:06:44 INFO - Revision ID: 0x0009 00:06:44 INFO - Displays: 00:06:44 INFO - Display: 00:06:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:06:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:06:44 INFO - Display Serial Number: 1600x1200 60 00:06:44 INFO - Main Display: Yes 00:06:44 INFO - Mirror: Off 00:06:44 INFO - Online: Yes 00:06:44 INFO - Rotation: Supported 00:06:44 INFO - Return code: 0 00:06:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:44 INFO - Python 2.7.3 00:06:44 INFO - Return code: 0 00:06:44 INFO - grabbing minidump binary from tooltool 00:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:06:44 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 0x1091c9d30>, '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 0x108fefdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1091c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:06:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 00:06:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:06:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:44 INFO - Return code: 0 00:06:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:06:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:06:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:44 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/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:06:44 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/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0271 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EOp4zIIhYe/Render', 00:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:44 INFO - 'HOME': '/Users/cltbld', 00:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:44 INFO - 'LOGNAME': 'cltbld', 00:06:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:44 INFO - 'MOZ_NO_REMOTE': '1', 00:06:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:44 INFO - 'NO_EM_RESTART': '1', 00:06:44 INFO - 'PAGER': '/bin/cat', 00:06:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:44 INFO - 'PWD': '/builds/slave/test', 00:06:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:44 INFO - 'SHELL': '/bin/bash', 00:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqEhXRx89a/Listeners', 00:06:44 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 00:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:44 INFO - 'USER': 'cltbld', 00:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:44 INFO - 'XPC_FLAGS': '0x0', 00:06:44 INFO - 'XPC_SERVICE_NAME': '0', 00:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:44 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/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:06:44 INFO - mozversion application_buildid: 20160928222120 00:06:44 INFO - mozversion application_changeset: 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 00:06:44 INFO - mozversion application_display_name: Nightly 00:06:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:44 INFO - mozversion application_name: Firefox 00:06:44 INFO - mozversion application_remotingname: firefox 00:06:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:06:44 INFO - mozversion application_vendor: Mozilla 00:06:44 INFO - mozversion application_version: 52.0a1 00:06:44 INFO - mozversion platform_buildid: 20160928222120 00:06:44 INFO - mozversion platform_changeset: 9ec418dcac3f0611f612bdad7d2fc0f0b23de043 00:06:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:06:44 INFO - mozversion platform_version: 52.0a1 00:06:44 INFO - using testdate: 1475132804 00:06:44 INFO - actual date: 1475132804 00:06:44 INFO - starting webserver on 'localhost:49267' 00:06:44 INFO - SUITE-START | Running 2 tests 00:06:44 INFO - TEST-START | dromaeo_css 00:06:44 INFO - operating with platform_type : mac_ 00:06:44 INFO - Initialising browser for dromaeo_css test... 00:06:44 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpBRrUfg/profile http://localhost:49267/getInfo.html) 00:06:47 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 00:06:47 INFO - PROCESS | 1661 | colorDepth:24 00:06:47 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 00:06:47 INFO - PROCESS | 1661 | __metrics 00:06:47 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:06:47 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:06:48 INFO - TEST-INFO | 1661: exit 0 00:06:48 INFO - Browser initialized. 00:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 00:06:48 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpBRrUfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:59 INFO - PROCESS | 1664 | RSS: Main: 235954176 00:06:59 INFO - PROCESS | 1664 | 00:07:51 INFO - PROCESS | 1664 | 1475132871686 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:10:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 00:10:03 INFO - PROCESS | 1664 | RSS: Main: 368922624 00:10:03 INFO - PROCESS | 1664 | 00:13:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 00:13:07 INFO - PROCESS | 1664 | RSS: Main: 375066624 00:13:07 INFO - PROCESS | 1664 | 00:16:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 00:16:10 INFO - PROCESS | 1664 | RSS: Main: 335847424 00:16:10 INFO - PROCESS | 1664 | 00:19:12 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 00:19:13 INFO - PROCESS | 1664 | RSS: Main: 343777280 00:19:13 INFO - PROCESS | 1664 | 00:22:16 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 00:22:17 INFO - PROCESS | 1664 | RSS: Main: 332312576 00:22:17 INFO - PROCESS | 1664 | 00:25:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 00:25:21 INFO - PROCESS | 1664 | RSS: Main: 449265664 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | __start_tp_report 00:25:21 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 00:25:21 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 00:25:21 INFO - PROCESS | 1664 | |i|pagename|runs| 00:25:21 INFO - PROCESS | 1664 | |0;dojo.html;3281.4585593377087;3303.4549299365603;3304.9919774468776;3341.9498707519406;3358.311546133043;5498.697571633558;5596.804111856086;5634.40838711935;5661.377248502672;5685.118806584981;5592.972035139829;5613.354464236604;5692.57305702072;5694.202811606378;5709.857253568653;5017.7491125443585;5059.797608095671;5075.593952483792;5151.974240128794;5156.994386094713;5214.06146893559;5236.450172731866;5241.371035475749;5258.948210357925;5286.762095705702;5188.169892817169;5202.03762303975;5203.9219411708855;5227.764750586214;5261.263423120766;4412.271975124101;5021.246812978046;5071.644984851062;5103.668261562986;5160.922586161173;5089.770960306795;5092.414372347191;5099.005693889693;5134.845954621367;5176.2235664650225;5580.581456390746;5585.2459917910965;5620.353659329188;5636.408177141423;5674.460926212003;6037.094435834616;6127.662978536178;6129.080637904305;6145.784897528565;6149.815505534841;6207.875842483125;6217.502599792006;6257.155284036688;6264.655443950626;6266.749330026793;5673.111731538835;5697.487226149667;5700.629459085146;5706.115552089433;5747.310322761254;6171.074338849208;6215.689215539205;6234.875302494015;6330;6344.587601805868;6052.485538729257;6086.452219300284;6113.8471538211015;6135.417135372132;6143.38566143391;6193.442590166816;6211.472024877936;6220.253569571681;6227;6230.408111229426;5961.105834124916;6028.3971602839365;6151.569390142737;6167;6180.598261113103;6108.578162056753;6121.510279177655;6165.599236049642;6221.191245138103;6233.096201050913;4870.9269360959615;4885.60915126789;4886.169351210303;4912.828051018198;4917.704937703749;4347.847825326098;4377.606015458624;4388.539203383662;4403.867883963486;4444.31113177458;5580.525655319343;5602.243697100839;5624.971875140598;5673.290838645169;5677.602567820296;6241.375862413813;6247.937520624827;6250.656213908279;6266.404691554295;6291.653959032205;5631.155326701028;5679.886402271932;5693.601447898607;5696.287964004499;5730.828075157752;4525.230710779176;5193.221016847428;5316.548093412026;5324.787008519694;5344.198370244494;6274.717637706314;6338.176037115146;6341.746330146742;6341.90487142684;6343.429091381798;6253.624782513064;6262.4990000800735;6272.18461599989;6273.15312432834;6278.4035516625845;6284.340144284967;6301.96849015752;6321.778737744157;6366.586171898812;6384.840378990562;5994.760209591567;6041.577089603686;6052.848678783065;6095.329513753395;6133.701927635063;6229.937700622936;6257.530685198537;6262.3111457738705;6266.717997690023;6276.905846412399;6032.577719559764;6067.605605635619;6098.26820781509;6101.877962440638;6105.45050945417;5736.541076713769;5866.178734977192;5906.852328691817;5967.9701601491715;6050.576459647782;5772;5790.7973220937065;5844.912326315194;5848.239728835224;5904.996150654313;6079.635361205455;6096.969515152396;6102;6125.081237814364;6125.693715314127;5812.564057695605;5865;5868.031774757288;5890.793822216202;5917.37867523921 00:25:21 INFO - PROCESS | 1664 | |1;ext.html;514.405861230279;539.2692901118985;541.8564080518663;562.4010428893229;563.5942121672394;37121.071973200684;39581.81254562361;39627.40558891619;39681.80159099204;39684.2063158737;40462.19075618486;40902.18195636085;40971.795141024326;41021;41060.384094238536;8798.824023519526;9013.459192448441;9555.092266234697;9777.46223957682;9782.021797820233;8899.466032038066;8998.145176208283;9007.099290070973;11780.7643847123;12117.818232726517;12007;12074.758504829899;12089.335086570236;12094;12099.27404355737;12032.699182520419;12117.151799374047;12122.090843186796;12123.575674851427;12145.69635759113;8658.78353041179;8894.466332020034;11650.30098194111;11724.531018759239;11844.34856082915;37835.81082094572;40202.59797402018;40213.79893100545;40261.19477610461;40280.38878444859;3295.9176020599675;3503.982480087583;3607.5670919489567;3785.9777859977653;4072.8574499892657;30234.94177703792;30558.388832223452;31343.529847052312;31804.886828960876;33138.17154571155;3223.693749093832;3233.8383080846097;3237.7571682123935;3251.0734440684528;3332.7000569948823;490501;491035;494808;495946;496045;32601;33193.17017074544;33370.666293336755;61611;62200;34826.82586587051;34852.825735871156;34887.30225395478;34891.82554087213;34927.650723492945;14227.715445691028;14355.856441435451;14358.712825743427;14365.281735913162;14370.568882933529;12135;12222.572209972608;12241;12257.203281786655;12264.32546209967;6495.902561461582;7287.6356182190675;7418.517796343221;7418.554886706815;7552.320291173711;3079.230192451887;3131.8120912745308;3169.8430073023183;3316.1709572606846;3355.5302257683456;916.7983043730369;947.1381043250609;954.7947191353892;963.5712108111964;999.2305924438142;28052.579211311848;29107.417851643273;29131.126066218047;29271.414571708447;29663;965.2181732796317;994.2145704893054;1035.9329890213094;1053.2942928238099;1055.6516349604613;14625.78061329081;15012.249387530579;15316.937410534812;15380.230988450532;15387;673934;678070;678982.6050869714;679138;682652;47312.526874730815;53320.73339633277;53668.463315367124;53718.73140634272;53801.92396152133;1260.571405722059;1340.7117469744053;1354.8238728965368;1397.3991183790865;1399.3632897031623;27914.302142445787;29789.404211915207;30187.69812301849;30326.7204802337;30401.631926562914;48439.5156048435;48881;48937.265941011625;49061;49117;430896;507280;509365;510306;851771;40082.39876401915;41126.1774764509;41126.79436602918;41242;41433;45261;45638.31542526798;45765.771171145265;46174.769126154155;46214.53785462103;37251.813740931124;37274.25451491009;37278.44082338713;38206.808965954995;38852;36980.81509592435;37139.44290835586;37266;38183.809080954416;38275.23449530938;36335.454968176025;37165.62834371622;37171.628283717895;37281.81359093187;37288.627113728515;31981.840090799396;32989.50515742314;33710.47171462199;33811.66188338085;33967.32065358728;23815.285541433786;24973.37566560778;25042.248732538053;25354.239372818844;25523.6171457432 00:25:21 INFO - PROCESS | 1664 | |2;jquery.html;321.6976042520031;368.49884157545733;374.2402922068202;387.8235402891685;400.4913759525403;19811.801881981177;20187.798122018776;20508.17967281307;21015.949202539887;21289.68065479015;18125.45933595646;19909.502262443446;20091.698624520643;20599;20712.171513139456;4824.5416685415;5811.506021988136;5890.125552415788;5930.762769489215;6084.939150608504;6007.339192688801;6045.818625441244;6061.090836374557;6071.666058366788;6073.908891366633;5734.856628584277;5913.172155898178;5970.462658360747;5983.700814959257;6008.819735407945;5814.0697488402075;5923.348431672513;5978.790742323998;5988.281406231258;6016.7292471838655;5067.670601410933;5128.871778205537;5173.508516690908;5173.689578625257;5174.353205849269;25691;25795.871020644965;25987.350316242057;26045;26128.34679133018;2207.668849672562;2256.593813113639;2364.775346342095;2396.59257926153;2504.336350867022;15103.697926041528;15579.610509737235;15827.52517424479;15946.840531594651;16346.509604711877;1745.9388921387817;1862.2457904548544;1867.5051111455475;1888.33908132154;1906.3112876583855;84537;114025;117819.41090294579;118670.21994670086;119988.99999999913;10398.792024159626;10417.427041512638;10429.582816687247;10525.631602893862;10830.566777328977;13577.456901724017;13586.1848289101;13605.931970340085;13613.795793063113;13630.1140425872;8346.332293416512;8523.829523409497;8528.143072070925;8551.1448855114;8677.262432693291;8545.31637469001;8563.058063612998;8618.439801412887;8748.47509149453;8749.912500875038;5441.972790136103;5643.294588176478;5877.5591830612875;6087.391260873877;6624;1788.499220218341;1824.744535764994;1825.6166205096813;1828.5520047588159;1887.5375532994503;901.2699713232303;928.1182876267573;931.4737173496952;945.239082538563;986.31451141456;21351.572968540542;22042.33872983813;22112.77887221107;22152.446188845086;22179.889100554396;915.0620613870702;945.8581212817995;963.1620490173453;983.2969426859829;1018.2057994764095;10853.728656783485;11052.171087168495;11820.23168494045;11851;11877.58428455;497813;577308;585297;592474;600153;114709.4264528672;115859.84140158659;117346;119162;121778;972.4894430423942;999.7350702063814;1019.6176433837311;1019.9031092046392;1022.0852337158202;14942.448552494156;19298.71051934194;19403.708944365564;19408.902955485133;19469.902650487224;52630;53070.469295308096;53692.38922832321;53905.46094539004;54147;73775;74466;74589;75404.62297688477;75601.24398755941;4882.731449770296;5422.918656220081;7757.185495522889;7917.881231781643;8262.462939908886;11187.832182517106;12759.681007974503;12913.481871035434;13322.467101316226;13870.4451821926;11497.252678575866;11575.710607234887;11749.29504229749;11819.763604728028;11882.76234475323;11233.213675042669;11337.489812958602;11364.431778411212;11726.413679315829;11787.882121178678;11594.478248479007;11745.882541174478;11861.288322700666;11959.162858599815;12040.157188996685;7800.687972481037;7884.960575197088;7892.763217103496;7981.3614910808155;8026.59867006659;10541;10730;10978.231523793258;11096.500657470271;11313.490892909675 00:25:21 INFO - PROCESS | 1664 | |3;mootools.html;1354.8238728965232;1500.8649221570056;1520.6274462756624;1731.4978656189705;1911.4170178095676;7871.7638470845895;8403.957980210098;8635.352348573859;8974.14745599167;8974.910250897488;8847.33644976626;8945.150210729986;8945.463272203673;8947.194752472276;8955.19403253707;2339.5203983183405;2369.277370402035;2369.3484291819714;2371;2372.252740386781;2322.477442575424;2353.2704861492907;2367.3134790910617;2370.075670488502;2371.1463873005705;2339.076064954342;2357.068957761683;2361.5631108244943;2375.0143690368477;2375.4655202579456;2314.618088015475;2337;2344.2615576093563;2345.566070277004;2354.1642716835618;2306.653309210171;2329.9767002329927;2340.9882950585306;2342.0865862313713;2343.297010896741;8800.471971681656;8998.910010899872;9000.369974101815;9003.819923601557;9032.096790320915;5154.38147422308;5230.92153617696;5357.517823395913;5364.91952620711;5378.623496355257;3457.3085382923264;3555.2178520725397;3559.661832125944;3630.981845090784;3635.818209089535;935.7601178438528;1027.6505987964129;1067.8238090715022;1081.3349789879167;1081.4971038467152;10955.83566246507;11207.271527350696;11610.825837612443;11778.587749428729;11991.340476273714;3884.2814079395403;4359.498657654347;4393.055493069006;4601.907961840744;4603.746793926366;9267.351285410092;9272.258219342437;9273.35086543949;9274.489903055262;9276.72169834906;5290.788368465295;5291.761870715827;5295.867603309948;5298.947010529922;5300.734963251822;4203.768792716369;4452.643788496913;4605.332226827159;4624.44506659203;4956.355673762388;3702.9444558331647;3754.793486358222;3807.143392736612;3821.2548553031893;3823.2162406707116;1144.713821544614;1148.0815347721789;1148.1962626161721;1155.5435602936793;1164.813629819242;848.1476116502876;860.2773670117132;881.5063564403954;912.9132732390545;957.2916042128775;5520.978618955426;5733.369329373765;6036.728347224385;6052.606580572248;6142.78500252498;837.3761547647042;938.2915898496591;949.7245798718294;952.7570469530364;995.1093771074848;3265.755068369882;3921.8823435296986;3939.212157568498;4085.2442298174933;4112.876613701594;9185;10580.788384232272;10911;11049.17131215162;11084.667459976214;11021.889781102247;11113.611023614296;11114.722131946766;11123.944380278208;11162.441877906072;8090.271875531231;8091.433599647969;8198.754037378889;8311.875321870057;8326.333893288522;5688.871220215073;5847.239858818326;5902.173695682522;5923.49650279731;5927.762889484545;9962.302638815214;10089.545970431202;10106.292559520763;10302;10320.741981450223;9373.765655858659;9844.704658860246;10222.693319200436;10384.117350025332;10502.894971050497;6180.258368995749;7043.788686339418;7120.359167674934;7206.603636800026;7210.423166146591;8350.290225330915;8361.331093512626;8369.079401265733;8442.66229350819;8456.492610443147;7499.625018748931;7561.243875612395;7650.885236721565;7677.539347639159;7692.615369231628;7378.446616503891;7407.444441667004;7455;7461.141968673672;7480.92519074824;7056.1179852518435;7071.36357727807;7132.1441427029085;7139.428845692436;7149.463790215651;4084.264832330209;4398.73607583546;4946.703197808143;4986.700797952134;5100.872478187926;4128.318827393447;4998.6500944933505;5084.923726144185;5206.062908676475;5287.074761916572 00:25:21 INFO - PROCESS | 1664 | |4;prototype.html;295.09406123201774;296.25935162094777;304.6185548537383;310.6753442652428;311.36792311607445;5195.298634684316;5398.568114550836;5435.755391007404;5474.589405794566;5512.862178445541;5216.322492642687;5336.6531175473565;5355.919661205085;5356.758945847437;5389.649672771267;3494.8776792812255;3971.3844354125085;3972.145988612462;4108.917821643566;4128.360104183841;3839.6544311012003;4074.286999775042;4102.917941641165;4137.069159439117;4143.357779544175;4035.6771458283265;4041.3937909313545;4048.5748996355255;4058.3100872851537;4133.3386658134705;4047.919041619151;4055.2497787909183;4067.3085575451946;4067.694922880781;4069.7965101744794;3166.730827879633;3447.827608619559;3498.195415054526;3526.2368815592204;3540.805255710935;4960.925586116211;5243.318368612094;5261.368635763694;5312.574994000471;5336.466353364672;4229.619334259901;4603.629130997539;4612.924184117127;4616.422947131608;4637.5826175644015;4445.5327293352175;5043.9912017596625;5588.944110558883;5639.8590035249445;5653.265075540154;3572.5712914450173;3699.6855267302312;3792.753471024402;3846.115393459492;3886.514185726784;6015.368386319461;6048.304444988838;6056.424639659225;6060.72726727294;6068.146726828451;3293.4401151803772;3300.4554248549202;3945.2898478273614;3948.230095131479;3953.695280557409;3815.6565909067763;3933.272344616255;3978.204359128186;3993.221321842213;3995.820188091485;4615.353850460938;4642.721436713808;4645.6980296280635;4646.697964632288;4658.277966915133;4824.34871292378;5780.248567686258;5784.681842498703;5794.841031793658;5853.843770922607;1042.5777560088177;1094.5402930769096;1175.0129890891692;1293.1077556485996;1372.6499742565782;928.9489078100769;944.390867890207;953.8330792111353;956.0535070280512;962.5957098018849;3548.3967725486727;3971.7616942983514;4320.740755554677;4401.603855652943;4461.553844615577;4067.8169482372773;4288.785560721952;4802.615790736732;4853.058776489362;4871.222003968597;3521.2429327694667;3851.0372406898277;3958.7332053742525;4150.501939767248;4458.7324760514475;2430.647556104355;2439.9878000609883;2558.5160606847985;2593.9650608787765;2594.7664710176173;4154.750714957112;4250;4283.601183337341;4307.418498502725;4983.202687569971;4247.660187185018;4765.8561945132915;4957.339291337443;4984.208843047904;4997.425810869565;4169.769917874174;4420.535843736426;4678.415153149864;4704.270838020044;4980.551750342486;4790.712557246577;4791.448983366958;4819.445763737075;4832.178529649897;4871.683340582851;4011.919761604693;4049.797510124541;4771.186948959373;4881.731504767272;4882.55872063968;3679.282539904693;4329.307310830252;4374.343848422762;4449.28811390176;4714.693544919569;3232.028462637742;3268.9346213076083;3385.053594183305;3413.0272872231294;3514.894553163409;4674.719516829001;4833.776462826998;4881.316615673737;4882.901347196852;5532.695701736443;5016.924746128738;5377.032134215879;5651.92613403452;5715.771369145187;5738.8278351649515;5680.182341650798;5712.914306285492;5730;5740.942590574208;5776.335721392094;5257.948410317876;5588.239704493071;5611.2424822650055;5634.295713035871;5667.659940403589;5284.365876094893;5734.455226753452;5756.42435756421;5760.913586296125;5773.942260577341;4681.485036645898;5474.056709868099;5589.301337332833;5632.971835140798;5693.430656934273 00:25:21 INFO - PROCESS | 1664 | |5;yui.html;675.1796567170887;723.0311382747118;736.0541703910475;745.3589912675102;751.6467260387623;14827.703445931089;15093.320800563974;15316;15508.844911550896;15675.29461174247;11805.468753906074;14173.645658858533;14267.50063747769;14295;14302.856971430283;821.080389963242;849.1932663969224;849.8045449546609;851.0680804519072;852.2968550945463;679.1680191765073;695.3706895259797;699.5907394174415;822.8889099971517;846.3948276981956;900.1268769293774;901.4140808474511;902.634433054614;903.8463461211577;903.941243819153;895.0691281067682;897.0043251990286;898.0884402331639;900.5947323704327;900.9819803603891;516.5170565521249;532.5233915645475;639.9424051835357;653.3956090616161;663.9734410623569;14662.120272783666;14683.339249733788;14695.77956330656;14699.044562103429;14721;11847.94076029623;13481;13956.651083722887;14011.859881401157;14037.1577705338;11219.083038410072;12194.512219511209;12332.876671233353;12437.93781031089;12857;4401.141777353418;4441.533638967894;4516.638668906479;4540.27355623102;4656.4645065817185;87389.12610873874;94724;103925.48037259765;115702.84297157005;118379;8740.431871928304;10712.19658525598;10788.190885683449;10905.34567925927;11169.553217871357;19846.80919144856;21552.676709849366;21560;21577.784222157577;21688.34934951954;7330;7660.2722741339485;7720.729774457867;7726.729564465217;8057.798555036171;4295.420118284054;4564.703294285927;4566.086782643484;4590.839320623762;4757.666963312604;2989.59640448541;3595.748297619194;3597.8380972856285;3600.477930700034;3607.7654952428534;495.4352038675912;598.9071693887454;609.558070398966;609.9634021958697;610.1336102734128;577.1861675038176;587.4918195760637;631.718885096137;639.7568923808923;653.6568301641677;6887.758928437581;8466.153384661484;8645.697400591074;8712.825743485095;8870.334724895658;572.6077636818792;585.4028890531633;587.3480436715242;618.3445547719432;631.709413669717;3755.342815007363;3774.2828862516585;4282.293421585466;4403.383526306319;4545.590896819236;100335.49832250937;141301;159537.20231398768;162832.18583907242;166210;129240;129700;130343.57251419863;130513.34743326412;133508;99688.50467243142;114230;117462.41268793601;123576;125632;8606.870896936676;8638.26574741154;8672.956635216784;8689.913100868911;8836.690715824916;49900;52412.73793631008;58769.412305876394;60785.696071519356;67925;65228.69542609216;96426.03573964171;102957;103299.93400131805;104648;10791.6222932197;11088.889111108785;11132.777344453227;11219.831702524305;11360.318380897173;11155.72110697239;12037.939810300892;12310.692232694255;12319.938400307941;12500.687482813002;11569.247998880046;12146.878531214576;12268.32524211177;12284.20152690108;12310.199837010565;10911.65328988774;13159.539416120773;13263.86736132665;13495.122817016863;13539.729205415639;13144.671383215496;13158.473661053833;13311.800322995357;13319.533816316383;14033.947453940791;10801.513931872927;10931.781364372828;11058.48486206779;11451.312921224753;11615.825762613737;11090.501121914735;11294.265872718248;11440.713982150513;11521.942390287995;11536.192466527262 00:25:21 INFO - PROCESS | 1664 | __end_tp_report 00:25:21 INFO - PROCESS | 1664 | __start_cc_report 00:25:21 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1692 00:25:21 INFO - PROCESS | 1664 | __end_cc_report 00:25:21 INFO - PROCESS | 1664 | __startTimestamp1475133921133__endTimestamp 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | ------- Summary: start ------- 00:25:21 INFO - PROCESS | 1664 | Number of tests: 6 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5691.18 Median:5866.18 stddev:657.05 (11.2%) stddev-sans-first:631.29 00:25:21 INFO - PROCESS | 1664 | Values: 3281.5 3303.5 3305.0 3341.9 3358.3 5498.7 5596.8 5634.4 5661.4 5685.1 5593.0 5613.4 5692.6 5694.2 5709.9 5017.7 5059.8 5075.6 5152.0 5157.0 5214.1 5236.5 5241.4 5258.9 5286.8 5188.2 5202.0 5203.9 5227.8 5261.3 4412.3 5021.2 5071.6 5103.7 5160.9 5089.8 5092.4 5099.0 5134.8 5176.2 5580.6 5585.2 5620.4 5636.4 5674.5 6037.1 6127.7 6129.1 6145.8 6149.8 6207.9 6217.5 6257.2 6264.7 6266.7 5673.1 5697.5 5700.6 5706.1 5747.3 6171.1 6215.7 6234.9 6330.0 6344.6 6052.5 6086.5 6113.8 6135.4 6143.4 6193.4 6211.5 6220.3 6227.0 6230.4 5961.1 6028.4 6151.6 6167.0 6180.6 6108.6 6121.5 6165.6 6221.2 6233.1 4870.9 4885.6 4886.2 4912.8 4917.7 4347.8 4377.6 4388.5 4403.9 4444.3 5580.5 5602.2 5625.0 5673.3 5677.6 6241.4 6247.9 6250.7 6266.4 6291.7 5631.2 5679.9 5693.6 5696.3 5730.8 4525.2 5193.2 5316.5 5324.8 5344.2 6274.7 6338.2 6341.7 6341.9 6343.4 6253.6 6262.5 6272.2 6273.2 6278.4 6284.3 6302.0 6321.8 6366.6 6384.8 5994.8 6041.6 6052.8 6095.3 6133.7 6229.9 6257.5 6262.3 6266.7 6276.9 6032.6 6067.6 6098.3 6101.9 6105.5 5736.5 5866.2 5906.9 5968.0 6050.6 5772.0 5790.8 5844.9 5848.2 5905.0 6079.6 6097.0 6102.0 6125.1 6125.7 5812.6 5865.0 5868.0 5890.8 5917.4 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:69430.16 Median:37258.91 stddev:158143.81 (424.4%) stddev-sans-first:158502.79 00:25:21 INFO - PROCESS | 1664 | Values: 514.4 539.3 541.9 562.4 563.6 37121.1 39581.8 39627.4 39681.8 39684.2 40462.2 40902.2 40971.8 41021.0 41060.4 8798.8 9013.5 9555.1 9777.5 9782.0 8899.5 8998.1 9007.1 11780.8 12117.8 12007.0 12074.8 12089.3 12094.0 12099.3 12032.7 12117.2 12122.1 12123.6 12145.7 8658.8 8894.5 11650.3 11724.5 11844.3 37835.8 40202.6 40213.8 40261.2 40280.4 3295.9 3504.0 3607.6 3786.0 4072.9 30234.9 30558.4 31343.5 31804.9 33138.2 3223.7 3233.8 3237.8 3251.1 3332.7 490501.0 491035.0 494808.0 495946.0 496045.0 32601.0 33193.2 33370.7 61611.0 62200.0 34826.8 34852.8 34887.3 34891.8 34927.7 14227.7 14355.9 14358.7 14365.3 14370.6 12135.0 12222.6 12241.0 12257.2 12264.3 6495.9 7287.6 7418.5 7418.6 7552.3 3079.2 3131.8 3169.8 3316.2 3355.5 916.8 947.1 954.8 963.6 999.2 28052.6 29107.4 29131.1 29271.4 29663.0 965.2 994.2 1035.9 1053.3 1055.7 14625.8 15012.2 15316.9 15380.2 15387.0 673934.0 678070.0 678982.6 679138.0 682652.0 47312.5 53320.7 53668.5 53718.7 53801.9 1260.6 1340.7 1354.8 1397.4 1399.4 27914.3 29789.4 30187.7 30326.7 30401.6 48439.5 48881.0 48937.3 49061.0 49117.0 430896.0 507280.0 509365.0 510306.0 851771.0 40082.4 41126.2 41126.8 41242.0 41433.0 45261.0 45638.3 45765.8 46174.8 46214.5 37251.8 37274.3 37278.4 38206.8 38852.0 36980.8 37139.4 37266.0 38183.8 38275.2 36335.5 37165.6 37171.6 37281.8 37288.6 31981.8 32989.5 33710.5 33811.7 33967.3 23815.3 24973.4 25042.2 25354.2 25523.6 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:33905.63 Median:2380.68 stddev:95219.25 (3999.7%) stddev-sans-first:95452.98 00:25:21 INFO - PROCESS | 1664 | Values: 321.7 368.5 374.2 387.8 400.5 19811.8 20187.8 20508.2 21015.9 21289.7 18125.5 19909.5 20091.7 20599.0 20712.2 4824.5 5811.5 5890.1 5930.8 6084.9 6007.3 6045.8 6061.1 6071.7 6073.9 5734.9 5913.2 5970.5 5983.7 6008.8 5814.1 5923.3 5978.8 5988.3 6016.7 5067.7 5128.9 5173.5 5173.7 5174.4 25691.0 25795.9 25987.4 26045.0 26128.3 2207.7 2256.6 2364.8 2396.6 2504.3 15103.7 15579.6 15827.5 15946.8 16346.5 1745.9 1862.2 1867.5 1888.3 1906.3 84537.0 114025.0 117819.4 118670.2 119989.0 10398.8 10417.4 10429.6 10525.6 10830.6 13577.5 13586.2 13605.9 13613.8 13630.1 8346.3 8523.8 8528.1 8551.1 8677.3 8545.3 8563.1 8618.4 8748.5 8749.9 5442.0 5643.3 5877.6 6087.4 6624.0 1788.5 1824.7 1825.6 1828.6 1887.5 901.3 928.1 931.5 945.2 986.3 21351.6 22042.3 22112.8 22152.4 22179.9 915.1 945.9 963.2 983.3 1018.2 10853.7 11052.2 11820.2 11851.0 11877.6 497813.0 577308.0 585297.0 592474.0 600153.0 114709.4 115859.8 117346.0 119162.0 121778.0 972.5 999.7 1019.6 1019.9 1022.1 14942.4 19298.7 19403.7 19408.9 19469.9 52630.0 53070.5 53692.4 53905.5 54147.0 73775.0 74466.0 74589.0 75404.6 75601.2 4882.7 5422.9 7757.2 7917.9 8262.5 11187.8 12759.7 12913.5 13322.5 13870.4 11497.3 11575.7 11749.3 11819.8 11882.8 11233.2 11337.5 11364.4 11726.4 11787.9 11594.5 11745.9 11861.3 11959.2 12040.2 7800.7 7885.0 7892.8 7981.4 8026.6 10541.0 10730.0 10978.2 11096.5 11313.5 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5677.09 Median:5041.79 stddev:3219.07 (63.8%) stddev-sans-first:3211.71 00:25:21 INFO - PROCESS | 1664 | Values: 1354.8 1500.9 1520.6 1731.5 1911.4 7871.8 8404.0 8635.4 8974.1 8974.9 8847.3 8945.2 8945.5 8947.2 8955.2 2339.5 2369.3 2369.3 2371.0 2372.3 2322.5 2353.3 2367.3 2370.1 2371.1 2339.1 2357.1 2361.6 2375.0 2375.5 2314.6 2337.0 2344.3 2345.6 2354.2 2306.7 2330.0 2341.0 2342.1 2343.3 8800.5 8998.9 9000.4 9003.8 9032.1 5154.4 5230.9 5357.5 5364.9 5378.6 3457.3 3555.2 3559.7 3631.0 3635.8 935.8 1027.7 1067.8 1081.3 1081.5 10955.8 11207.3 11610.8 11778.6 11991.3 3884.3 4359.5 4393.1 4601.9 4603.7 9267.4 9272.3 9273.4 9274.5 9276.7 5290.8 5291.8 5295.9 5298.9 5300.7 4203.8 4452.6 4605.3 4624.4 4956.4 3702.9 3754.8 3807.1 3821.3 3823.2 1144.7 1148.1 1148.2 1155.5 1164.8 848.1 860.3 881.5 912.9 957.3 5521.0 5733.4 6036.7 6052.6 6142.8 837.4 938.3 949.7 952.8 995.1 3265.8 3921.9 3939.2 4085.2 4112.9 9185.0 10580.8 10911.0 11049.2 11084.7 11021.9 11113.6 11114.7 11123.9 11162.4 8090.3 8091.4 8198.8 8311.9 8326.3 5688.9 5847.2 5902.2 5923.5 5927.8 9962.3 10089.5 10106.3 10302.0 10320.7 9373.8 9844.7 10222.7 10384.1 10502.9 6180.3 7043.8 7120.4 7206.6 7210.4 8350.3 8361.3 8369.1 8442.7 8456.5 7499.6 7561.2 7650.9 7677.5 7692.6 7378.4 7407.4 7455.0 7461.1 7480.9 7056.1 7071.4 7132.1 7139.4 7149.5 4084.3 4398.7 4946.7 4986.7 5100.9 4128.3 4998.7 5084.9 5206.1 5287.1 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4286.17 Median:4627.00 stddev:1327.11 (28.7%) stddev-sans-first:1296.59 00:25:21 INFO - PROCESS | 1664 | Values: 295.1 296.3 304.6 310.7 311.4 5195.3 5398.6 5435.8 5474.6 5512.9 5216.3 5336.7 5355.9 5356.8 5389.6 3494.9 3971.4 3972.1 4108.9 4128.4 3839.7 4074.3 4102.9 4137.1 4143.4 4035.7 4041.4 4048.6 4058.3 4133.3 4047.9 4055.2 4067.3 4067.7 4069.8 3166.7 3447.8 3498.2 3526.2 3540.8 4960.9 5243.3 5261.4 5312.6 5336.5 4229.6 4603.6 4612.9 4616.4 4637.6 4445.5 5044.0 5588.9 5639.9 5653.3 3572.6 3699.7 3792.8 3846.1 3886.5 6015.4 6048.3 6056.4 6060.7 6068.1 3293.4 3300.5 3945.3 3948.2 3953.7 3815.7 3933.3 3978.2 3993.2 3995.8 4615.4 4642.7 4645.7 4646.7 4658.3 4824.3 5780.2 5784.7 5794.8 5853.8 1042.6 1094.5 1175.0 1293.1 1372.6 928.9 944.4 953.8 956.1 962.6 3548.4 3971.8 4320.7 4401.6 4461.6 4067.8 4288.8 4802.6 4853.1 4871.2 3521.2 3851.0 3958.7 4150.5 4458.7 2430.6 2440.0 2558.5 2594.0 2594.8 4154.8 4250.0 4283.6 4307.4 4983.2 4247.7 4765.9 4957.3 4984.2 4997.4 4169.8 4420.5 4678.4 4704.3 4980.6 4790.7 4791.4 4819.4 4832.2 4871.7 4011.9 4049.8 4771.2 4881.7 4882.6 3679.3 4329.3 4374.3 4449.3 4714.7 3232.0 3268.9 3385.1 3413.0 3514.9 4674.7 4833.8 4881.3 4882.9 5532.7 5016.9 5377.0 5651.9 5715.8 5738.8 5680.2 5712.9 5730.0 5740.9 5776.3 5257.9 5588.2 5611.2 5634.3 5667.7 5284.4 5734.5 5756.4 5760.9 5773.9 4681.5 5474.1 5589.3 5633.0 5693.4 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:24513.49 Median:3596.79 stddev:40000.71 (1112.1%) stddev-sans-first:40072.88 00:25:21 INFO - PROCESS | 1664 | Values: 675.2 723.0 736.1 745.4 751.6 14827.7 15093.3 15316.0 15508.8 15675.3 11805.5 14173.6 14267.5 14295.0 14302.9 821.1 849.2 849.8 851.1 852.3 679.2 695.4 699.6 822.9 846.4 900.1 901.4 902.6 903.8 903.9 895.1 897.0 898.1 900.6 901.0 516.5 532.5 639.9 653.4 664.0 14662.1 14683.3 14695.8 14699.0 14721.0 11847.9 13481.0 13956.7 14011.9 14037.2 11219.1 12194.5 12332.9 12437.9 12857.0 4401.1 4441.5 4516.6 4540.3 4656.5 87389.1 94724.0 103925.5 115702.8 118379.0 8740.4 10712.2 10788.2 10905.3 11169.6 19846.8 21552.7 21560.0 21577.8 21688.3 7330.0 7660.3 7720.7 7726.7 8057.8 4295.4 4564.7 4566.1 4590.8 4757.7 2989.6 3595.7 3597.8 3600.5 3607.8 495.4 598.9 609.6 610.0 610.1 577.2 587.5 631.7 639.8 653.7 6887.8 8466.2 8645.7 8712.8 8870.3 572.6 585.4 587.3 618.3 631.7 3755.3 3774.3 4282.3 4403.4 4545.6 100335.5 141301.0 159537.2 162832.2 166210.0 129240.0 129700.0 130343.6 130513.3 133508.0 99688.5 114230.0 117462.4 123576.0 125632.0 8606.9 8638.3 8673.0 8689.9 8836.7 49900.0 52412.7 58769.4 60785.7 67925.0 65228.7 96426.0 102957.0 103299.9 104648.0 10791.6 11088.9 11132.8 11219.8 11360.3 11155.7 12037.9 12310.7 12319.9 12500.7 11569.2 12146.9 12268.3 12284.2 12310.2 10911.7 13159.5 13263.9 13495.1 13539.7 13144.7 13158.5 13311.8 13319.5 14033.9 10801.5 10931.8 11058.5 11451.3 11615.8 11090.5 11294.3 11440.7 11521.9 11536.2 00:25:21 INFO - PROCESS | 1664 | -------- Summary: end -------- 00:25:21 INFO - PROCESS | 1664 | 00:25:21 INFO - TEST-INFO | 1664: exit 0 00:25:21 INFO - TEST-OK | dromaeo_css | took 1117118ms 00:25:21 INFO - TEST-START | kraken 00:25:21 INFO - operating with platform_type : mac_ 00:25:21 INFO - Initialising browser for kraken test... 00:25:21 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpqEz2JL/profile http://localhost:49267/getInfo.html) 00:25:24 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 00:25:24 INFO - PROCESS | 1670 | colorDepth:24 00:25:24 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 00:25:24 INFO - PROCESS | 1670 | __metrics 00:25:24 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:25:24 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:25:25 INFO - TEST-INFO | 1670: exit 0 00:25:25 INFO - Browser initialized. 00:25:25 INFO - Running cycle 1/1 for kraken test... 00:25:25 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpqEz2JL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:25:36 INFO - PROCESS | 1671 | RSS: Main: 235798528 00:25:36 INFO - PROCESS | 1671 | 00:25:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 00:25:40 INFO - PROCESS | 1671 | RSS: Main: 294850560 00:25:40 INFO - PROCESS | 1671 | 00:25:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 00:25:43 INFO - PROCESS | 1671 | RSS: Main: 293003264 00:25:43 INFO - PROCESS | 1671 | 00:25:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 00:25:48 INFO - PROCESS | 1671 | RSS: Main: 385318912 00:25:48 INFO - PROCESS | 1671 | 00:25:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 00:25:50 INFO - PROCESS | 1671 | RSS: Main: 285003776 00:25:50 INFO - PROCESS | 1671 | 00:25:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:53 INFO - PROCESS | 1671 | RSS: Main: 290492416 00:25:53 INFO - PROCESS | 1671 | 00:25:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:56 INFO - PROCESS | 1671 | RSS: Main: 328019968 00:25:56 INFO - PROCESS | 1671 | 00:25:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 00:26:00 INFO - PROCESS | 1671 | RSS: Main: 328695808 00:26:00 INFO - PROCESS | 1671 | 00:26:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 00:26:03 INFO - PROCESS | 1671 | RSS: Main: 328507392 00:26:03 INFO - PROCESS | 1671 | 00:26:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:26:05 INFO - PROCESS | 1671 | RSS: Main: 303734784 00:26:05 INFO - PROCESS | 1671 | 00:26:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:26:08 INFO - PROCESS | 1671 | RSS: Main: 307224576 00:26:08 INFO - PROCESS | 1671 | 00:26:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:26:11 INFO - PROCESS | 1671 | RSS: Main: 310820864 00:26:11 INFO - PROCESS | 1671 | 00:26:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:26:14 INFO - PROCESS | 1671 | RSS: Main: 316747776 00:26:14 INFO - PROCESS | 1671 | 00:26:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:26:18 INFO - PROCESS | 1671 | RSS: Main: 318754816 00:26:18 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 00:26:20 INFO - PROCESS | 1671 | RSS: Main: 362246144 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | __start_tp_report 00:26:20 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 00:26:20 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 00:26:20 INFO - PROCESS | 1671 | |i|pagename|runs| 00:26:20 INFO - PROCESS | 1671 | |0;ai-astar;113;114;118;165;169;161;114;114;114;114 00:26:20 INFO - PROCESS | 1671 | |1;audio-beat-detection;145;110;111;145;109;110;110;106;144;114 00:26:20 INFO - PROCESS | 1671 | |2;audio-dft;200;185;184;186;183;183;207;180;183;183 00:26:20 INFO - PROCESS | 1671 | |3;audio-fft;74;83;59;88;61;59;59;58;81;57 00:26:20 INFO - PROCESS | 1671 | |4;audio-oscillator;89;71;91;70;69;69;93;68;69;89 00:26:20 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;86;90;86;88;85;89;87;90;86 00:26:20 INFO - PROCESS | 1671 | |6;imaging-darkroom;94;95;94;95;94;95;94;93;93;94 00:26:20 INFO - PROCESS | 1671 | |7;imaging-desaturate;85;86;85;87;87;86;85;86;84;86 00:26:20 INFO - PROCESS | 1671 | |8;json-parse-financial;57;53;54;53;54;54;54;53;54;54 00:26:20 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;65;78;66;74;74;69;71;70;71;73 00:26:20 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;85;86;88;88;87;84;86;90;88 00:26:20 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;140;144;148;152;142;148;128;152;194;141 00:26:20 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;170;169;223;168;166;163;229;223;167;167 00:26:20 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;66;66;66;68;67;69;66;66;66;68 00:26:20 INFO - PROCESS | 1671 | __end_tp_report 00:26:20 INFO - PROCESS | 1671 | __start_cc_report 00:26:20 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2006 00:26:20 INFO - PROCESS | 1671 | __end_cc_report 00:26:20 INFO - PROCESS | 1671 | __startTimestamp1475133980264__endTimestamp 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | ------- Summary: start ------- 00:26:20 INFO - PROCESS | 1671 | Number of tests: 14 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:129.60 Median:116.00 stddev:24.54 (21.2%) stddev-sans-first:25.28 00:26:20 INFO - PROCESS | 1671 | Values: 113.0 114.0 118.0 165.0 169.0 161.0 114.0 114.0 114.0 114.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:112.50 stddev:16.86 (15.0%) stddev-sans-first:15.35 00:26:20 INFO - PROCESS | 1671 | Values: 145.0 110.0 111.0 145.0 109.0 110.0 110.0 106.0 144.0 114.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:187.40 Median:184.50 stddev:8.78 (4.8%) stddev-sans-first:8.05 00:26:20 INFO - PROCESS | 1671 | Values: 200.0 185.0 184.0 186.0 183.0 183.0 207.0 180.0 183.0 183.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:67.90 Median:67.50 stddev:12.22 (18.1%) stddev-sans-first:12.76 00:26:20 INFO - PROCESS | 1671 | Values: 74.0 83.0 59.0 88.0 61.0 59.0 59.0 58.0 81.0 57.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:11.01 (13.8%) stddev-sans-first:10.91 00:26:20 INFO - PROCESS | 1671 | Values: 89.0 71.0 91.0 70.0 69.0 69.0 93.0 68.0 69.0 89.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.84 (2.1%) stddev-sans-first:1.88 00:26:20 INFO - PROCESS | 1671 | Values: 89.0 86.0 90.0 86.0 88.0 85.0 89.0 87.0 90.0 86.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 00:26:20 INFO - PROCESS | 1671 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 94.0 93.0 93.0 94.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 00:26:20 INFO - PROCESS | 1671 | Values: 85.0 86.0 85.0 87.0 87.0 86.0 85.0 86.0 84.0 86.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:0.50 00:26:20 INFO - PROCESS | 1671 | Values: 57.0 53.0 54.0 53.0 54.0 54.0 54.0 53.0 54.0 54.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:72.00 stddev:3.90 (5.4%) stddev-sans-first:3.46 00:26:20 INFO - PROCESS | 1671 | Values: 65.0 78.0 66.0 74.0 74.0 69.0 71.0 70.0 71.0 73.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.50 stddev:1.75 (2.0%) stddev-sans-first:1.83 00:26:20 INFO - PROCESS | 1671 | Values: 86.0 85.0 86.0 88.0 88.0 87.0 84.0 86.0 90.0 88.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:148.00 stddev:17.34 (11.7%) stddev-sans-first:18.09 00:26:20 INFO - PROCESS | 1671 | Values: 140.0 144.0 148.0 152.0 142.0 148.0 128.0 152.0 194.0 141.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:169.50 stddev:28.06 (16.6%) stddev-sans-first:29.26 00:26:20 INFO - PROCESS | 1671 | Values: 170.0 169.0 223.0 168.0 166.0 163.0 229.0 223.0 167.0 167.0 00:26:20 INFO - PROCESS | 1671 | 00:26:20 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 00:26:20 INFO - PROCESS | 1671 | Values: 66.0 66.0 66.0 68.0 67.0 69.0 66.0 66.0 66.0 68.0 00:26:20 INFO - PROCESS | 1671 | -------- Summary: end -------- 00:26:20 INFO - PROCESS | 1671 | 00:26:21 INFO - TEST-INFO | 1671: exit 0 00:26:21 INFO - TEST-OK | kraken | took 59305ms 00:26:21 INFO - SUITE-END | took 1176s 00:26:21 INFO - Completed test suite (00:19:36) 00:26:21 INFO - javascript benchmark 00:26:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.4585593377087, 3303.4549299365603, 3304.9919774468776, 3341.9498707519406, 3358.311546133043, 5498.697571633558, 5596.804111856086, 5634.40838711935, 5661.377248502672, 5685.118806584981, 5592.972035139829, 5613.354464236604, 5692.57305702072, 5694.202811606378, 5709.857253568653, 5017.7491125443585, 5059.797608095671, 5075.593952483792, 5151.974240128794, 5156.994386094713, 5214.06146893559, 5236.450172731866, 5241.371035475749, 5258.948210357925, 5286.762095705702, 5188.169892817169, 5202.03762303975, 5203.9219411708855, 5227.764750586214, 5261.263423120766, 4412.271975124101, 5021.246812978046, 5071.644984851062, 5103.668261562986, 5160.922586161173, 5089.770960306795, 5092.414372347191, 5099.005693889693, 5134.845954621367, 5176.2235664650225, 5580.581456390746, 5585.2459917910965, 5620.353659329188, 5636.408177141423, 5674.460926212003, 6037.094435834616, 6127.662978536178, 6129.080637904305, 6145.784897528565, 6149.815505534841, 6207.875842483125, 6217.502599792006, 6257.155284036688, 6264.655443950626, 6266.749330026793, 5673.111731538835, 5697.487226149667, 5700.629459085146, 5706.115552089433, 5747.310322761254, 6171.074338849208, 6215.689215539205, 6234.875302494015, 6330.0, 6344.587601805868, 6052.485538729257, 6086.452219300284, 6113.8471538211015, 6135.417135372132, 6143.38566143391, 6193.442590166816, 6211.472024877936, 6220.253569571681, 6227.0, 6230.408111229426, 5961.105834124916, 6028.3971602839365, 6151.569390142737, 6167.0, 6180.598261113103, 6108.578162056753, 6121.510279177655, 6165.599236049642, 6221.191245138103, 6233.096201050913, 4870.9269360959615, 4885.60915126789, 4886.169351210303, 4912.828051018198, 4917.704937703749, 4347.847825326098, 4377.606015458624, 4388.539203383662, 4403.867883963486, 4444.31113177458, 5580.525655319343, 5602.243697100839, 5624.971875140598, 5673.290838645169, 5677.602567820296, 6241.375862413813, 6247.937520624827, 6250.656213908279, 6266.404691554295, 6291.653959032205, 5631.155326701028, 5679.886402271932, 5693.601447898607, 5696.287964004499, 5730.828075157752, 4525.230710779176, 5193.221016847428, 5316.548093412026, 5324.787008519694, 5344.198370244494, 6274.717637706314, 6338.176037115146, 6341.746330146742, 6341.90487142684, 6343.429091381798, 6253.624782513064, 6262.4990000800735, 6272.18461599989, 6273.15312432834, 6278.4035516625845, 6284.340144284967, 6301.96849015752, 6321.778737744157, 6366.586171898812, 6384.840378990562, 5994.760209591567, 6041.577089603686, 6052.848678783065, 6095.329513753395, 6133.701927635063, 6229.937700622936, 6257.530685198537, 6262.3111457738705, 6266.717997690023, 6276.905846412399, 6032.577719559764, 6067.605605635619, 6098.26820781509, 6101.877962440638, 6105.45050945417, 5736.541076713769, 5866.178734977192, 5906.852328691817, 5967.9701601491715, 6050.576459647782, 5772.0, 5790.7973220937065, 5844.912326315194, 5848.239728835224, 5904.996150654313, 6079.635361205455, 6096.969515152396, 6102.0, 6125.081237814364, 6125.693715314127, 5812.564057695605, 5865.0, 5868.031774757288, 5890.793822216202, 5917.37867523921], "value": 5647.34733088507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.405861230279, 539.2692901118985, 541.8564080518663, 562.4010428893229, 563.5942121672394, 37121.071973200684, 39581.81254562361, 39627.40558891619, 39681.80159099204, 39684.2063158737, 40462.19075618486, 40902.18195636085, 40971.795141024326, 41021.0, 41060.384094238536, 8798.824023519526, 9013.459192448441, 9555.092266234697, 9777.46223957682, 9782.021797820233, 8899.466032038066, 8998.145176208283, 9007.099290070973, 11780.7643847123, 12117.818232726517, 12007.0, 12074.758504829899, 12089.335086570236, 12094.0, 12099.27404355737, 12032.699182520419, 12117.151799374047, 12122.090843186796, 12123.575674851427, 12145.69635759113, 8658.78353041179, 8894.466332020034, 11650.30098194111, 11724.531018759239, 11844.34856082915, 37835.81082094572, 40202.59797402018, 40213.79893100545, 40261.19477610461, 40280.38878444859, 3295.9176020599675, 3503.982480087583, 3607.5670919489567, 3785.9777859977653, 4072.8574499892657, 30234.94177703792, 30558.388832223452, 31343.529847052312, 31804.886828960876, 33138.17154571155, 3223.693749093832, 3233.8383080846097, 3237.7571682123935, 3251.0734440684528, 3332.7000569948823, 490501.0, 491035.0, 494808.0, 495946.0, 496045.0, 32601.0, 33193.17017074544, 33370.666293336755, 61611.0, 62200.0, 34826.82586587051, 34852.825735871156, 34887.30225395478, 34891.82554087213, 34927.650723492945, 14227.715445691028, 14355.856441435451, 14358.712825743427, 14365.281735913162, 14370.568882933529, 12135.0, 12222.572209972608, 12241.0, 12257.203281786655, 12264.32546209967, 6495.902561461582, 7287.6356182190675, 7418.517796343221, 7418.554886706815, 7552.320291173711, 3079.230192451887, 3131.8120912745308, 3169.8430073023183, 3316.1709572606846, 3355.5302257683456, 916.7983043730369, 947.1381043250609, 954.7947191353892, 963.5712108111964, 999.2305924438142, 28052.579211311848, 29107.417851643273, 29131.126066218047, 29271.414571708447, 29663.0, 965.2181732796317, 994.2145704893054, 1035.9329890213094, 1053.2942928238099, 1055.6516349604613, 14625.78061329081, 15012.249387530579, 15316.937410534812, 15380.230988450532, 15387.0, 673934.0, 678070.0, 678982.6050869714, 679138.0, 682652.0, 47312.526874730815, 53320.73339633277, 53668.463315367124, 53718.73140634272, 53801.92396152133, 1260.571405722059, 1340.7117469744053, 1354.8238728965368, 1397.3991183790865, 1399.3632897031623, 27914.302142445787, 29789.404211915207, 30187.69812301849, 30326.7204802337, 30401.631926562914, 48439.5156048435, 48881.0, 48937.265941011625, 49061.0, 49117.0, 430896.0, 507280.0, 509365.0, 510306.0, 851771.0, 40082.39876401915, 41126.1774764509, 41126.79436602918, 41242.0, 41433.0, 45261.0, 45638.31542526798, 45765.771171145265, 46174.769126154155, 46214.53785462103, 37251.813740931124, 37274.25451491009, 37278.44082338713, 38206.808965954995, 38852.0, 36980.81509592435, 37139.44290835586, 37266.0, 38183.809080954416, 38275.23449530938, 36335.454968176025, 37165.62834371622, 37171.628283717895, 37281.81359093187, 37288.627113728515, 31981.840090799396, 32989.50515742314, 33710.47171462199, 33811.66188338085, 33967.32065358728, 23815.285541433786, 24973.37566560778, 25042.248732538053, 25354.239372818844, 25523.6171457432], "value": 18856.334349949004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.6976042520031, 368.49884157545733, 374.2402922068202, 387.8235402891685, 400.4913759525403, 19811.801881981177, 20187.798122018776, 20508.17967281307, 21015.949202539887, 21289.68065479015, 18125.45933595646, 19909.502262443446, 20091.698624520643, 20599.0, 20712.171513139456, 4824.5416685415, 5811.506021988136, 5890.125552415788, 5930.762769489215, 6084.939150608504, 6007.339192688801, 6045.818625441244, 6061.090836374557, 6071.666058366788, 6073.908891366633, 5734.856628584277, 5913.172155898178, 5970.462658360747, 5983.700814959257, 6008.819735407945, 5814.0697488402075, 5923.348431672513, 5978.790742323998, 5988.281406231258, 6016.7292471838655, 5067.670601410933, 5128.871778205537, 5173.508516690908, 5173.689578625257, 5174.353205849269, 25691.0, 25795.871020644965, 25987.350316242057, 26045.0, 26128.34679133018, 2207.668849672562, 2256.593813113639, 2364.775346342095, 2396.59257926153, 2504.336350867022, 15103.697926041528, 15579.610509737235, 15827.52517424479, 15946.840531594651, 16346.509604711877, 1745.9388921387817, 1862.2457904548544, 1867.5051111455475, 1888.33908132154, 1906.3112876583855, 84537.0, 114025.0, 117819.41090294579, 118670.21994670086, 119988.99999999913, 10398.792024159626, 10417.427041512638, 10429.582816687247, 10525.631602893862, 10830.566777328977, 13577.456901724017, 13586.1848289101, 13605.931970340085, 13613.795793063113, 13630.1140425872, 8346.332293416512, 8523.829523409497, 8528.143072070925, 8551.1448855114, 8677.262432693291, 8545.31637469001, 8563.058063612998, 8618.439801412887, 8748.47509149453, 8749.912500875038, 5441.972790136103, 5643.294588176478, 5877.5591830612875, 6087.391260873877, 6624.0, 1788.499220218341, 1824.744535764994, 1825.6166205096813, 1828.5520047588159, 1887.5375532994503, 901.2699713232303, 928.1182876267573, 931.4737173496952, 945.239082538563, 986.31451141456, 21351.572968540542, 22042.33872983813, 22112.77887221107, 22152.446188845086, 22179.889100554396, 915.0620613870702, 945.8581212817995, 963.1620490173453, 983.2969426859829, 1018.2057994764095, 10853.728656783485, 11052.171087168495, 11820.23168494045, 11851.0, 11877.58428455, 497813.0, 577308.0, 585297.0, 592474.0, 600153.0, 114709.4264528672, 115859.84140158659, 117346.0, 119162.0, 121778.0, 972.4894430423942, 999.7350702063814, 1019.6176433837311, 1019.9031092046392, 1022.0852337158202, 14942.448552494156, 19298.71051934194, 19403.708944365564, 19408.902955485133, 19469.902650487224, 52630.0, 53070.469295308096, 53692.38922832321, 53905.46094539004, 54147.0, 73775.0, 74466.0, 74589.0, 75404.62297688477, 75601.24398755941, 4882.731449770296, 5422.918656220081, 7757.185495522889, 7917.881231781643, 8262.462939908886, 11187.832182517106, 12759.681007974503, 12913.481871035434, 13322.467101316226, 13870.4451821926, 11497.252678575866, 11575.710607234887, 11749.29504229749, 11819.763604728028, 11882.76234475323, 11233.213675042669, 11337.489812958602, 11364.431778411212, 11726.413679315829, 11787.882121178678, 11594.478248479007, 11745.882541174478, 11861.288322700666, 11959.162858599815, 12040.157188996685, 7800.687972481037, 7884.960575197088, 7892.763217103496, 7981.3614910808155, 8026.59867006659, 10541.0, 10730.0, 10978.231523793258, 11096.500657470271, 11313.490892909675], "value": 9669.81790782193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.8238728965232, 1500.8649221570056, 1520.6274462756624, 1731.4978656189705, 1911.4170178095676, 7871.7638470845895, 8403.957980210098, 8635.352348573859, 8974.14745599167, 8974.910250897488, 8847.33644976626, 8945.150210729986, 8945.463272203673, 8947.194752472276, 8955.19403253707, 2339.5203983183405, 2369.277370402035, 2369.3484291819714, 2371.0, 2372.252740386781, 2322.477442575424, 2353.2704861492907, 2367.3134790910617, 2370.075670488502, 2371.1463873005705, 2339.076064954342, 2357.068957761683, 2361.5631108244943, 2375.0143690368477, 2375.4655202579456, 2314.618088015475, 2337.0, 2344.2615576093563, 2345.566070277004, 2354.1642716835618, 2306.653309210171, 2329.9767002329927, 2340.9882950585306, 2342.0865862313713, 2343.297010896741, 8800.471971681656, 8998.910010899872, 9000.369974101815, 9003.819923601557, 9032.096790320915, 5154.38147422308, 5230.92153617696, 5357.517823395913, 5364.91952620711, 5378.623496355257, 3457.3085382923264, 3555.2178520725397, 3559.661832125944, 3630.981845090784, 3635.818209089535, 935.7601178438528, 1027.6505987964129, 1067.8238090715022, 1081.3349789879167, 1081.4971038467152, 10955.83566246507, 11207.271527350696, 11610.825837612443, 11778.587749428729, 11991.340476273714, 3884.2814079395403, 4359.498657654347, 4393.055493069006, 4601.907961840744, 4603.746793926366, 9267.351285410092, 9272.258219342437, 9273.35086543949, 9274.489903055262, 9276.72169834906, 5290.788368465295, 5291.761870715827, 5295.867603309948, 5298.947010529922, 5300.734963251822, 4203.768792716369, 4452.643788496913, 4605.332226827159, 4624.44506659203, 4956.355673762388, 3702.9444558331647, 3754.793486358222, 3807.143392736612, 3821.2548553031893, 3823.2162406707116, 1144.713821544614, 1148.0815347721789, 1148.1962626161721, 1155.5435602936793, 1164.813629819242, 848.1476116502876, 860.2773670117132, 881.5063564403954, 912.9132732390545, 957.2916042128775, 5520.978618955426, 5733.369329373765, 6036.728347224385, 6052.606580572248, 6142.78500252498, 837.3761547647042, 938.2915898496591, 949.7245798718294, 952.7570469530364, 995.1093771074848, 3265.755068369882, 3921.8823435296986, 3939.212157568498, 4085.2442298174933, 4112.876613701594, 9185.0, 10580.788384232272, 10911.0, 11049.17131215162, 11084.667459976214, 11021.889781102247, 11113.611023614296, 11114.722131946766, 11123.944380278208, 11162.441877906072, 8090.271875531231, 8091.433599647969, 8198.754037378889, 8311.875321870057, 8326.333893288522, 5688.871220215073, 5847.239858818326, 5902.173695682522, 5923.49650279731, 5927.762889484545, 9962.302638815214, 10089.545970431202, 10106.292559520763, 10302.0, 10320.741981450223, 9373.765655858659, 9844.704658860246, 10222.693319200436, 10384.117350025332, 10502.894971050497, 6180.258368995749, 7043.788686339418, 7120.359167674934, 7206.603636800026, 7210.423166146591, 8350.290225330915, 8361.331093512626, 8369.079401265733, 8442.66229350819, 8456.492610443147, 7499.625018748931, 7561.243875612395, 7650.885236721565, 7677.539347639159, 7692.615369231628, 7378.446616503891, 7407.444441667004, 7455.0, 7461.141968673672, 7480.92519074824, 7056.1179852518435, 7071.36357727807, 7132.1441427029085, 7139.428845692436, 7149.463790215651, 4084.264832330209, 4398.73607583546, 4946.703197808143, 4986.700797952134, 5100.872478187926, 4128.318827393447, 4998.6500944933505, 5084.923726144185, 5206.062908676475, 5287.074761916572], "value": 4541.887049279618, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.09406123201774, 296.25935162094777, 304.6185548537383, 310.6753442652428, 311.36792311607445, 5195.298634684316, 5398.568114550836, 5435.755391007404, 5474.589405794566, 5512.862178445541, 5216.322492642687, 5336.6531175473565, 5355.919661205085, 5356.758945847437, 5389.649672771267, 3494.8776792812255, 3971.3844354125085, 3972.145988612462, 4108.917821643566, 4128.360104183841, 3839.6544311012003, 4074.286999775042, 4102.917941641165, 4137.069159439117, 4143.357779544175, 4035.6771458283265, 4041.3937909313545, 4048.5748996355255, 4058.3100872851537, 4133.3386658134705, 4047.919041619151, 4055.2497787909183, 4067.3085575451946, 4067.694922880781, 4069.7965101744794, 3166.730827879633, 3447.827608619559, 3498.195415054526, 3526.2368815592204, 3540.805255710935, 4960.925586116211, 5243.318368612094, 5261.368635763694, 5312.574994000471, 5336.466353364672, 4229.619334259901, 4603.629130997539, 4612.924184117127, 4616.422947131608, 4637.5826175644015, 4445.5327293352175, 5043.9912017596625, 5588.944110558883, 5639.8590035249445, 5653.265075540154, 3572.5712914450173, 3699.6855267302312, 3792.753471024402, 3846.115393459492, 3886.514185726784, 6015.368386319461, 6048.304444988838, 6056.424639659225, 6060.72726727294, 6068.146726828451, 3293.4401151803772, 3300.4554248549202, 3945.2898478273614, 3948.230095131479, 3953.695280557409, 3815.6565909067763, 3933.272344616255, 3978.204359128186, 3993.221321842213, 3995.820188091485, 4615.353850460938, 4642.721436713808, 4645.6980296280635, 4646.697964632288, 4658.277966915133, 4824.34871292378, 5780.248567686258, 5784.681842498703, 5794.841031793658, 5853.843770922607, 1042.5777560088177, 1094.5402930769096, 1175.0129890891692, 1293.1077556485996, 1372.6499742565782, 928.9489078100769, 944.390867890207, 953.8330792111353, 956.0535070280512, 962.5957098018849, 3548.3967725486727, 3971.7616942983514, 4320.740755554677, 4401.603855652943, 4461.553844615577, 4067.8169482372773, 4288.785560721952, 4802.615790736732, 4853.058776489362, 4871.222003968597, 3521.2429327694667, 3851.0372406898277, 3958.7332053742525, 4150.501939767248, 4458.7324760514475, 2430.647556104355, 2439.9878000609883, 2558.5160606847985, 2593.9650608787765, 2594.7664710176173, 4154.750714957112, 4250.0, 4283.601183337341, 4307.418498502725, 4983.202687569971, 4247.660187185018, 4765.8561945132915, 4957.339291337443, 4984.208843047904, 4997.425810869565, 4169.769917874174, 4420.535843736426, 4678.415153149864, 4704.270838020044, 4980.551750342486, 4790.712557246577, 4791.448983366958, 4819.445763737075, 4832.178529649897, 4871.683340582851, 4011.919761604693, 4049.797510124541, 4771.186948959373, 4881.731504767272, 4882.55872063968, 3679.282539904693, 4329.307310830252, 4374.343848422762, 4449.28811390176, 4714.693544919569, 3232.028462637742, 3268.9346213076083, 3385.053594183305, 3413.0272872231294, 3514.894553163409, 4674.719516829001, 4833.776462826998, 4881.316615673737, 4882.901347196852, 5532.695701736443, 5016.924746128738, 5377.032134215879, 5651.92613403452, 5715.771369145187, 5738.8278351649515, 5680.182341650798, 5712.914306285492, 5730.0, 5740.942590574208, 5776.335721392094, 5257.948410317876, 5588.239704493071, 5611.2424822650055, 5634.295713035871, 5667.659940403589, 5284.365876094893, 5734.455226753452, 5756.42435756421, 5760.913586296125, 5773.942260577341, 4681.485036645898, 5474.056709868099, 5589.301337332833, 5632.971835140798, 5693.430656934273], "value": 3874.8852623914095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.1796567170887, 723.0311382747118, 736.0541703910475, 745.3589912675102, 751.6467260387623, 14827.703445931089, 15093.320800563974, 15316.0, 15508.844911550896, 15675.29461174247, 11805.468753906074, 14173.645658858533, 14267.50063747769, 14295.0, 14302.856971430283, 821.080389963242, 849.1932663969224, 849.8045449546609, 851.0680804519072, 852.2968550945463, 679.1680191765073, 695.3706895259797, 699.5907394174415, 822.8889099971517, 846.3948276981956, 900.1268769293774, 901.4140808474511, 902.634433054614, 903.8463461211577, 903.941243819153, 895.0691281067682, 897.0043251990286, 898.0884402331639, 900.5947323704327, 900.9819803603891, 516.5170565521249, 532.5233915645475, 639.9424051835357, 653.3956090616161, 663.9734410623569, 14662.120272783666, 14683.339249733788, 14695.77956330656, 14699.044562103429, 14721.0, 11847.94076029623, 13481.0, 13956.651083722887, 14011.859881401157, 14037.1577705338, 11219.083038410072, 12194.512219511209, 12332.876671233353, 12437.93781031089, 12857.0, 4401.141777353418, 4441.533638967894, 4516.638668906479, 4540.27355623102, 4656.4645065817185, 87389.12610873874, 94724.0, 103925.48037259765, 115702.84297157005, 118379.0, 8740.431871928304, 10712.19658525598, 10788.190885683449, 10905.34567925927, 11169.553217871357, 19846.80919144856, 21552.676709849366, 21560.0, 21577.784222157577, 21688.34934951954, 7330.0, 7660.2722741339485, 7720.729774457867, 7726.729564465217, 8057.798555036171, 4295.420118284054, 4564.703294285927, 4566.086782643484, 4590.839320623762, 4757.666963312604, 2989.59640448541, 3595.748297619194, 3597.8380972856285, 3600.477930700034, 3607.7654952428534, 495.4352038675912, 598.9071693887454, 609.558070398966, 609.9634021958697, 610.1336102734128, 577.1861675038176, 587.4918195760637, 631.718885096137, 639.7568923808923, 653.6568301641677, 6887.758928437581, 8466.153384661484, 8645.697400591074, 8712.825743485095, 8870.334724895658, 572.6077636818792, 585.4028890531633, 587.3480436715242, 618.3445547719432, 631.709413669717, 3755.342815007363, 3774.2828862516585, 4282.293421585466, 4403.383526306319, 4545.590896819236, 100335.49832250937, 141301.0, 159537.20231398768, 162832.18583907242, 166210.0, 129240.0, 129700.0, 130343.57251419863, 130513.34743326412, 133508.0, 99688.50467243142, 114230.0, 117462.41268793601, 123576.0, 125632.0, 8606.870896936676, 8638.26574741154, 8672.956635216784, 8689.913100868911, 8836.690715824916, 49900.0, 52412.73793631008, 58769.412305876394, 60785.696071519356, 67925.0, 65228.69542609216, 96426.03573964171, 102957.0, 103299.93400131805, 104648.0, 10791.6222932197, 11088.889111108785, 11132.777344453227, 11219.831702524305, 11360.318380897173, 11155.72110697239, 12037.939810300892, 12310.692232694255, 12319.938400307941, 12500.687482813002, 11569.247998880046, 12146.878531214576, 12268.32524211177, 12284.20152690108, 12310.199837010565, 10911.65328988774, 13159.539416120773, 13263.86736132665, 13495.122817016863, 13539.729205415639, 13144.671383215496, 13158.473661053833, 13311.800322995357, 13319.533816316383, 14033.947453940791, 10801.513931872927, 10931.781364372828, 11058.48486206779, 11451.312921224753, 11615.825762613737, 11090.501121914735, 11294.265872718248, 11440.713982150513, 11521.942390287995, 11536.192466527262], "value": 7553.721793700488, "unit": "score"}], "name": "dromaeo_css", "value": 7179.109015728672, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 118.0, 165.0, 169.0, 161.0, 114.0, 114.0, 114.0, 114.0], "value": 129.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 111.0, 145.0, 109.0, 110.0, 110.0, 106.0, 144.0, 114.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 185.0, 184.0, 186.0, 183.0, 183.0, 207.0, 180.0, 183.0, 183.0], "value": 187.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 59.0, 88.0, 61.0, 59.0, 59.0, 58.0, 81.0, 57.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 91.0, 70.0, 69.0, 69.0, 93.0, 68.0, 69.0, 89.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 86.0, 88.0, 85.0, 89.0, 87.0, 90.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 93.0, 93.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 87.0, 87.0, 86.0, 85.0, 86.0, 84.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 66.0, 74.0, 74.0, 69.0, 71.0, 70.0, 71.0, 73.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 88.0, 88.0, 87.0, 84.0, 86.0, 90.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 148.0, 152.0, 142.0, 148.0, 128.0, 152.0, 194.0, 141.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 223.0, 168.0, 166.0, 163.0, 229.0, 223.0, 167.0, 167.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 68.0, 67.0, 69.0, 66.0, 66.0, 66.0, 68.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1462.6000000000001, "alertThreshold": 2.0}]} 00:26:21 INFO - Return code: 0 00:26:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:26:21 INFO - # TBPL SUCCESS # 00:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:26:21 INFO - 2016-09-29 00:26:21.583 screenresolution[1675:10845] starting screenresolution argv=screenresolution get 00:26:21 INFO - 2016-09-29 00:26:21.586 screenresolution[1675:10845] Display 0: 1600x1200x32@60 00:26:21 INFO - 2016-09-29 00:26:21.592 screenresolution[1676:10848] starting screenresolution argv=screenresolution list 00:26:21 INFO - Available Modes on Display 0 00:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:26:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:26:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:26:21 INFO - Intel Iris: 00:26:21 INFO - Chipset Model: Intel Iris 00:26:21 INFO - Type: GPU 00:26:21 INFO - Bus: Built-In 00:26:21 INFO - VRAM (Dynamic, Max): 1536 MB 00:26:21 INFO - Vendor: Intel (0x8086) 00:26:21 INFO - Device ID: 0x0a2e 00:26:21 INFO - Revision ID: 0x0009 00:26:21 INFO - Displays: 00:26:21 INFO - Display: 00:26:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:26:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:26:21 INFO - Display Serial Number: 1600x1200 60 00:26:21 INFO - Main Display: Yes 00:26:21 INFO - Mirror: Off 00:26:21 INFO - Online: Yes 00:26:21 INFO - Rotation: Supported 00:26:21 INFO - Return code: 0 00:26:21 INFO - Running post-action listener: _resource_record_post_action 00:26:21 INFO - [mozharness: 2016-09-29 07:26:21.828201Z] Finished run-tests step (success) 00:26:21 INFO - Running post-run listener: _resource_record_post_run 00:26:21 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31947776; Write bytes: 709497856; Read time: 197; Write time: 1962 00:26:21 INFO - TinderboxPrint: CPU usage
53.6% 00:26:21 INFO - TinderboxPrint: I/O read bytes / time
31,947,776 / 197 00:26:21 INFO - TinderboxPrint: I/O write bytes / time
709,497,856 / 1,962 00:26:21 INFO - TinderboxPrint: CPU idle
2,249.4 (46.4%) 00:26:21 INFO - TinderboxPrint: CPU system
967.7 (20.0%) 00:26:21 INFO - TinderboxPrint: CPU user
1,632.6 (33.7%) 00:26:21 INFO - TinderboxPrint: Swap in / out
435,761,152 / 0 00:26:21 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389360128; Write bytes: 384337920; Read time: 29253; Write time: 773 00:26:21 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31026176; Write bytes: 298806272; Read time: 186; Write time: 1125 00:26:22 INFO - Running post-run listener: _upload_blobber_files 00:26:22 INFO - Blob upload gear active. 00:26:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:26:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:26:22 INFO - (blobuploader) - INFO - Open directory for files ... 00:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:23 INFO - (blobuploader) - INFO - Done attempting. 00:26:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:26:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:26:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:24 INFO - (blobuploader) - INFO - Done attempting. 00:26:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:26:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:26:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:26:27 INFO - (blobuploader) - INFO - Done attempting. 00:26:27 INFO - (blobuploader) - INFO - Iteration through files over. 00:26:27 INFO - Return code: 0 00:26:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:26:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:26:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbb10ff978d3d315c8737fe55b4fd855ca7079380a64d7c4864cdddfb633fba0edb44f301259abbeac614198c42922c989d10fd575643f4a49cc50712744a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4ec11cd705c1fe05c41282eddb77b7202cd43038e7939af90941452f124281e5b2ae88f9f69d2482fd9f25bf63b8f06da752a3602642ecc528c0fbf64ac8088", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c3508ddfe4e8044a5bdfc59104a52ae97ab96333f44d3ec2886c0039a11bf300c78c835f686b512306b43de0dce0cbe5df6033f20af368dbc0fe1ed04d56c28"} 00:26:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:26:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:26:27 INFO - Contents: 00:26:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbb10ff978d3d315c8737fe55b4fd855ca7079380a64d7c4864cdddfb633fba0edb44f301259abbeac614198c42922c989d10fd575643f4a49cc50712744a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4ec11cd705c1fe05c41282eddb77b7202cd43038e7939af90941452f124281e5b2ae88f9f69d2482fd9f25bf63b8f06da752a3602642ecc528c0fbf64ac8088", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c3508ddfe4e8044a5bdfc59104a52ae97ab96333f44d3ec2886c0039a11bf300c78c835f686b512306b43de0dce0cbe5df6033f20af368dbc0fe1ed04d56c28"} 00:26:27 INFO - Running post-run listener: copy_logs_to_upload_dir 00:26:27 INFO - Copying logs to upload dir... 00:26:27 INFO - mkdir: /builds/slave/test/build/upload/logs 00:26:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.110776 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-29 00:26:27.190461) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 00:26:27.194884) ========= 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.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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/cbb10ff978d3d315c8737fe55b4fd855ca7079380a64d7c4864cdddfb633fba0edb44f301259abbeac614198c42922c989d10fd575643f4a49cc50712744a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4ec11cd705c1fe05c41282eddb77b7202cd43038e7939af90941452f124281e5b2ae88f9f69d2482fd9f25bf63b8f06da752a3602642ecc528c0fbf64ac8088", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c3508ddfe4e8044a5bdfc59104a52ae97ab96333f44d3ec2886c0039a11bf300c78c835f686b512306b43de0dce0cbe5df6033f20af368dbc0fe1ed04d56c28"} build_url:https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/KF4gm6z3SsGBsSt0HDya2A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cbb10ff978d3d315c8737fe55b4fd855ca7079380a64d7c4864cdddfb633fba0edb44f301259abbeac614198c42922c989d10fd575643f4a49cc50712744a4e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f4ec11cd705c1fe05c41282eddb77b7202cd43038e7939af90941452f124281e5b2ae88f9f69d2482fd9f25bf63b8f06da752a3602642ecc528c0fbf64ac8088", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c3508ddfe4e8044a5bdfc59104a52ae97ab96333f44d3ec2886c0039a11bf300c78c835f686b512306b43de0dce0cbe5df6033f20af368dbc0fe1ed04d56c28"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 00:26:27.228336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:26:27.228669) ========= 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.EOp4zIIhYe/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.CqEhXRx89a/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.005091 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 00:26:27.281936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 00:26:27.282269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 00:26:27.282611) ========= ========= Total master_lag: 2.59 =========