builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0316 starttime: 1480071308.37 results: success (0) buildid: 20161125004419 builduid: 94007c8787f94c7a8f61374ce1936dc5 revision: c5c00b463cc744954d4cc8dac626e979db55a039 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.370877) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.371303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.371659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.419150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.419833) ========= 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.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-11-25 02:55:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-11-25 02:55:08 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.516058 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.969051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:08.969360) ========= 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.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.024808 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:09.017525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-11-25 02:55:09.017887) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c5c00b463cc744954d4cc8dac626e979db55a039 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c5c00b463cc744954d4cc8dac626e979db55a039 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-11-25 02:55:09,120 truncating revision to first 12 chars 2016-11-25 02:55:09,120 Setting DEBUG logging. 2016-11-25 02:55:09,120 attempt 1/10 2016-11-25 02:55:09,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c5c00b463cc7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 02:55:10,283 unpacking tar archive at: mozilla-aurora-c5c00b463cc7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436814 ========= master_lag: 2.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-11-25 02:55:13.089629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:13.089903) ========= script_repo_revision: c5c00b463cc744954d4cc8dac626e979db55a039 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:13.090252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:13.090575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 02:55:13.135961) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-25 02:55:13.136231) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55:13 INFO - MultiFileLogger online at 20161125 02:55:13 in /builds/slave/test 02:55:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:55:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:13 INFO - {'append_to_log': False, 02:55:13 INFO - 'base_work_dir': '/builds/slave/test', 02:55:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:55:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:13 INFO - 'branch': 'Mozilla-Aurora', 02:55:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:13 INFO - 'config_files': ('talos/mac_config.py',), 02:55:13 INFO - 'default_actions': ('clobber', 02:55:13 INFO - 'read-buildbot-config', 02:55:13 INFO - 'download-and-extract', 02:55:13 INFO - 'populate-webroot', 02:55:13 INFO - 'create-virtualenv', 02:55:13 INFO - 'install', 02:55:13 INFO - 'run-tests'), 02:55:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:13 INFO - 'download_minidump_stackwalk': True, 02:55:13 INFO - 'download_symbols': 'ondemand', 02:55:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:13 INFO - 'installer_path': 'installer.exe', 02:55:13 INFO - 'log_level': 'info', 02:55:13 INFO - 'log_name': 'talos', 02:55:13 INFO - 'log_to_console': True, 02:55:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:13 INFO - 'opt_config_files': (), 02:55:13 INFO - 'pip_index': False, 02:55:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:13 INFO - 'cmd': ('bash', 02:55:13 INFO - '-c', 02:55:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:13 INFO - 'enabled': True, 02:55:13 INFO - 'halt_on_failure': False, 02:55:13 INFO - 'name': 'check_screen_resolution'},), 02:55:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:13 INFO - 'cmd': ('bash', 02:55:13 INFO - '-c', 02:55:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:13 INFO - 'enabled': True, 02:55:13 INFO - 'halt_on_failure': False, 02:55:13 INFO - 'name': 'check_screen_resolution'},), 02:55:13 INFO - 'run_cmd_checks_enabled': True, 02:55:13 INFO - 'sps_profile': False, 02:55:13 INFO - 'sps_profile_interval': 0, 02:55:13 INFO - 'suite': 'dromaeojs', 02:55:13 INFO - 'system_bits': '32', 02:55:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:13 INFO - 'title': 't-yosemite-r7-0316', 02:55:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:13 INFO - 'use_talos_json': True, 02:55:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:13 INFO - 'work_dir': 'build'} 02:55:13 INFO - [mozharness: 2016-11-25 10:55:13.348551Z] Running clobber step. 02:55:13 INFO - Running pre-action listener: _resource_record_pre_action 02:55:13 INFO - Running main action method: clobber 02:55:13 INFO - rmtree: /builds/slave/test/build 02:55:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:15 INFO - Running post-action listener: _resource_record_post_action 02:55:15 INFO - [mozharness: 2016-11-25 10:55:15.851233Z] Finished clobber step (success) 02:55:15 INFO - [mozharness: 2016-11-25 10:55:15.851745Z] Running read-buildbot-config step. 02:55:15 INFO - Running pre-action listener: _resource_record_pre_action 02:55:15 INFO - Running main action method: read_buildbot_config 02:55:15 INFO - Using buildbot properties: 02:55:15 INFO - { 02:55:15 INFO - "project": "", 02:55:15 INFO - "product": "firefox", 02:55:15 INFO - "script_repo_revision": "production", 02:55:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:55:15 INFO - "repository": "", 02:55:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:55:15 INFO - "buildid": "20161125004419", 02:55:15 INFO - "pgo_build": "False", 02:55:15 INFO - "basedir": "/builds/slave/test", 02:55:15 INFO - "buildnumber": 34, 02:55:15 INFO - "slavename": "t-yosemite-r7-0316", 02:55:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:55:15 INFO - "platform": "yosemite_r7", 02:55:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:55:15 INFO - "branch": "mozilla-aurora", 02:55:15 INFO - "repo_path": "releases/mozilla-aurora", 02:55:15 INFO - "revision": "c5c00b463cc744954d4cc8dac626e979db55a039", 02:55:15 INFO - "stage_platform": "macosx64", 02:55:15 INFO - "builduid": "94007c8787f94c7a8f61374ce1936dc5", 02:55:15 INFO - "slavebuilddir": "test" 02:55:15 INFO - } 02:55:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:55:15 INFO - Running post-action listener: _resource_record_post_action 02:55:15 INFO - [mozharness: 2016-11-25 10:55:15.858361Z] Finished read-buildbot-config step (success) 02:55:15 INFO - [mozharness: 2016-11-25 10:55:15.858517Z] Running download-and-extract step. 02:55:15 INFO - Running pre-action listener: _resource_record_pre_action 02:55:15 INFO - Running main action method: download_and_extract 02:55:15 INFO - mkdir: /builds/slave/test/build/tests 02:55: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')]} 02:55:15 INFO - trying https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:55:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:55:16 INFO - Downloaded 1199 bytes. 02:55:16 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:55:16 INFO - Using the following test package requirements: 02:55:16 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:55:16 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:55:16 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:55:16 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'jsshell-mac.zip'], 02:55:16 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:55:16 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:55:16 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:55:16 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:55:16 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:55:16 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:55:16 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:55:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:55:17 INFO - Http code: 200 02:55:17 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 02:55:17 INFO - x-amz-cf-id: RY4HeJVILsPgbziokP6dGpVm3urJK4ekt99bDcLDrLCEJOKW3Q5IPw== 02:55:17 INFO - x-amz-version-id: oJA6B9M7ESydLgddurjU3O6BPlCSMma7 02:55:17 INFO - Expected file size: 16278943 02:55:17 INFO - Obtained file size: 16278943 02:55:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:55:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:55:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:55:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:55:25 INFO - Http code: 200 02:55:25 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 02:55:25 INFO - x-amz-cf-id: uA458B9twmCG9VnqFvrxlv53GPTDcEFGGOpGmORy21uiuus9fFbXCA== 02:55:25 INFO - x-amz-version-id: oJA6B9M7ESydLgddurjU3O6BPlCSMma7 02:55:25 INFO - Expected file size: 16278943 02:55:25 INFO - Obtained file size: 16278943 02:55:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:55:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:55:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:55:32 INFO - Http code: 200 02:55:32 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 02:55:32 INFO - x-amz-cf-id: djVA31C1HNfn6WGZ9IZ-BTUmkbV0CzQlsTmEgh7NGZ6fLjH_l96suA== 02:55:32 INFO - x-amz-version-id: CwWe6HDnNi_06LGH7Sp0z69tS7Z1lRvs 02:55:32 INFO - Expected file size: 14409038 02:55:32 INFO - Obtained file size: 14409038 02:55:33 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')]} 02:55:33 INFO - trying https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:55:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:55:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:55:36 INFO - Downloaded 109739354 bytes. 02:55:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:55:36 INFO - mkdir: /builds/slave/test/properties 02:55:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:36 INFO - Contents: 02:55:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:55:36 INFO - Running post-action listener: _resource_record_post_action 02:55:36 INFO - Running post-action listener: set_extra_try_arguments 02:55:36 INFO - [mozharness: 2016-11-25 10:55:36.949418Z] Finished download-and-extract step (success) 02:55:36 INFO - [mozharness: 2016-11-25 10:55:36.949555Z] Running populate-webroot step. 02:55:36 INFO - Running pre-action listener: _resource_record_pre_action 02:55:36 INFO - Running main action method: populate_webroot 02:55:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:36 INFO - '--tppagecycles', 02:55:36 INFO - '7'], 02:55:36 INFO - 'tests': ['tsvgm']}}, 02:55:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['damp', 'tps']}, 02:55:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'tests': ['damp', 'tps']}, 02:55:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['dromaeo_dom']}, 02:55:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['basic_compositor_video']}, 02:55:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:55:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['a11yr', 02:55:36 INFO - 'ts_paint', 02:55:36 INFO - 'tpaint', 02:55:36 INFO - 'sessionrestore', 02:55:36 INFO - 'sessionrestore_no_auto_restore', 02:55:36 INFO - 'tabpaint']}, 02:55:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['tsvgx', 02:55:36 INFO - 'tsvgr_opacity', 02:55:36 INFO - 'tart', 02:55:36 INFO - 'tscrollx', 02:55:36 INFO - 'cart']}, 02:55:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:36 INFO - 'tsvgr_opacity', 02:55:36 INFO - 'tart', 02:55:36 INFO - 'tscrollx', 02:55:36 INFO - 'cart']}, 02:55:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'talos_options': ['--disable-e10s'], 02:55:36 INFO - 'tests': ['tp5o']}, 02:55:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'tests': ['tp5o']}, 02:55:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'talos_options': ['--disable-e10s', 02:55:36 INFO - '--xperf_path', 02:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:36 INFO - 'tests': ['tp5n']}, 02:55:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:36 INFO - 'talos_options': ['--xperf_path', 02:55:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:36 INFO - 'tests': ['tp5n']}}, 02:55:36 INFO - 'talos.zip': {'path': '', 02:55:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:36 INFO - Running post-action listener: _resource_record_post_action 02:55:36 INFO - [mozharness: 2016-11-25 10:55:36.968459Z] Finished populate-webroot step (success) 02:55:36 INFO - [mozharness: 2016-11-25 10:55:36.968571Z] Running create-virtualenv step. 02:55:36 INFO - Running pre-action listener: _resource_record_pre_action 02:55:36 INFO - Running main action method: create_virtualenv 02:55:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:36 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 02:55:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:37 INFO - Using real prefix '/tools/python27' 02:55:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:37 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:40 INFO - Installing pip.................done. 02:55:40 INFO - Return code: 0 02:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:55:40 INFO - Reading from file tmpfile_stdout 02:55:40 INFO - Output received: 02:55:40 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) 02:55:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:40 INFO - 'HOME': '/Users/cltbld', 02:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:40 INFO - 'LOGNAME': 'cltbld', 02:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:40 INFO - 'MOZ_NO_REMOTE': '1', 02:55:40 INFO - 'NO_EM_RESTART': '1', 02:55:40 INFO - 'PAGER': '/bin/cat', 02:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:40 INFO - 'PWD': '/builds/slave/test', 02:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:40 INFO - 'SHELL': '/bin/bash', 02:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:40 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:40 INFO - 'USER': 'cltbld', 02:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:40 INFO - 'XPC_FLAGS': '0x0', 02:55:40 INFO - 'XPC_SERVICE_NAME': '0', 02:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55: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 02:55:41 INFO - Cleaning up... 02:55:41 INFO - Return code: 0 02:55:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55: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 02:55: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 02:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:41 INFO - 'HOME': '/Users/cltbld', 02:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:41 INFO - 'LOGNAME': 'cltbld', 02:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:41 INFO - 'MOZ_NO_REMOTE': '1', 02:55:41 INFO - 'NO_EM_RESTART': '1', 02:55:41 INFO - 'PAGER': '/bin/cat', 02:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:41 INFO - 'PWD': '/builds/slave/test', 02:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:41 INFO - 'SHELL': '/bin/bash', 02:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:41 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:41 INFO - 'USER': 'cltbld', 02:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:41 INFO - 'XPC_FLAGS': '0x0', 02:55:41 INFO - 'XPC_SERVICE_NAME': '0', 02:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:41 INFO - Downloading/unpacking psutil>=3.1.1 02:55:41 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 02:55:41 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 02:55:41 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 02:55:41 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 02:55:41 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 02:55:41 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 02:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:45 INFO - Installing collected packages: psutil 02:55:45 INFO - Running setup.py install for psutil 02:55:45 INFO - building 'psutil._psutil_osx' extension 02:55: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 02:55: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 02:55: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 02:55: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 02:55:46 INFO - building 'psutil._psutil_posix' extension 02:55: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 02:55:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:55:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:55:46 INFO - ^ 02:55:46 INFO - 1 warning generated. 02:55: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 02:55:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:46 INFO - Successfully installed psutil 02:55:46 INFO - Cleaning up... 02:55:46 INFO - Return code: 0 02:55:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:46 INFO - 'HOME': '/Users/cltbld', 02:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:46 INFO - 'LOGNAME': 'cltbld', 02:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:46 INFO - 'MOZ_NO_REMOTE': '1', 02:55:46 INFO - 'NO_EM_RESTART': '1', 02:55:46 INFO - 'PAGER': '/bin/cat', 02:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:46 INFO - 'PWD': '/builds/slave/test', 02:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:46 INFO - 'SHELL': '/bin/bash', 02:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:46 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:46 INFO - 'USER': 'cltbld', 02:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:46 INFO - 'XPC_FLAGS': '0x0', 02:55:46 INFO - 'XPC_SERVICE_NAME': '0', 02:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:55:49 INFO - Installing collected packages: mozsystemmonitor 02:55:49 INFO - Running setup.py install for mozsystemmonitor 02:55:49 INFO - Successfully installed mozsystemmonitor 02:55:49 INFO - Cleaning up... 02:55:49 INFO - Return code: 0 02:55:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:49 INFO - 'HOME': '/Users/cltbld', 02:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:49 INFO - 'LOGNAME': 'cltbld', 02:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:49 INFO - 'MOZ_NO_REMOTE': '1', 02:55:49 INFO - 'NO_EM_RESTART': '1', 02:55:49 INFO - 'PAGER': '/bin/cat', 02:55:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:49 INFO - 'PWD': '/builds/slave/test', 02:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:49 INFO - 'SHELL': '/bin/bash', 02:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:49 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:49 INFO - 'USER': 'cltbld', 02:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:49 INFO - 'XPC_FLAGS': '0x0', 02:55:49 INFO - 'XPC_SERVICE_NAME': '0', 02:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:50 INFO - Downloading/unpacking jsonschema==2.5.1 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:55:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:53 INFO - Downloading functools32-3.2.3-2.tar.gz 02:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:55:53 INFO - warning: no files found matching '*.txt' 02:55:53 INFO - no previously-included directories found matching 'build' 02:55:53 INFO - no previously-included directories found matching 'dist' 02:55:53 INFO - no previously-included directories found matching '.git*' 02:55:53 INFO - Installing collected packages: jsonschema, functools32 02:55:53 INFO - Running setup.py install for functools32 02:55:53 INFO - warning: no files found matching '*.txt' 02:55:53 INFO - no previously-included directories found matching 'build' 02:55:53 INFO - no previously-included directories found matching 'dist' 02:55:53 INFO - no previously-included directories found matching '.git*' 02:55:53 INFO - Successfully installed jsonschema functools32 02:55:53 INFO - Cleaning up... 02:55:53 INFO - Return code: 0 02:55:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55: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 02:55: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 02:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:53 INFO - 'HOME': '/Users/cltbld', 02:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:53 INFO - 'LOGNAME': 'cltbld', 02:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:53 INFO - 'MOZ_NO_REMOTE': '1', 02:55:53 INFO - 'NO_EM_RESTART': '1', 02:55:53 INFO - 'PAGER': '/bin/cat', 02:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:53 INFO - 'PWD': '/builds/slave/test', 02:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:53 INFO - 'SHELL': '/bin/bash', 02:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:53 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:53 INFO - 'USER': 'cltbld', 02:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:53 INFO - 'XPC_FLAGS': '0x0', 02:55:53 INFO - 'XPC_SERVICE_NAME': '0', 02:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:55:53 INFO - Cleaning up... 02:55:53 INFO - Return code: 0 02:55:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55: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 02:55: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 02:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:53 INFO - 'HOME': '/Users/cltbld', 02:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:53 INFO - 'LOGNAME': 'cltbld', 02:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:53 INFO - 'MOZ_NO_REMOTE': '1', 02:55:53 INFO - 'NO_EM_RESTART': '1', 02:55:53 INFO - 'PAGER': '/bin/cat', 02:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:53 INFO - 'PWD': '/builds/slave/test', 02:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:53 INFO - 'SHELL': '/bin/bash', 02:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:53 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:53 INFO - 'USER': 'cltbld', 02:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:53 INFO - 'XPC_FLAGS': '0x0', 02:55:53 INFO - 'XPC_SERVICE_NAME': '0', 02:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:56 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55: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 02:55:57 INFO - Downloading docopt-0.6.1.tar.gz 02:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:57 INFO - Running setup.py install for blobuploader 02:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:57 INFO - Running setup.py install for requests 02:55:58 INFO - Running setup.py install for docopt 02:55:58 INFO - Successfully installed blobuploader requests docopt 02:55:58 INFO - Cleaning up... 02:55:58 INFO - Return code: 0 02:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:55: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 02:55: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 02:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:58 INFO - 'HOME': '/Users/cltbld', 02:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:58 INFO - 'LOGNAME': 'cltbld', 02:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:58 INFO - 'MOZ_NO_REMOTE': '1', 02:55:58 INFO - 'NO_EM_RESTART': '1', 02:55:58 INFO - 'PAGER': '/bin/cat', 02:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:58 INFO - 'PWD': '/builds/slave/test', 02:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:58 INFO - 'SHELL': '/bin/bash', 02:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:55:58 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:58 INFO - 'USER': 'cltbld', 02:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:58 INFO - 'XPC_FLAGS': '0x0', 02:55:58 INFO - 'XPC_SERVICE_NAME': '0', 02:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-tjdNfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-UdpNWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Yzu9J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-t33dSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-5A33TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-frE1f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-2k528q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Mwdft2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-IUNLJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:59 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ZUlGT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-zgXl1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-BA8cVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-3Cq_kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-sJmYeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-H6k0hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-zL6JVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:00 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-x61Zrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:56:00 INFO - Running setup.py install for manifestparser 02:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Running setup.py install for mozcrash 02:56:01 INFO - Running setup.py install for mozdebug 02:56:01 INFO - Running setup.py install for mozdevice 02:56:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozfile 02:56:01 INFO - Running setup.py install for mozhttpd 02:56:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozinfo 02:56:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozInstall 02:56:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozleak 02:56:02 INFO - Running setup.py install for mozlog 02:56:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for moznetwork 02:56:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozprocess 02:56:02 INFO - Running setup.py install for mozprofile 02:56:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozrunner 02:56:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozscreenshot 02:56:03 INFO - Running setup.py install for moztest 02:56:03 INFO - Running setup.py install for mozversion 02:56:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:03 INFO - Cleaning up... 02:56:03 INFO - Return code: 0 02:56:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:56: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 02:56: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 02:56:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:56:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:03 INFO - 'HOME': '/Users/cltbld', 02:56:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:03 INFO - 'LOGNAME': 'cltbld', 02:56:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:03 INFO - 'MOZ_NO_REMOTE': '1', 02:56:03 INFO - 'NO_EM_RESTART': '1', 02:56:03 INFO - 'PAGER': '/bin/cat', 02:56:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:03 INFO - 'PWD': '/builds/slave/test', 02:56:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:03 INFO - 'SHELL': '/bin/bash', 02:56:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:56:03 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:56:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:03 INFO - 'USER': 'cltbld', 02:56:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:03 INFO - 'XPC_FLAGS': '0x0', 02:56:03 INFO - 'XPC_SERVICE_NAME': '0', 02:56:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-U2UK3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56: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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-dxAEHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-aIuNNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:03 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-RCV9MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-fddux3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-AfH7KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ozXfqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-gVuswD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-07rUNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-7Ra0CO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-VoFGYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-qvPnIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56: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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-RZH4DM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:04 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ASmDCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:05 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-imEKK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56: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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:05 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-E0Qsl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56: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)) 02:56:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:05 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-0_BiMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56: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)) 02:56: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56: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==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56:07 INFO - Downloading blessings-1.6.tar.gz 02:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:08 INFO - Installing collected packages: blessings 02:56:08 INFO - Running setup.py install for blessings 02:56:08 INFO - Successfully installed blessings 02:56:08 INFO - Cleaning up... 02:56:08 INFO - Return code: 0 02:56:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:08 INFO - Reading from file tmpfile_stdout 02:56:08 INFO - Current package versions: 02:56:08 INFO - blessings == 1.6 02:56:08 INFO - blobuploader == 1.2.4 02:56:08 INFO - docopt == 0.6.1 02:56:08 INFO - functools32 == 3.2.3-2 02:56:08 INFO - jsonschema == 2.5.1 02:56:08 INFO - manifestparser == 1.1 02:56:08 INFO - mozInstall == 1.12 02:56:08 INFO - mozcrash == 1.0 02:56:08 INFO - mozdebug == 0.1 02:56:08 INFO - mozdevice == 0.48 02:56:08 INFO - mozfile == 1.2 02:56:08 INFO - mozhttpd == 0.7 02:56:08 INFO - mozinfo == 0.9 02:56:08 INFO - mozleak == 0.1 02:56:08 INFO - mozlog == 3.4 02:56:08 INFO - moznetwork == 0.27 02:56:08 INFO - mozprocess == 0.23 02:56:08 INFO - mozprofile == 0.28 02:56:08 INFO - mozrunner == 6.13 02:56:08 INFO - mozscreenshot == 0.1 02:56:08 INFO - mozsystemmonitor == 0.3 02:56:08 INFO - moztest == 0.7 02:56:08 INFO - mozversion == 1.4 02:56:08 INFO - psutil == 3.1.1 02:56:08 INFO - requests == 1.2.3 02:56:08 INFO - wsgiref == 0.1.2 02:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:56: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 02:56: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 02:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:08 INFO - 'HOME': '/Users/cltbld', 02:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:08 INFO - 'LOGNAME': 'cltbld', 02:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:08 INFO - 'MOZ_NO_REMOTE': '1', 02:56:08 INFO - 'NO_EM_RESTART': '1', 02:56:08 INFO - 'PAGER': '/bin/cat', 02:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:08 INFO - 'PWD': '/builds/slave/test', 02:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:08 INFO - 'SHELL': '/bin/bash', 02:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:56:08 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:08 INFO - 'USER': 'cltbld', 02:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:08 INFO - 'XPC_FLAGS': '0x0', 02:56:08 INFO - 'XPC_SERVICE_NAME': '0', 02:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56: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)) 02:56:08 INFO - Cleaning up... 02:56:08 INFO - Return code: 0 02:56:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56: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')]} 02:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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')]} 02:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56: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 0x10de3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ddb3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea51d6f2a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, '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.QheMDLHgjX/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.lLrwq0nm2t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 02:56: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 02:56: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 02:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:08 INFO - 'HOME': '/Users/cltbld', 02:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:08 INFO - 'LOGNAME': 'cltbld', 02:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:08 INFO - 'MOZ_NO_REMOTE': '1', 02:56:08 INFO - 'NO_EM_RESTART': '1', 02:56:08 INFO - 'PAGER': '/bin/cat', 02:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:08 INFO - 'PWD': '/builds/slave/test', 02:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:08 INFO - 'SHELL': '/bin/bash', 02:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:56:08 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:08 INFO - 'USER': 'cltbld', 02:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:08 INFO - 'XPC_FLAGS': '0x0', 02:56:08 INFO - 'XPC_SERVICE_NAME': '0', 02:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:56:09 INFO - Cleaning up... 02:56:09 INFO - Return code: 0 02:56:09 INFO - Running post-action listener: _resource_record_post_action 02:56:09 INFO - Running post-action listener: _start_resource_monitoring 02:56:09 INFO - Starting resource monitoring. 02:56:09 INFO - [mozharness: 2016-11-25 10:56:09.159593Z] Finished create-virtualenv step (success) 02:56:09 INFO - [mozharness: 2016-11-25 10:56:09.160619Z] Running install step. 02:56:09 INFO - Running pre-action listener: _resource_record_pre_action 02:56:09 INFO - Running main action method: install 02:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:09 INFO - Reading from file tmpfile_stdout 02:56:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:09 INFO - Reading from file tmpfile_stdout 02:56:09 INFO - Output received: 02:56:09 INFO - Usage: mozinstall [options] installer 02:56:09 INFO - Options: 02:56:09 INFO - -h, --help show this help message and exit 02:56:09 INFO - -d DEST, --destination=DEST 02:56:09 INFO - Directory to install application into. [default: 02:56:09 INFO - "/builds/slave/test"] 02:56:09 INFO - --app=APP Application being installed. [default: firefox] 02:56:09 INFO - mkdir: /builds/slave/test/build/application 02:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:56:40 INFO - Reading from file tmpfile_stdout 02:56:40 INFO - Output received: 02:56:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:56:40 INFO - Running post-action listener: _resource_record_post_action 02:56:40 INFO - [mozharness: 2016-11-25 10:56:40.665114Z] Finished install step (success) 02:56:40 INFO - [mozharness: 2016-11-25 10:56:40.665246Z] Running run-tests step. 02:56:40 INFO - Running pre-action listener: _resource_record_pre_action 02:56:40 INFO - Running main action method: run_tests 02:56:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:40 INFO - 2016-11-25 02:56:40.678 screenresolution[1631:8109] starting screenresolution argv=screenresolution get 02:56:40 INFO - 2016-11-25 02:56:40.680 screenresolution[1631:8109] Display 0: 1600x1200x32@60 02:56:40 INFO - 2016-11-25 02:56:40.686 screenresolution[1632:8111] starting screenresolution argv=screenresolution list 02:56:40 INFO - Available Modes on Display 0 02:56:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:40 INFO - Intel Iris: 02:56:40 INFO - Chipset Model: Intel Iris 02:56:40 INFO - Type: GPU 02:56:40 INFO - Bus: Built-In 02:56:40 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:40 INFO - Vendor: Intel (0x8086) 02:56:40 INFO - Device ID: 0x0a2e 02:56:40 INFO - Revision ID: 0x0009 02:56:40 INFO - Displays: 02:56:40 INFO - Display: 02:56:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:40 INFO - Display Serial Number: 1600x1200 60 02:56:40 INFO - Main Display: Yes 02:56:40 INFO - Mirror: Off 02:56:40 INFO - Online: Yes 02:56:40 INFO - Rotation: Supported 02:56:40 INFO - Return code: 0 02:56:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:40 INFO - Python 2.7.3 02:56:40 INFO - Return code: 0 02:56:40 INFO - grabbing minidump binary from tooltool 02:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:40 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 0x10dc51d30>, '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 0x10dab7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:40 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 02:56:40 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 02:56:40 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 02:56:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:41 INFO - Return code: 0 02:56:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 02:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0316 --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 02:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QheMDLHgjX/Render', 02:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:41 INFO - 'HOME': '/Users/cltbld', 02:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:41 INFO - 'LOGNAME': 'cltbld', 02:56:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:41 INFO - 'MOZ_NO_REMOTE': '1', 02:56:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:41 INFO - 'NO_EM_RESTART': '1', 02:56:41 INFO - 'PAGER': '/bin/cat', 02:56:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:41 INFO - 'PWD': '/builds/slave/test', 02:56:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:41 INFO - 'SHELL': '/bin/bash', 02:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lLrwq0nm2t/Listeners', 02:56:41 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 02:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:41 INFO - 'USER': 'cltbld', 02:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:41 INFO - 'XPC_FLAGS': '0x0', 02:56:41 INFO - 'XPC_SERVICE_NAME': '0', 02:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 02:56:41 INFO - mozversion application_buildid: 20161125004419 02:56:41 INFO - mozversion application_changeset: c5c00b463cc744954d4cc8dac626e979db55a039 02:56:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:56:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:41 INFO - mozversion application_name: Firefox 02:56:41 INFO - mozversion application_remotingname: firefox-dev 02:56:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:41 INFO - mozversion application_vendor: Mozilla 02:56:41 INFO - mozversion application_version: 52.0a2 02:56:41 INFO - mozversion platform_buildid: 20161125004419 02:56:41 INFO - mozversion platform_changeset: c5c00b463cc744954d4cc8dac626e979db55a039 02:56:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:56:41 INFO - mozversion platform_version: 52.0a2 02:56:41 INFO - using testdate: 1480071401 02:56:41 INFO - actual date: 1480071401 02:56:41 INFO - starting webserver on 'localhost:49240' 02:56:41 INFO - SUITE-START | Running 2 tests 02:56:41 INFO - TEST-START | dromaeo_css 02:56:41 INFO - operating with platform_type : mac_ 02:56:41 INFO - Initialising browser for dromaeo_css test... 02:56:41 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpprv9Ad/profile http://localhost:49240/getInfo.html) 02:56:43 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 02:56:43 INFO - PROCESS | 1642 | colorDepth:24 02:56:43 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 02:56:43 INFO - PROCESS | 1642 | __metrics 02:56:43 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:56:43 INFO - PROCESS | 1642 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:44 INFO - TEST-INFO | 1642: exit 0 02:56:44 INFO - Browser initialized. 02:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:44 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpprv9Ad/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:57 INFO - PROCESS | 1645 | RSS: Main: 222887936 02:56:57 INFO - PROCESS | 1645 | 02:57:48 INFO - PROCESS | 1645 | 1480071468625 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] 03:00:01 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:00:03 INFO - PROCESS | 1645 | RSS: Main: 315805696 03:00:03 INFO - PROCESS | 1645 | 03:03:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:03:06 INFO - PROCESS | 1645 | RSS: Main: 348049408 03:03:06 INFO - PROCESS | 1645 | 03:06:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:06:09 INFO - PROCESS | 1645 | RSS: Main: 316669952 03:06:09 INFO - PROCESS | 1645 | 03:09:12 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:09:12 INFO - PROCESS | 1645 | RSS: Main: 315518976 03:09:12 INFO - PROCESS | 1645 | 03:12:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:12:16 INFO - PROCESS | 1645 | RSS: Main: 313520128 03:12:16 INFO - PROCESS | 1645 | 03:15:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 03:15:20 INFO - PROCESS | 1645 | RSS: Main: 372273152 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | __start_tp_report 03:15:20 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 03:15:20 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 03:15:20 INFO - PROCESS | 1645 | |i|pagename|runs| 03:15:20 INFO - PROCESS | 1645 | |0;dojo.html;3243.50798632629;3251.8536665850033;3322.468405055191;3349.1961929137005;3367.1077164551384;5711.057675483546;5742.856428589283;5746.310442746866;5759.020966435705;5813.30240371156;5691.8292451226525;5765.106408506688;5773.884522309551;5824.388439213874;5824.854378640536;5216.504432078947;5216.791328346881;5247.606429517782;5286.392064912527;5289.180177072541;5191.688498690071;5213.426523082458;5227.73861306935;5326.227696983935;5342.572594192456;5222.4255331913455;5259.211118332242;5266.710330931797;5273.920891186616;5293.655912365684;5273.841784746463;5322.627416080837;5332.626716129873;5333.040052790496;5339.065663508871;5117.590592752571;5256.632035757499;5263.763130659129;5287.68273903567;5300.469953004668;5610.382857885629;5611.7474713637985;5639.802606908738;5648.717564121777;5693.544516438675;6164.383561643845;6201.441870231656;6209.689515524251;6244;6296.433321001086;6286.717097730568;6288.496920246369;6334.556581039329;6336.17629708135;6353.459955903753;5649.237352957381;5699.031164702011;5771.220885180447;5801.506871915934;5855.385184555603;6283.654399008007;6312;6324.462420694293;6325.9051114233325;6335;6169.876602467925;6169.981952977709;6175.876482470326;6177.62934223939;6189.783357582553;6144.126041557279;6158.414950579688;6214.689265536705;6235.282942461675;6289.24529056507;5239;6198.163247961557;6283.937160628427;6286.748530058747;6295.118683384329;6242.282137554149;6275.152854364694;6289.056641503811;6319.46284565817;6326.367363263729;4763.642726795504;4878.36581244443;4942.555170034714;4962.404511458648;4989.451160372356;4396.252637051709;4402.493713222956;4405.867823965286;4408.338749187647;4500.909981800346;5806.44838740319;5811.622244554091;5817.563682723812;5831.620944638585;5840.970795146082;6298;6329.145565348619;6344.238691356974;6366.968165159237;6400.0719895614875;5574.303212098488;5677.574181936288;5701.059325211377;5756.913646295309;5809.448102430262;5409.702466364388;5420.810271640474;5429.267048948342;5433.782648694087;5438.510534051954;5988.311344195299;6302.306746257908;6326.8734625306315;6339.080833279241;6349.015902535114;6032.306284777132;6120.17377654011;6238.438540531374;6281.309056003744;6320.115183874169;6237.8752424950335;6307.526935479949;6328.968355158195;6335.271443784024;6348;6238.064290356301;6265.561410701207;6277.027060805583;6294.8111556653375;6298.559100862895;6139.829471381233;6208.9689551551955;6269.749210031548;6303.023031430135;6311.305756366888;5976.342602313655;6092.6039807414145;6108.08378743192;6115.724792384264;6187.876242475035;6138.739088650262;6146.907796383147;6158.291796443466;6183;6204.565680402328;5789.2184555086205;5920.171176035273;6001.849953751192;6008.399160083956;6099.268087829489;5984.281886173513;6071.9981203101;6092.208012958287;6110.16388879229;6158.907616385847;5741.3971532988435;5762.654240745569;5790.1893734877995;5816.47651711348;5823.79616713413 03:15:20 INFO - PROCESS | 1645 | |1;ext.html;515.5385929593015;525.4928993521252;527.3961314295135;546.022619511075;551.8675517875708;32465.51301730473;39393.80303098484;39467.407988880186;39496.60503394969;39512.80243598778;40451.595484045225;40628;40659.79670101653;40676.59323406765;40710.38934415979;9205.171534561889;9372.953135234315;9382.108699673554;9393.06069393062;9397.342186046979;9304.209142222919;9414.576344064499;9416.717498475056;9420.293477989144;9429.292803039765;9387.155156035955;9443.716688499357;9454.810903781954;9497.382670126453;9506.334556581041;9377.062293770636;9438.622455101788;9442;9448.669296574586;9469.905300946972;9172.6789562365;9258.953705231497;9260.490673012982;9275.72172834816;9276.675316363895;38945.221095578214;39281.41077883834;39282;39282;39334.60665393367;2878.401997503121;3199.840007999591;3258.7881787683964;3498.6501349865066;3887.9028024299337;28181;28717.425651486854;29507.262318441997;29823.65793539274;30576.54135187974;3093.489574220251;3106.8135911845134;3150.4959206526846;3169.9683003169903;3176.190071531768;459460;462251;466033.9999999966;466249.337506624;466295;30555.847220763753;59442;59960.40039599635;60035.69982150149;60102.699486502286;28074.71925280762;33824.98525044253;34015.14962125967;34061.14847128792;34139.658603414144;11631.65105046833;14246.501372452121;14249.073810202304;14271.78592321116;14282.714345713028;12061.396930153458;12129.939350303192;12146.574869879512;12161.270323780602;12180.086493513021;6811.795646130624;7221.241769614115;7617.923820761722;7681.577513236825;7691.653875575501;3174.555562221291;3232.8060316381093;3234.4016356974034;3234.4178047951596;3268.591426071741;932.7388331267256;957.2055194188806;1011.8785745710414;1014.5282443663584;1022.0852337158202;24862.751372486044;27880.16359509218;29179.270518237216;29618.407631847243;29655.703442965296;875.5410018534433;879.9648014079493;882.289756745813;1068.9465526723632;1121.966341009771;14954;15024.474143405147;15158.772618410732;15300.770488442682;15326.23368831554;675065;681107;681417;683055;683407;49286;55400.44599553953;55868.44131558632;55983.44016559782;56043.439565603825;1250.9624711258678;1336.993315033438;1349.50742978814;1382.6819831438625;1383.7301726163503;28957.85521072381;29382.559261610666;29630;30098.24754381158;30218;48078;48588.75705621449;48676.269855952894;48680;48736.26895596498;544771;549920;695329.7568633774;716335;717780;37991.81004094962;38017;38162.618373817015;38275.42586861143;38320.23359532849;43167.35248971205;43648;43887.78056109827;44028.89927751832;44306;36202.63797362098;36843.63156368402;36852.63147368492;37086.07284817793;38125.4281185788;36883.63116368802;36942.44586331261;36987.63012369949;37103.44344834776;37236.627633723314;34637.96086117421;35121.8243908789;35999.100022499646;36985.63014369822;37160.6283937168;32153.517697235027;32493.67506325001;33084.503732443554;33126.503102453964;33298.667013329556;24661;24765;24982;25151.622725658763;25220.74779252184 03:15:20 INFO - PROCESS | 1645 | |2;jquery.html;295.5728971635986;347.8712876235793;370.43323714716485;370.7608592457865;399.70421887803036;14719.190444525548;15238.619034524143;16060.67878642428;18690.813091869077;20371;19458;19657.31199408021;20009.299674511396;20139.59720805583;20368.388948331536;5615.606907516475;5707.828765137053;5838.532917366621;5890.175375447441;5904.439078287577;5473;5785.797497087603;5790.36306006339;5796.652200867961;5800.680962547058;5768.307803063638;5823.854403639901;5830.650160990333;5836.445537673935;5845.970770146143;5581.525570326507;5785.652860828342;5807.593468457209;5856.648601083906;5871.060630299132;5665.745041473144;5666.631668941547;5667.121596152603;5685.147227915804;5689.061304884689;22711;22789.20237791686;23570.882145589163;23646.054157833667;23781;2026.2199053364413;2082.1983536338466;2205.9669104963436;2319.652052192168;2862.7852911031546;8304.958475207586;9586.76033099171;9654.613815447374;14460.276986150651;15312.617184570476;1794.9102544872703;1809.3938530592268;1829.6432195721839;1847.6581832361055;1882.6799444094536;111430;117778;119666.4016679911;121557.39221303837;122595.16107258399;10942.507587158598;11506.367149806674;11534.250273732348;11755.412229388496;11910.94044529789;12649.114561980574;13186.340682966005;13219.735605288033;13369.33153342329;14078.859211407755;8235.794105147299;8302.83394332122;8364.37267204962;8485.193906578865;8518.70184543538;7072.504924655224;8215.548144852091;8222.218889205635;8464.576771161417;8477.23704866565;4115.670746340285;4140.44104045956;4418.248897687401;4507.842225522091;4594.95405045952;1866.6080123174286;1905.4378958207362;1929.4597512696469;1943.1450161928706;1957.1192963166632;806.6289506826926;890.7684002159485;934.4113208678625;984.8325784616633;1025.9025392587691;19842.70235946462;20552;20678.793212067685;20735.27426540064;21008.26471073505;885.3227281129941;906.2387594420718;921.3780698028804;938.2869019545059;952.1668540027476;8690.652373905099;9373.734545836362;9989.500524973722;10703.357798532114;10937.179711521667;615341;619027;623100;634679;636193;120374;128522;129340;138066.30966845102;144235;767.5011242692294;978.4422878959067;1003.3678782367208;1005.4470041477158;1006.3056491021172;14961.156251392547;18632.347867824563;18946.242150313832;19110.904445477685;19128.234870605578;53783;53871;55082;56694.43305567057;57102;77357.61321193358;78980;79275.62173134815;79594.20405795868;81042.5947870257;7871.976643036369;7962.402819788655;7986.440949133737;8232.876506852523;8247.051589067334;11812.822807658064;12360.4437800301;12572.497100115894;12635.494580217057;12879.034072444792;10609.681709548726;10720.785584288427;10740.892591074302;11210.215284929976;11232.831507527557;10557.366558006544;10621.681349559525;10653.307535010199;10724.356538607708;10766.354018758899;10856.34905223549;10961.013508783928;10974.286671366335;11071.280366776457;11157.776844462904;6861.279565645735;7825.882611760942;7930.762077137695;8280.296174825207;8337.999440067231;8852.955735221283;9055.773605659911;10627.149828013586;10750.8387374191;11048.226624136554 03:15:20 INFO - PROCESS | 1645 | |3;mootools.html;1267.1510088240877;1469.933852976616;1497.8352381238062;1651.793525809274;1826;7456.701731930723;7852.9607351963305;7855.921440785591;7863.213678632134;7863.292303692667;7697.34572561333;8122.675092996273;8224.013118425783;8250.793730156749;8367.372447066478;2286.9542609147848;2323.5933711600487;2324.5699545584034;2325;2327.2436458151083;2007.7590689117326;2219.768028744046;2288.439332363565;2328.662343960125;2341.3210169050953;2258.06290389489;2263.173941511353;2292.1862738727764;2304.6543018547186;2313.8495997760174;2059.2895451069357;2144.731908511436;2254.2786308381324;2264.53577016712;2287.3824067501846;2290.977090229093;2312;2315.7684231576877;2316.525112351964;2316.629339305703;8257.05043919951;8321.334293256525;8410.411271211018;8415.28470080044;8422.28410585101;4895.804167833282;4954.43024052235;5061.974690126526;5082.33929589151;5155.072087024334;3355.614104377979;3493.2489514754448;3578.731595130376;3586.9282614347826;3587.461880717913;1045.7647029418397;1071.669778713595;1085.1427372375813;1097.1880808201952;1100.9229353945227;10802.67591972242;10813.513391897304;10930.453477326182;10933.890661093288;10948.671539853816;4234.13200293939;4307.332363483602;4372;4429.247028005247;4436.889077773017;7794.688212471551;8493.745187644381;8562.48625082497;8709.346798990102;8722.694705685397;5071.366079240095;5072.340595722532;5076.111680455905;5077.974610126926;5087.8982420351385;4002.6197511236387;4210.789460527023;4333.8699839004885;4384.298512238027;4776.164171270014;3613.4399168128457;3636.890893273206;3713.517242758424;3715.2198038412234;3719.27474142545;1129.4578602270792;1139.043203708872;1144.2905398652888;1148.5578052449866;1154.6074334726234;874.3267683883374;880.7665968518347;880.7665968518347;891.7547674389594;910.0626354854378;5215.921761173586;5295.655782374133;5530.695811730313;5582.385937546866;5597.3003374578175;409.37774582634825;426.22639908565856;435.64059650787596;438.4125272135354;441.3225698552706;3578.7494875359;3618.3125206210734;3788.6021967693546;3861.555921069113;3902.434147048662;9868.457234852009;10194.796104077877;10320.690379288633;10326.122279606167;10352.948235258775;9489.572969216402;10203.795924081476;10206.285560010876;10261.230407719451;10294.433806140734;6699.430548403343;7622.085349757954;7739.92260077392;7817.179196184433;7879.290863822283;4761.738104404152;5594.1608758686525;5619.409961953936;5791.623544469596;5802.622829516068;9237.07629237071;9309.487978161265;9397.624095036395;9399.295052871199;9448.055194480497;9457.574409151743;9607.759806004906;9624.230061594915;9644.132028117503;9673.613055477703;7124.8218794528475;7195.676194571152;7270.9636451817405;7290.015847860471;7292.817679558054;7730.188330225245;7918.841623167619;7929.682812687428;7943.920560794318;7949.761507154794;6993.230744618189;7118.216996130318;7127.964360178166;7162.283771622796;7266.2007179211305;5918.437748413894;6415.294317625151;6646.169228846395;7034.191068027242;7040.0847889774;6289.465395441439;6509.641969691713;6545.14913061299;6545.509086818603;6616.768413105518;4769.236922092448;4778.928316075331;4825.276208568743;4839.806407743792;4904.994476132313;4809.591184749335;4844.563989240985;4886.462489126122;4942.332785073969;4956.529129732669 03:15:20 INFO - PROCESS | 1645 | |4;prototype.html;284.2169822140004;295.3826502609546;299.9100269919022;303.5871215147399;311.962564492261;4632.652551058672;4764.857054288368;5180.6632568883;5238.607104467161;5298.052950551844;3717.442383642448;4858.781354839032;5103.464136265694;5148.150555158394;5175;3246.2371342734436;3864.956461755324;3961.6632586230203;3972.880813575597;3973.781442020688;3785.791781452019;3936.881893543184;3950.802459877009;3973.5231772187376;3976.622220889011;3243.51347297906;3922.4508568800393;3930.9189972757435;3932.941005884914;3937.7243592948507;3064.8966372106024;3207;3727.422249551324;3910.393888947218;3932.0563064864514;2804.9298767530977;3167.0498850345034;3419.5725534308212;3425.9828700856588;3436.639152888961;4225.72532785371;4699.295105734133;4826.745046287955;5039.647224694273;5043.36957880265;4450.554944505556;4454.665900057508;4463.531329210418;4475.888102797424;4486.7980940857415;4950.381202349707;5134;5416.566674666017;5417.51242388187;5437.809676661298;3339.2486690494443;3492.3539145257955;3523.365794157051;3740.1584643455276;3746.2882052409955;4956.653034287638;5723.397448714367;5732.9140062899505;5735.598508104435;5826.1552074948895;3612.277544491112;3808.542974842981;3812.3328417526823;3816.44661524083;3820.6436714966344;3858.5176852893387;3868.6905047596124;3871.8644847430205;3883;3884.533855937306;3496.3182179474757;4186.434831297735;4486.820527178941;4489.595936365743;4494.77526123699;5443.374011988592;5480.588955828329;5501.807436739695;5503.394626591072;5553.305836770403;1033.4161198922584;1106.1316866259947;1155.1682788392345;1237.808139738324;1253.893419059372;739.6782399656059;832.2967092806568;835.8829763833069;853.8463076646264;857.8976015819642;4298.46269216348;4357.4988876279;4863.367762190964;4866.343043689128;4884.413870335582;4541.68208225421;5318.282031925718;5319.946800532022;5341.839744807662;5425.620206585501;3992.441058251847;4169.97915010423;4880.267959806058;4892.779824907888;4914.262860570871;2397.7292035221362;2566.820322577402;2678.986605066962;2847.345110624568;2848.9430211395656;5055.887704704959;5099.654159086787;5462.20797984298;5510.669359838423;5671;4617.8152873884665;4629.490756016836;4949.777260023236;5420.864478387993;5795.059359635488;5089.745512724349;5350.91973620396;5405.729713514309;5935.940640593539;5952.255968004086;5730.742116604846;5736.4550367715;5743.971280143573;5744.772257245886;5751.511121554715;4634.443866735878;4902.671231165168;5492.835214943558;5543.417941116125;5670.383940576916;5824.534037276923;5887.558433117619;5899.286328289035;5904.202932604044;5925.644461332334;3471.4098603238017;3473.89578312651;3801.5248093988253;3828.5788563258575;3843.1160833008007;4965.329680493087;5294.311739473844;5654.547636189177;5663.2071509989455;5692.658440493584;5094.796208151781;5500.339959204761;5522.337319521683;5532.806351777668;5571.498565128995;4382.496012958551;5026.974865125651;5311.466895718366;5473.781048758005;5516.61383703153;4379.810094952523;5358.651687640291;5387.272718182995;5402.702851343057;5411.918821217606;4877.609791216623;5485.945140548543;5494.917576236279;5525.613207075467;5526.557875370041;4138.52406973202;4756.500567440369;4902.313676085422;5075.949240507695;5203.661761985459 03:15:20 INFO - PROCESS | 1645 | |5;yui.html;668.221521926955;725.9128904531457;780.7579650308405;794.630496818979;796.1998191817223;13999.370028348723;14636.634084147901;14683.926580367097;14685.04547204431;14699.632509187275;12736.108472406911;12942.28817415044;13179.143355681874;13448.596542103727;13474.865251347484;649.113959445356;807.0839597057338;819.213554987213;821.3921697943539;822.8272062866805;663.3631713554993;674.608726938377;811.9391045671568;822.8313195794848;836.6736972580699;872.4634349874844;873.5326600268858;874.9981271444193;875.1161327059684;875.9969834539448;867.8437881181385;869.148234729965;869.3566760597113;870.7561882672861;872.821071680304;500.5195012787728;501.0930216308493;517.9585633149377;518.65768592729;519.584332533975;13738;14202.857971420257;14239;14591.270436478133;14599.270036498132;13375.799363009563;13669.521566745116;13799.2410417427;13868.306584670727;13875.583732488041;10760.515776790064;10894.836577451344;10954.616588419367;10963.122950164048;11035.668929932115;3514.3147086318177;3563.6970857477145;3601.001444198469;3707.0361705956375;3771.340015497277;86452;87333.56333218356;87367.56316218378;87445;87532;10340.638077667396;10378.481075946172;10790.892091079146;10841.295315804447;10859.511321990529;20965.895170524356;21091.050902709107;21265.78734212669;21275.787242127382;21546.461338466663;7464.813379665552;7621.31408173267;7626.69493220276;7664.425168112414;7830.41271904598;4115.7851644017155;4144.109016561454;4362.607365337135;4374;4399.670024748157;3376.510405991167;3471.9132021699156;3493.161641206143;3500.789952602852;3500.842462089161;619.9956071164652;630.4830039367674;635.8187916443884;644.7259914536303;663.9203295604461;511.6086194061546;633.5944995203074;649.233903993283;668.1481408159295;682.952193346461;8689.609662453977;8709.520976346235;8823.661639750375;8992.505412202392;9055.68305109318;610.2646311194999;629.7782302333459;660.6432526435767;663.1696517611427;664.2792570061538;4191.455110835572;4548.931766023512;4617.284320930261;4659.254519276968;4711.575958163782;59533.702331488064;100148.49925750325;107829.46085269524;117183;123953.76046239602;101121;101172.49413753032;106205.46897265465;108545.45727271472;109042;89636.5518172405;91359.54320228622;93227.53386233025;93883.53058234528;94094;8986.460812351019;9009.324300677607;9080.364374493722;9105;9175;36207.818960905024;54921.45078549163;55724.16413753716;58074.12888806756;58359.70820145872;80661.59669201616;81365;83094.58452707698;86767.49243806866;88031.55984220038;9427.387219830689;11717.648470545897;11821.881781182423;12085.879141208827;12140.271583705005;13544.79682804739;13947.58157255284;14373.856261437251;14513.129212247299;14559.563213103624;12566.37168141571;12625.936870315589;12673.049521285757;12868.806967895302;13369.131006484547;12299.508019679113;12375.876241237473;12713.046521511109;12766;12882.904953079093;12067.69830754203;12318.938405307916;12557.497700091893;13062.54281100157;13124.14693044949;9100.31747618918;10166.288359814742;10526.894731052898;10726.302790318605;10802.189835762192;10455.94772026135;10946.835797462885;11094.889051109385;11234.662960111209;11283 03:15:20 INFO - PROCESS | 1645 | __end_tp_report 03:15:20 INFO - PROCESS | 1645 | __start_cc_report 03:15:20 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1711 03:15:20 INFO - PROCESS | 1645 | __end_cc_report 03:15:20 INFO - PROCESS | 1645 | __startTimestamp1480072520001__endTimestamp 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | ------- Summary: start ------- 03:15:20 INFO - PROCESS | 1645 | Number of tests: 6 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5763.27 Median:5920.17 stddev:647.57 (10.9%) stddev-sans-first:618.66 03:15:20 INFO - PROCESS | 1645 | Values: 3243.5 3251.9 3322.5 3349.2 3367.1 5711.1 5742.9 5746.3 5759.0 5813.3 5691.8 5765.1 5773.9 5824.4 5824.9 5216.5 5216.8 5247.6 5286.4 5289.2 5191.7 5213.4 5227.7 5326.2 5342.6 5222.4 5259.2 5266.7 5273.9 5293.7 5273.8 5322.6 5332.6 5333.0 5339.1 5117.6 5256.6 5263.8 5287.7 5300.5 5610.4 5611.7 5639.8 5648.7 5693.5 6164.4 6201.4 6209.7 6244.0 6296.4 6286.7 6288.5 6334.6 6336.2 6353.5 5649.2 5699.0 5771.2 5801.5 5855.4 6283.7 6312.0 6324.5 6325.9 6335.0 6169.9 6170.0 6175.9 6177.6 6189.8 6144.1 6158.4 6214.7 6235.3 6289.2 5239.0 6198.2 6283.9 6286.7 6295.1 6242.3 6275.2 6289.1 6319.5 6326.4 4763.6 4878.4 4942.6 4962.4 4989.5 4396.3 4402.5 4405.9 4408.3 4500.9 5806.4 5811.6 5817.6 5831.6 5841.0 6298.0 6329.1 6344.2 6367.0 6400.1 5574.3 5677.6 5701.1 5756.9 5809.4 5409.7 5420.8 5429.3 5433.8 5438.5 5988.3 6302.3 6326.9 6339.1 6349.0 6032.3 6120.2 6238.4 6281.3 6320.1 6237.9 6307.5 6329.0 6335.3 6348.0 6238.1 6265.6 6277.0 6294.8 6298.6 6139.8 6209.0 6269.7 6303.0 6311.3 5976.3 6092.6 6108.1 6115.7 6187.9 6138.7 6146.9 6158.3 6183.0 6204.6 5789.2 5920.2 6001.8 6008.4 6099.3 5984.3 6072.0 6092.2 6110.2 6158.9 5741.4 5762.7 5790.2 5816.5 5823.8 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:70650.64 Median:21104.07 stddev:162749.81 (771.2%) stddev-sans-first:163121.18 03:15:20 INFO - PROCESS | 1645 | Values: 515.5 525.5 527.4 546.0 551.9 32465.5 39393.8 39467.4 39496.6 39512.8 40451.6 40628.0 40659.8 40676.6 40710.4 9205.2 9373.0 9382.1 9393.1 9397.3 9304.2 9414.6 9416.7 9420.3 9429.3 9387.2 9443.7 9454.8 9497.4 9506.3 9377.1 9438.6 9442.0 9448.7 9469.9 9172.7 9259.0 9260.5 9275.7 9276.7 38945.2 39281.4 39282.0 39282.0 39334.6 2878.4 3199.8 3258.8 3498.7 3887.9 28181.0 28717.4 29507.3 29823.7 30576.5 3093.5 3106.8 3150.5 3170.0 3176.2 459460.0 462251.0 466034.0 466249.3 466295.0 30555.8 59442.0 59960.4 60035.7 60102.7 28074.7 33825.0 34015.1 34061.1 34139.7 11631.7 14246.5 14249.1 14271.8 14282.7 12061.4 12129.9 12146.6 12161.3 12180.1 6811.8 7221.2 7617.9 7681.6 7691.7 3174.6 3232.8 3234.4 3234.4 3268.6 932.7 957.2 1011.9 1014.5 1022.1 24862.8 27880.2 29179.3 29618.4 29655.7 875.5 880.0 882.3 1068.9 1122.0 14954.0 15024.5 15158.8 15300.8 15326.2 675065.0 681107.0 681417.0 683055.0 683407.0 49286.0 55400.4 55868.4 55983.4 56043.4 1251.0 1337.0 1349.5 1382.7 1383.7 28957.9 29382.6 29630.0 30098.2 30218.0 48078.0 48588.8 48676.3 48680.0 48736.3 544771.0 549920.0 695329.8 716335.0 717780.0 37991.8 38017.0 38162.6 38275.4 38320.2 43167.4 43648.0 43887.8 44028.9 44306.0 36202.6 36843.6 36852.6 37086.1 38125.4 36883.6 36942.4 36987.6 37103.4 37236.6 34638.0 35121.8 35999.1 36985.6 37160.6 32153.5 32493.7 33084.5 33126.5 33298.7 24661.0 24765.0 24982.0 25151.6 25220.7 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35721.25 Median:1579.18 stddev:104394.11 (6610.7%) stddev-sans-first:104653.07 03:15:20 INFO - PROCESS | 1645 | Values: 295.6 347.9 370.4 370.8 399.7 14719.2 15238.6 16060.7 18690.8 20371.0 19458.0 19657.3 20009.3 20139.6 20368.4 5615.6 5707.8 5838.5 5890.2 5904.4 5473.0 5785.8 5790.4 5796.7 5800.7 5768.3 5823.9 5830.7 5836.4 5846.0 5581.5 5785.7 5807.6 5856.6 5871.1 5665.7 5666.6 5667.1 5685.1 5689.1 22711.0 22789.2 23570.9 23646.1 23781.0 2026.2 2082.2 2206.0 2319.7 2862.8 8305.0 9586.8 9654.6 14460.3 15312.6 1794.9 1809.4 1829.6 1847.7 1882.7 111430.0 117778.0 119666.4 121557.4 122595.2 10942.5 11506.4 11534.3 11755.4 11910.9 12649.1 13186.3 13219.7 13369.3 14078.9 8235.8 8302.8 8364.4 8485.2 8518.7 7072.5 8215.5 8222.2 8464.6 8477.2 4115.7 4140.4 4418.2 4507.8 4595.0 1866.6 1905.4 1929.5 1943.1 1957.1 806.6 890.8 934.4 984.8 1025.9 19842.7 20552.0 20678.8 20735.3 21008.3 885.3 906.2 921.4 938.3 952.2 8690.7 9373.7 9989.5 10703.4 10937.2 615341.0 619027.0 623100.0 634679.0 636193.0 120374.0 128522.0 129340.0 138066.3 144235.0 767.5 978.4 1003.4 1005.4 1006.3 14961.2 18632.3 18946.2 19110.9 19128.2 53783.0 53871.0 55082.0 56694.4 57102.0 77357.6 78980.0 79275.6 79594.2 81042.6 7872.0 7962.4 7986.4 8232.9 8247.1 11812.8 12360.4 12572.5 12635.5 12879.0 10609.7 10720.8 10740.9 11210.2 11232.8 10557.4 10621.7 10653.3 10724.4 10766.4 10856.3 10961.0 10974.3 11071.3 11157.8 6861.3 7825.9 7930.8 8280.3 8338.0 8853.0 9055.8 10627.1 10750.8 11048.2 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5351.95 Median:4891.13 stddev:2983.72 (61.0%) stddev-sans-first:2976.30 03:15:20 INFO - PROCESS | 1645 | Values: 1267.2 1469.9 1497.8 1651.8 1826.0 7456.7 7853.0 7855.9 7863.2 7863.3 7697.3 8122.7 8224.0 8250.8 8367.4 2287.0 2323.6 2324.6 2325.0 2327.2 2007.8 2219.8 2288.4 2328.7 2341.3 2258.1 2263.2 2292.2 2304.7 2313.8 2059.3 2144.7 2254.3 2264.5 2287.4 2291.0 2312.0 2315.8 2316.5 2316.6 8257.1 8321.3 8410.4 8415.3 8422.3 4895.8 4954.4 5062.0 5082.3 5155.1 3355.6 3493.2 3578.7 3586.9 3587.5 1045.8 1071.7 1085.1 1097.2 1100.9 10802.7 10813.5 10930.5 10933.9 10948.7 4234.1 4307.3 4372.0 4429.2 4436.9 7794.7 8493.7 8562.5 8709.3 8722.7 5071.4 5072.3 5076.1 5078.0 5087.9 4002.6 4210.8 4333.9 4384.3 4776.2 3613.4 3636.9 3713.5 3715.2 3719.3 1129.5 1139.0 1144.3 1148.6 1154.6 874.3 880.8 880.8 891.8 910.1 5215.9 5295.7 5530.7 5582.4 5597.3 409.4 426.2 435.6 438.4 441.3 3578.7 3618.3 3788.6 3861.6 3902.4 9868.5 10194.8 10320.7 10326.1 10352.9 9489.6 10203.8 10206.3 10261.2 10294.4 6699.4 7622.1 7739.9 7817.2 7879.3 4761.7 5594.2 5619.4 5791.6 5802.6 9237.1 9309.5 9397.6 9399.3 9448.1 9457.6 9607.8 9624.2 9644.1 9673.6 7124.8 7195.7 7271.0 7290.0 7292.8 7730.2 7918.8 7929.7 7943.9 7949.8 6993.2 7118.2 7128.0 7162.3 7266.2 5918.4 6415.3 6646.2 7034.2 7040.1 6289.5 6509.6 6545.1 6545.5 6616.8 4769.2 4778.9 4825.3 4839.8 4905.0 4809.6 4844.6 4886.5 4942.3 4956.5 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4348.52 Median:4871.98 stddev:1371.98 (28.2%) stddev-sans-first:1341.49 03:15:20 INFO - PROCESS | 1645 | Values: 284.2 295.4 299.9 303.6 312.0 4632.7 4764.9 5180.7 5238.6 5298.1 3717.4 4858.8 5103.5 5148.2 5175.0 3246.2 3865.0 3961.7 3972.9 3973.8 3785.8 3936.9 3950.8 3973.5 3976.6 3243.5 3922.5 3930.9 3932.9 3937.7 3064.9 3207.0 3727.4 3910.4 3932.1 2804.9 3167.0 3419.6 3426.0 3436.6 4225.7 4699.3 4826.7 5039.6 5043.4 4450.6 4454.7 4463.5 4475.9 4486.8 4950.4 5134.0 5416.6 5417.5 5437.8 3339.2 3492.4 3523.4 3740.2 3746.3 4956.7 5723.4 5732.9 5735.6 5826.2 3612.3 3808.5 3812.3 3816.4 3820.6 3858.5 3868.7 3871.9 3883.0 3884.5 3496.3 4186.4 4486.8 4489.6 4494.8 5443.4 5480.6 5501.8 5503.4 5553.3 1033.4 1106.1 1155.2 1237.8 1253.9 739.7 832.3 835.9 853.8 857.9 4298.5 4357.5 4863.4 4866.3 4884.4 4541.7 5318.3 5319.9 5341.8 5425.6 3992.4 4170.0 4880.3 4892.8 4914.3 2397.7 2566.8 2679.0 2847.3 2848.9 5055.9 5099.7 5462.2 5510.7 5671.0 4617.8 4629.5 4949.8 5420.9 5795.1 5089.7 5350.9 5405.7 5935.9 5952.3 5730.7 5736.5 5744.0 5744.8 5751.5 4634.4 4902.7 5492.8 5543.4 5670.4 5824.5 5887.6 5899.3 5904.2 5925.6 3471.4 3473.9 3801.5 3828.6 3843.1 4965.3 5294.3 5654.5 5663.2 5692.7 5094.8 5500.3 5522.3 5532.8 5571.5 4382.5 5027.0 5311.5 5473.8 5516.6 4379.8 5358.7 5387.3 5402.7 5411.9 4877.6 5485.9 5494.9 5525.6 5526.6 4138.5 4756.5 4902.3 5075.9 5203.7 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20962.37 Median:4277.03 stddev:31256.37 (730.8%) stddev-sans-first:31306.90 03:15:20 INFO - PROCESS | 1645 | Values: 668.2 725.9 780.8 794.6 796.2 13999.4 14636.6 14683.9 14685.0 14699.6 12736.1 12942.3 13179.1 13448.6 13474.9 649.1 807.1 819.2 821.4 822.8 663.4 674.6 811.9 822.8 836.7 872.5 873.5 875.0 875.1 876.0 867.8 869.1 869.4 870.8 872.8 500.5 501.1 518.0 518.7 519.6 13738.0 14202.9 14239.0 14591.3 14599.3 13375.8 13669.5 13799.2 13868.3 13875.6 10760.5 10894.8 10954.6 10963.1 11035.7 3514.3 3563.7 3601.0 3707.0 3771.3 86452.0 87333.6 87367.6 87445.0 87532.0 10340.6 10378.5 10790.9 10841.3 10859.5 20965.9 21091.1 21265.8 21275.8 21546.5 7464.8 7621.3 7626.7 7664.4 7830.4 4115.8 4144.1 4362.6 4374.0 4399.7 3376.5 3471.9 3493.2 3500.8 3500.8 620.0 630.5 635.8 644.7 663.9 511.6 633.6 649.2 668.1 683.0 8689.6 8709.5 8823.7 8992.5 9055.7 610.3 629.8 660.6 663.2 664.3 4191.5 4548.9 4617.3 4659.3 4711.6 59533.7 100148.5 107829.5 117183.0 123953.8 101121.0 101172.5 106205.5 108545.5 109042.0 89636.6 91359.5 93227.5 93883.5 94094.0 8986.5 9009.3 9080.4 9105.0 9175.0 36207.8 54921.5 55724.2 58074.1 58359.7 80661.6 81365.0 83094.6 86767.5 88031.6 9427.4 11717.6 11821.9 12085.9 12140.3 13544.8 13947.6 14373.9 14513.1 14559.6 12566.4 12625.9 12673.0 12868.8 13369.1 12299.5 12375.9 12713.0 12766.0 12882.9 12067.7 12318.9 12557.5 13062.5 13124.1 9100.3 10166.3 10526.9 10726.3 10802.2 10455.9 10946.8 11094.9 11234.7 11283.0 03:15:20 INFO - PROCESS | 1645 | -------- Summary: end -------- 03:15:20 INFO - PROCESS | 1645 | 03:15:20 INFO - TEST-INFO | 1645: exit 0 03:15:20 INFO - TEST-OK | dromaeo_css | took 1119342ms 03:15:20 INFO - TEST-START | kraken 03:15:20 INFO - operating with platform_type : mac_ 03:15:20 INFO - Initialising browser for kraken test... 03:15:20 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpAAe8vP/profile http://localhost:49240/getInfo.html) 03:15:23 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 03:15:23 INFO - PROCESS | 1650 | colorDepth:24 03:15:23 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 03:15:23 INFO - PROCESS | 1650 | __metrics 03:15:23 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:15:23 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:15:24 INFO - TEST-INFO | 1650: exit 0 03:15:24 INFO - Browser initialized. 03:15:24 INFO - Running cycle 1/1 for kraken test... 03:15:24 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpAAe8vP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:36 INFO - PROCESS | 1651 | RSS: Main: 223068160 03:15:36 INFO - PROCESS | 1651 | 03:15:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:40 INFO - PROCESS | 1651 | RSS: Main: 272609280 03:15:40 INFO - PROCESS | 1651 | 03:15:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 03:15:43 INFO - PROCESS | 1651 | RSS: Main: 284061696 03:15:43 INFO - PROCESS | 1651 | 03:15:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 03:15:47 INFO - PROCESS | 1651 | RSS: Main: 380940288 03:15:47 INFO - PROCESS | 1651 | 03:15:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 03:15:50 INFO - PROCESS | 1651 | RSS: Main: 282742784 03:15:50 INFO - PROCESS | 1651 | 03:15:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:52 INFO - PROCESS | 1651 | RSS: Main: 283705344 03:15:52 INFO - PROCESS | 1651 | 03:15:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:56 INFO - PROCESS | 1651 | RSS: Main: 327065600 03:15:56 INFO - PROCESS | 1651 | 03:15:58 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 03:15:59 INFO - PROCESS | 1651 | RSS: Main: 325292032 03:15:59 INFO - PROCESS | 1651 | 03:16:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 03:16:03 INFO - PROCESS | 1651 | RSS: Main: 322658304 03:16:03 INFO - PROCESS | 1651 | 03:16:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:05 INFO - PROCESS | 1651 | RSS: Main: 301936640 03:16:05 INFO - PROCESS | 1651 | 03:16:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:07 INFO - PROCESS | 1651 | RSS: Main: 303558656 03:16:07 INFO - PROCESS | 1651 | 03:16:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:10 INFO - PROCESS | 1651 | RSS: Main: 305205248 03:16:10 INFO - PROCESS | 1651 | 03:16:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:14 INFO - PROCESS | 1651 | RSS: Main: 313057280 03:16:14 INFO - PROCESS | 1651 | 03:16:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:17 INFO - PROCESS | 1651 | RSS: Main: 313282560 03:16:17 INFO - PROCESS | 1651 | 03:16:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 03:16:20 INFO - PROCESS | 1651 | RSS: Main: 356909056 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | __start_tp_report 03:16:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 03:16:20 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 03:16:20 INFO - PROCESS | 1651 | |i|pagename|runs| 03:16:20 INFO - PROCESS | 1651 | |0;ai-astar;115;114;114;113;113;114;113;114;113;114 03:16:20 INFO - PROCESS | 1651 | |1;audio-beat-detection;175;141;141;156;111;113;114;116;143;120 03:16:20 INFO - PROCESS | 1651 | |2;audio-dft;186;183;182;189;181;182;181;181;182;182 03:16:20 INFO - PROCESS | 1651 | |3;audio-fft;82;60;60;88;60;58;59;61;84;61 03:16:20 INFO - PROCESS | 1651 | |4;audio-oscillator;89;70;94;70;67;68;90;67;68;91 03:16:20 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;86;84;86;86;92;84;90;84;90;84 03:16:20 INFO - PROCESS | 1651 | |6;imaging-darkroom;95;95;95;95;95;96;95;95;96;95 03:16:20 INFO - PROCESS | 1651 | |7;imaging-desaturate;83;81;80;82;80;85;99;138;130;83 03:16:20 INFO - PROCESS | 1651 | |8;json-parse-financial;56;55;57;56;58;58;58;58;58;58 03:16:20 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;65;72;69;82;74;72;70;70;70;71 03:16:20 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;86;84;84;84;86;85;83;83;82;84 03:16:20 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;149;146;147;149;148;150;148;153;217;170 03:16:20 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;169;168;174;169;190;230;235;177;168;168 03:16:20 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;68;74;89;87;87;75;66;66;66 03:16:20 INFO - PROCESS | 1651 | __end_tp_report 03:16:20 INFO - PROCESS | 1651 | __start_cc_report 03:16:20 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2031 03:16:20 INFO - PROCESS | 1651 | __end_cc_report 03:16:20 INFO - PROCESS | 1651 | __startTimestamp1480072580001__endTimestamp 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | ------- Summary: start ------- 03:16:20 INFO - PROCESS | 1651 | Number of tests: 14 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 03:16:20 INFO - PROCESS | 1651 | Values: 115.0 114.0 114.0 113.0 113.0 114.0 113.0 114.0 113.0 114.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:141.00 stddev:21.66 (15.4%) stddev-sans-first:16.82 03:16:20 INFO - PROCESS | 1651 | Values: 175.0 141.0 141.0 156.0 111.0 113.0 114.0 116.0 143.0 120.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:182.90 Median:182.00 stddev:2.60 (1.4%) stddev-sans-first:2.51 03:16:20 INFO - PROCESS | 1651 | Values: 186.0 183.0 182.0 189.0 181.0 182.0 181.0 181.0 182.0 182.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.00 stddev:12.10 (19.8%) stddev-sans-first:11.61 03:16:20 INFO - PROCESS | 1651 | Values: 82.0 60.0 60.0 88.0 60.0 58.0 59.0 61.0 84.0 61.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.50 stddev:11.82 (14.9%) stddev-sans-first:11.76 03:16:20 INFO - PROCESS | 1651 | Values: 89.0 70.0 94.0 70.0 67.0 68.0 90.0 67.0 68.0 91.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:86.00 stddev:2.99 (3.5%) stddev-sans-first:3.16 03:16:20 INFO - PROCESS | 1651 | Values: 86.0 84.0 86.0 86.0 92.0 84.0 90.0 84.0 90.0 84.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:16:20 INFO - PROCESS | 1651 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:82.50 stddev:21.82 (26.4%) stddev-sans-first:22.77 03:16:20 INFO - PROCESS | 1651 | Values: 83.0 81.0 80.0 82.0 80.0 85.0 99.0 138.0 130.0 83.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.14 (2.0%) stddev-sans-first:1.12 03:16:20 INFO - PROCESS | 1651 | Values: 56.0 55.0 57.0 56.0 58.0 58.0 58.0 58.0 58.0 58.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:4.38 (6.1%) stddev-sans-first:3.96 03:16:20 INFO - PROCESS | 1651 | Values: 65.0 72.0 69.0 82.0 74.0 72.0 70.0 70.0 70.0 71.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.17 03:16:20 INFO - PROCESS | 1651 | Values: 86.0 84.0 84.0 84.0 86.0 85.0 83.0 83.0 82.0 84.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:157.70 Median:149.50 stddev:21.96 (14.7%) stddev-sans-first:23.07 03:16:20 INFO - PROCESS | 1651 | Values: 149.0 146.0 147.0 149.0 148.0 150.0 148.0 153.0 217.0 170.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:175.50 stddev:26.06 (14.9%) stddev-sans-first:27.01 03:16:20 INFO - PROCESS | 1651 | Values: 169.0 168.0 174.0 169.0 190.0 230.0 235.0 177.0 168.0 168.0 03:16:20 INFO - PROCESS | 1651 | 03:16:20 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.50 stddev:9.95 (13.4%) stddev-sans-first:9.85 03:16:20 INFO - PROCESS | 1651 | Values: 64.0 68.0 74.0 89.0 87.0 87.0 75.0 66.0 66.0 66.0 03:16:20 INFO - PROCESS | 1651 | -------- Summary: end -------- 03:16:20 INFO - PROCESS | 1651 | 03:16:21 INFO - TEST-INFO | 1651: exit 0 03:16:21 INFO - TEST-OK | kraken | took 60446ms 03:16:21 INFO - SUITE-END | took 1179s 03:16:21 INFO - Completed test suite (00:19:39) 03:16:21 INFO - javascript benchmark 03:16:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3243.50798632629, 3251.8536665850033, 3322.468405055191, 3349.1961929137005, 3367.1077164551384, 5711.057675483546, 5742.856428589283, 5746.310442746866, 5759.020966435705, 5813.30240371156, 5691.8292451226525, 5765.106408506688, 5773.884522309551, 5824.388439213874, 5824.854378640536, 5216.504432078947, 5216.791328346881, 5247.606429517782, 5286.392064912527, 5289.180177072541, 5191.688498690071, 5213.426523082458, 5227.73861306935, 5326.227696983935, 5342.572594192456, 5222.4255331913455, 5259.211118332242, 5266.710330931797, 5273.920891186616, 5293.655912365684, 5273.841784746463, 5322.627416080837, 5332.626716129873, 5333.040052790496, 5339.065663508871, 5117.590592752571, 5256.632035757499, 5263.763130659129, 5287.68273903567, 5300.469953004668, 5610.382857885629, 5611.7474713637985, 5639.802606908738, 5648.717564121777, 5693.544516438675, 6164.383561643845, 6201.441870231656, 6209.689515524251, 6244.0, 6296.433321001086, 6286.717097730568, 6288.496920246369, 6334.556581039329, 6336.17629708135, 6353.459955903753, 5649.237352957381, 5699.031164702011, 5771.220885180447, 5801.506871915934, 5855.385184555603, 6283.654399008007, 6312.0, 6324.462420694293, 6325.9051114233325, 6335.0, 6169.876602467925, 6169.981952977709, 6175.876482470326, 6177.62934223939, 6189.783357582553, 6144.126041557279, 6158.414950579688, 6214.689265536705, 6235.282942461675, 6289.24529056507, 5239.0, 6198.163247961557, 6283.937160628427, 6286.748530058747, 6295.118683384329, 6242.282137554149, 6275.152854364694, 6289.056641503811, 6319.46284565817, 6326.367363263729, 4763.642726795504, 4878.36581244443, 4942.555170034714, 4962.404511458648, 4989.451160372356, 4396.252637051709, 4402.493713222956, 4405.867823965286, 4408.338749187647, 4500.909981800346, 5806.44838740319, 5811.622244554091, 5817.563682723812, 5831.620944638585, 5840.970795146082, 6298.0, 6329.145565348619, 6344.238691356974, 6366.968165159237, 6400.0719895614875, 5574.303212098488, 5677.574181936288, 5701.059325211377, 5756.913646295309, 5809.448102430262, 5409.702466364388, 5420.810271640474, 5429.267048948342, 5433.782648694087, 5438.510534051954, 5988.311344195299, 6302.306746257908, 6326.8734625306315, 6339.080833279241, 6349.015902535114, 6032.306284777132, 6120.17377654011, 6238.438540531374, 6281.309056003744, 6320.115183874169, 6237.8752424950335, 6307.526935479949, 6328.968355158195, 6335.271443784024, 6348.0, 6238.064290356301, 6265.561410701207, 6277.027060805583, 6294.8111556653375, 6298.559100862895, 6139.829471381233, 6208.9689551551955, 6269.749210031548, 6303.023031430135, 6311.305756366888, 5976.342602313655, 6092.6039807414145, 6108.08378743192, 6115.724792384264, 6187.876242475035, 6138.739088650262, 6146.907796383147, 6158.291796443466, 6183.0, 6204.565680402328, 5789.2184555086205, 5920.171176035273, 6001.849953751192, 6008.399160083956, 6099.268087829489, 5984.281886173513, 6071.9981203101, 6092.208012958287, 6110.16388879229, 6158.907616385847, 5741.3971532988435, 5762.654240745569, 5790.1893734877995, 5816.47651711348, 5823.79616713413], "value": 5720.451931897192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.5385929593015, 525.4928993521252, 527.3961314295135, 546.022619511075, 551.8675517875708, 32465.51301730473, 39393.80303098484, 39467.407988880186, 39496.60503394969, 39512.80243598778, 40451.595484045225, 40628.0, 40659.79670101653, 40676.59323406765, 40710.38934415979, 9205.171534561889, 9372.953135234315, 9382.108699673554, 9393.06069393062, 9397.342186046979, 9304.209142222919, 9414.576344064499, 9416.717498475056, 9420.293477989144, 9429.292803039765, 9387.155156035955, 9443.716688499357, 9454.810903781954, 9497.382670126453, 9506.334556581041, 9377.062293770636, 9438.622455101788, 9442.0, 9448.669296574586, 9469.905300946972, 9172.6789562365, 9258.953705231497, 9260.490673012982, 9275.72172834816, 9276.675316363895, 38945.221095578214, 39281.41077883834, 39282.0, 39282.0, 39334.60665393367, 2878.401997503121, 3199.840007999591, 3258.7881787683964, 3498.6501349865066, 3887.9028024299337, 28181.0, 28717.425651486854, 29507.262318441997, 29823.65793539274, 30576.54135187974, 3093.489574220251, 3106.8135911845134, 3150.4959206526846, 3169.9683003169903, 3176.190071531768, 459460.0, 462251.0, 466033.9999999966, 466249.337506624, 466295.0, 30555.847220763753, 59442.0, 59960.40039599635, 60035.69982150149, 60102.699486502286, 28074.71925280762, 33824.98525044253, 34015.14962125967, 34061.14847128792, 34139.658603414144, 11631.65105046833, 14246.501372452121, 14249.073810202304, 14271.78592321116, 14282.714345713028, 12061.396930153458, 12129.939350303192, 12146.574869879512, 12161.270323780602, 12180.086493513021, 6811.795646130624, 7221.241769614115, 7617.923820761722, 7681.577513236825, 7691.653875575501, 3174.555562221291, 3232.8060316381093, 3234.4016356974034, 3234.4178047951596, 3268.591426071741, 932.7388331267256, 957.2055194188806, 1011.8785745710414, 1014.5282443663584, 1022.0852337158202, 24862.751372486044, 27880.16359509218, 29179.270518237216, 29618.407631847243, 29655.703442965296, 875.5410018534433, 879.9648014079493, 882.289756745813, 1068.9465526723632, 1121.966341009771, 14954.0, 15024.474143405147, 15158.772618410732, 15300.770488442682, 15326.23368831554, 675065.0, 681107.0, 681417.0, 683055.0, 683407.0, 49286.0, 55400.44599553953, 55868.44131558632, 55983.44016559782, 56043.439565603825, 1250.9624711258678, 1336.993315033438, 1349.50742978814, 1382.6819831438625, 1383.7301726163503, 28957.85521072381, 29382.559261610666, 29630.0, 30098.24754381158, 30218.0, 48078.0, 48588.75705621449, 48676.269855952894, 48680.0, 48736.26895596498, 544771.0, 549920.0, 695329.7568633774, 716335.0, 717780.0, 37991.81004094962, 38017.0, 38162.618373817015, 38275.42586861143, 38320.23359532849, 43167.35248971205, 43648.0, 43887.78056109827, 44028.89927751832, 44306.0, 36202.63797362098, 36843.63156368402, 36852.63147368492, 37086.07284817793, 38125.4281185788, 36883.63116368802, 36942.44586331261, 36987.63012369949, 37103.44344834776, 37236.627633723314, 34637.96086117421, 35121.8243908789, 35999.100022499646, 36985.63014369822, 37160.6283937168, 32153.517697235027, 32493.67506325001, 33084.503732443554, 33126.503102453964, 33298.667013329556, 24661.0, 24765.0, 24982.0, 25151.622725658763, 25220.74779252184], "value": 18340.06202631546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5728971635986, 347.8712876235793, 370.43323714716485, 370.7608592457865, 399.70421887803036, 14719.190444525548, 15238.619034524143, 16060.67878642428, 18690.813091869077, 20371.0, 19458.0, 19657.31199408021, 20009.299674511396, 20139.59720805583, 20368.388948331536, 5615.606907516475, 5707.828765137053, 5838.532917366621, 5890.175375447441, 5904.439078287577, 5473.0, 5785.797497087603, 5790.36306006339, 5796.652200867961, 5800.680962547058, 5768.307803063638, 5823.854403639901, 5830.650160990333, 5836.445537673935, 5845.970770146143, 5581.525570326507, 5785.652860828342, 5807.593468457209, 5856.648601083906, 5871.060630299132, 5665.745041473144, 5666.631668941547, 5667.121596152603, 5685.147227915804, 5689.061304884689, 22711.0, 22789.20237791686, 23570.882145589163, 23646.054157833667, 23781.0, 2026.2199053364413, 2082.1983536338466, 2205.9669104963436, 2319.652052192168, 2862.7852911031546, 8304.958475207586, 9586.76033099171, 9654.613815447374, 14460.276986150651, 15312.617184570476, 1794.9102544872703, 1809.3938530592268, 1829.6432195721839, 1847.6581832361055, 1882.6799444094536, 111430.0, 117778.0, 119666.4016679911, 121557.39221303837, 122595.16107258399, 10942.507587158598, 11506.367149806674, 11534.250273732348, 11755.412229388496, 11910.94044529789, 12649.114561980574, 13186.340682966005, 13219.735605288033, 13369.33153342329, 14078.859211407755, 8235.794105147299, 8302.83394332122, 8364.37267204962, 8485.193906578865, 8518.70184543538, 7072.504924655224, 8215.548144852091, 8222.218889205635, 8464.576771161417, 8477.23704866565, 4115.670746340285, 4140.44104045956, 4418.248897687401, 4507.842225522091, 4594.95405045952, 1866.6080123174286, 1905.4378958207362, 1929.4597512696469, 1943.1450161928706, 1957.1192963166632, 806.6289506826926, 890.7684002159485, 934.4113208678625, 984.8325784616633, 1025.9025392587691, 19842.70235946462, 20552.0, 20678.793212067685, 20735.27426540064, 21008.26471073505, 885.3227281129941, 906.2387594420718, 921.3780698028804, 938.2869019545059, 952.1668540027476, 8690.652373905099, 9373.734545836362, 9989.500524973722, 10703.357798532114, 10937.179711521667, 615341.0, 619027.0, 623100.0, 634679.0, 636193.0, 120374.0, 128522.0, 129340.0, 138066.30966845102, 144235.0, 767.5011242692294, 978.4422878959067, 1003.3678782367208, 1005.4470041477158, 1006.3056491021172, 14961.156251392547, 18632.347867824563, 18946.242150313832, 19110.904445477685, 19128.234870605578, 53783.0, 53871.0, 55082.0, 56694.43305567057, 57102.0, 77357.61321193358, 78980.0, 79275.62173134815, 79594.20405795868, 81042.5947870257, 7871.976643036369, 7962.402819788655, 7986.440949133737, 8232.876506852523, 8247.051589067334, 11812.822807658064, 12360.4437800301, 12572.497100115894, 12635.494580217057, 12879.034072444792, 10609.681709548726, 10720.785584288427, 10740.892591074302, 11210.215284929976, 11232.831507527557, 10557.366558006544, 10621.681349559525, 10653.307535010199, 10724.356538607708, 10766.354018758899, 10856.34905223549, 10961.013508783928, 10974.286671366335, 11071.280366776457, 11157.776844462904, 6861.279565645735, 7825.882611760942, 7930.762077137695, 8280.296174825207, 8337.999440067231, 8852.955735221283, 9055.773605659911, 10627.149828013586, 10750.8387374191, 11048.226624136554], "value": 9379.004023631218, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.1510088240877, 1469.933852976616, 1497.8352381238062, 1651.793525809274, 1826.0, 7456.701731930723, 7852.9607351963305, 7855.921440785591, 7863.213678632134, 7863.292303692667, 7697.34572561333, 8122.675092996273, 8224.013118425783, 8250.793730156749, 8367.372447066478, 2286.9542609147848, 2323.5933711600487, 2324.5699545584034, 2325.0, 2327.2436458151083, 2007.7590689117326, 2219.768028744046, 2288.439332363565, 2328.662343960125, 2341.3210169050953, 2258.06290389489, 2263.173941511353, 2292.1862738727764, 2304.6543018547186, 2313.8495997760174, 2059.2895451069357, 2144.731908511436, 2254.2786308381324, 2264.53577016712, 2287.3824067501846, 2290.977090229093, 2312.0, 2315.7684231576877, 2316.525112351964, 2316.629339305703, 8257.05043919951, 8321.334293256525, 8410.411271211018, 8415.28470080044, 8422.28410585101, 4895.804167833282, 4954.43024052235, 5061.974690126526, 5082.33929589151, 5155.072087024334, 3355.614104377979, 3493.2489514754448, 3578.731595130376, 3586.9282614347826, 3587.461880717913, 1045.7647029418397, 1071.669778713595, 1085.1427372375813, 1097.1880808201952, 1100.9229353945227, 10802.67591972242, 10813.513391897304, 10930.453477326182, 10933.890661093288, 10948.671539853816, 4234.13200293939, 4307.332363483602, 4372.0, 4429.247028005247, 4436.889077773017, 7794.688212471551, 8493.745187644381, 8562.48625082497, 8709.346798990102, 8722.694705685397, 5071.366079240095, 5072.340595722532, 5076.111680455905, 5077.974610126926, 5087.8982420351385, 4002.6197511236387, 4210.789460527023, 4333.8699839004885, 4384.298512238027, 4776.164171270014, 3613.4399168128457, 3636.890893273206, 3713.517242758424, 3715.2198038412234, 3719.27474142545, 1129.4578602270792, 1139.043203708872, 1144.2905398652888, 1148.5578052449866, 1154.6074334726234, 874.3267683883374, 880.7665968518347, 880.7665968518347, 891.7547674389594, 910.0626354854378, 5215.921761173586, 5295.655782374133, 5530.695811730313, 5582.385937546866, 5597.3003374578175, 409.37774582634825, 426.22639908565856, 435.64059650787596, 438.4125272135354, 441.3225698552706, 3578.7494875359, 3618.3125206210734, 3788.6021967693546, 3861.555921069113, 3902.434147048662, 9868.457234852009, 10194.796104077877, 10320.690379288633, 10326.122279606167, 10352.948235258775, 9489.572969216402, 10203.795924081476, 10206.285560010876, 10261.230407719451, 10294.433806140734, 6699.430548403343, 7622.085349757954, 7739.92260077392, 7817.179196184433, 7879.290863822283, 4761.738104404152, 5594.1608758686525, 5619.409961953936, 5791.623544469596, 5802.622829516068, 9237.07629237071, 9309.487978161265, 9397.624095036395, 9399.295052871199, 9448.055194480497, 9457.574409151743, 9607.759806004906, 9624.230061594915, 9644.132028117503, 9673.613055477703, 7124.8218794528475, 7195.676194571152, 7270.9636451817405, 7290.015847860471, 7292.817679558054, 7730.188330225245, 7918.841623167619, 7929.682812687428, 7943.920560794318, 7949.761507154794, 6993.230744618189, 7118.216996130318, 7127.964360178166, 7162.283771622796, 7266.2007179211305, 5918.437748413894, 6415.294317625151, 6646.169228846395, 7034.191068027242, 7040.0847889774, 6289.465395441439, 6509.641969691713, 6545.14913061299, 6545.509086818603, 6616.768413105518, 4769.236922092448, 4778.928316075331, 4825.276208568743, 4839.806407743792, 4904.994476132313, 4809.591184749335, 4844.563989240985, 4886.462489126122, 4942.332785073969, 4956.529129732669], "value": 4254.791136237697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2169822140004, 295.3826502609546, 299.9100269919022, 303.5871215147399, 311.962564492261, 4632.652551058672, 4764.857054288368, 5180.6632568883, 5238.607104467161, 5298.052950551844, 3717.442383642448, 4858.781354839032, 5103.464136265694, 5148.150555158394, 5175.0, 3246.2371342734436, 3864.956461755324, 3961.6632586230203, 3972.880813575597, 3973.781442020688, 3785.791781452019, 3936.881893543184, 3950.802459877009, 3973.5231772187376, 3976.622220889011, 3243.51347297906, 3922.4508568800393, 3930.9189972757435, 3932.941005884914, 3937.7243592948507, 3064.8966372106024, 3207.0, 3727.422249551324, 3910.393888947218, 3932.0563064864514, 2804.9298767530977, 3167.0498850345034, 3419.5725534308212, 3425.9828700856588, 3436.639152888961, 4225.72532785371, 4699.295105734133, 4826.745046287955, 5039.647224694273, 5043.36957880265, 4450.554944505556, 4454.665900057508, 4463.531329210418, 4475.888102797424, 4486.7980940857415, 4950.381202349707, 5134.0, 5416.566674666017, 5417.51242388187, 5437.809676661298, 3339.2486690494443, 3492.3539145257955, 3523.365794157051, 3740.1584643455276, 3746.2882052409955, 4956.653034287638, 5723.397448714367, 5732.9140062899505, 5735.598508104435, 5826.1552074948895, 3612.277544491112, 3808.542974842981, 3812.3328417526823, 3816.44661524083, 3820.6436714966344, 3858.5176852893387, 3868.6905047596124, 3871.8644847430205, 3883.0, 3884.533855937306, 3496.3182179474757, 4186.434831297735, 4486.820527178941, 4489.595936365743, 4494.77526123699, 5443.374011988592, 5480.588955828329, 5501.807436739695, 5503.394626591072, 5553.305836770403, 1033.4161198922584, 1106.1316866259947, 1155.1682788392345, 1237.808139738324, 1253.893419059372, 739.6782399656059, 832.2967092806568, 835.8829763833069, 853.8463076646264, 857.8976015819642, 4298.46269216348, 4357.4988876279, 4863.367762190964, 4866.343043689128, 4884.413870335582, 4541.68208225421, 5318.282031925718, 5319.946800532022, 5341.839744807662, 5425.620206585501, 3992.441058251847, 4169.97915010423, 4880.267959806058, 4892.779824907888, 4914.262860570871, 2397.7292035221362, 2566.820322577402, 2678.986605066962, 2847.345110624568, 2848.9430211395656, 5055.887704704959, 5099.654159086787, 5462.20797984298, 5510.669359838423, 5671.0, 4617.8152873884665, 4629.490756016836, 4949.777260023236, 5420.864478387993, 5795.059359635488, 5089.745512724349, 5350.91973620396, 5405.729713514309, 5935.940640593539, 5952.255968004086, 5730.742116604846, 5736.4550367715, 5743.971280143573, 5744.772257245886, 5751.511121554715, 4634.443866735878, 4902.671231165168, 5492.835214943558, 5543.417941116125, 5670.383940576916, 5824.534037276923, 5887.558433117619, 5899.286328289035, 5904.202932604044, 5925.644461332334, 3471.4098603238017, 3473.89578312651, 3801.5248093988253, 3828.5788563258575, 3843.1160833008007, 4965.329680493087, 5294.311739473844, 5654.547636189177, 5663.2071509989455, 5692.658440493584, 5094.796208151781, 5500.339959204761, 5522.337319521683, 5532.806351777668, 5571.498565128995, 4382.496012958551, 5026.974865125651, 5311.466895718366, 5473.781048758005, 5516.61383703153, 4379.810094952523, 5358.651687640291, 5387.272718182995, 5402.702851343057, 5411.918821217606, 4877.609791216623, 5485.945140548543, 5494.917576236279, 5525.613207075467, 5526.557875370041, 4138.52406973202, 4756.500567440369, 4902.313676085422, 5075.949240507695, 5203.661761985459], "value": 3908.956588073047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.221521926955, 725.9128904531457, 780.7579650308405, 794.630496818979, 796.1998191817223, 13999.370028348723, 14636.634084147901, 14683.926580367097, 14685.04547204431, 14699.632509187275, 12736.108472406911, 12942.28817415044, 13179.143355681874, 13448.596542103727, 13474.865251347484, 649.113959445356, 807.0839597057338, 819.213554987213, 821.3921697943539, 822.8272062866805, 663.3631713554993, 674.608726938377, 811.9391045671568, 822.8313195794848, 836.6736972580699, 872.4634349874844, 873.5326600268858, 874.9981271444193, 875.1161327059684, 875.9969834539448, 867.8437881181385, 869.148234729965, 869.3566760597113, 870.7561882672861, 872.821071680304, 500.5195012787728, 501.0930216308493, 517.9585633149377, 518.65768592729, 519.584332533975, 13738.0, 14202.857971420257, 14239.0, 14591.270436478133, 14599.270036498132, 13375.799363009563, 13669.521566745116, 13799.2410417427, 13868.306584670727, 13875.583732488041, 10760.515776790064, 10894.836577451344, 10954.616588419367, 10963.122950164048, 11035.668929932115, 3514.3147086318177, 3563.6970857477145, 3601.001444198469, 3707.0361705956375, 3771.340015497277, 86452.0, 87333.56333218356, 87367.56316218378, 87445.0, 87532.0, 10340.638077667396, 10378.481075946172, 10790.892091079146, 10841.295315804447, 10859.511321990529, 20965.895170524356, 21091.050902709107, 21265.78734212669, 21275.787242127382, 21546.461338466663, 7464.813379665552, 7621.31408173267, 7626.69493220276, 7664.425168112414, 7830.41271904598, 4115.7851644017155, 4144.109016561454, 4362.607365337135, 4374.0, 4399.670024748157, 3376.510405991167, 3471.9132021699156, 3493.161641206143, 3500.789952602852, 3500.842462089161, 619.9956071164652, 630.4830039367674, 635.8187916443884, 644.7259914536303, 663.9203295604461, 511.6086194061546, 633.5944995203074, 649.233903993283, 668.1481408159295, 682.952193346461, 8689.609662453977, 8709.520976346235, 8823.661639750375, 8992.505412202392, 9055.68305109318, 610.2646311194999, 629.7782302333459, 660.6432526435767, 663.1696517611427, 664.2792570061538, 4191.455110835572, 4548.931766023512, 4617.284320930261, 4659.254519276968, 4711.575958163782, 59533.702331488064, 100148.49925750325, 107829.46085269524, 117183.0, 123953.76046239602, 101121.0, 101172.49413753032, 106205.46897265465, 108545.45727271472, 109042.0, 89636.5518172405, 91359.54320228622, 93227.53386233025, 93883.53058234528, 94094.0, 8986.460812351019, 9009.324300677607, 9080.364374493722, 9105.0, 9175.0, 36207.818960905024, 54921.45078549163, 55724.16413753716, 58074.12888806756, 58359.70820145872, 80661.59669201616, 81365.0, 83094.58452707698, 86767.49243806866, 88031.55984220038, 9427.387219830689, 11717.648470545897, 11821.881781182423, 12085.879141208827, 12140.271583705005, 13544.79682804739, 13947.58157255284, 14373.856261437251, 14513.129212247299, 14559.563213103624, 12566.37168141571, 12625.936870315589, 12673.049521285757, 12868.806967895302, 13369.131006484547, 12299.508019679113, 12375.876241237473, 12713.046521511109, 12766.0, 12882.904953079093, 12067.69830754203, 12318.938405307916, 12557.497700091893, 13062.54281100157, 13124.14693044949, 9100.31747618918, 10166.288359814742, 10526.894731052898, 10726.302790318605, 10802.189835762192, 10455.94772026135, 10946.835797462885, 11094.889051109385, 11234.662960111209, 11283.0], "value": 7244.154589979335, "unit": "score"}], "name": "dromaeo_css", "value": 7009.068728467568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 141.0, 141.0, 156.0, 111.0, 113.0, 114.0, 116.0, 143.0, 120.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 182.0, 189.0, 181.0, 182.0, 181.0, 181.0, 182.0, 182.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 88.0, 60.0, 58.0, 59.0, 61.0, 84.0, 61.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 94.0, 70.0, 67.0, 68.0, 90.0, 67.0, 68.0, 91.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 92.0, 84.0, 90.0, 84.0, 90.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 80.0, 82.0, 80.0, 85.0, 99.0, 138.0, 130.0, 83.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 56.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 69.0, 82.0, 74.0, 72.0, 70.0, 70.0, 70.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 86.0, 85.0, 83.0, 83.0, 82.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 147.0, 149.0, 148.0, 150.0, 148.0, 153.0, 217.0, 170.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 174.0, 169.0, 190.0, 230.0, 235.0, 177.0, 168.0, 168.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 74.0, 89.0, 87.0, 87.0, 75.0, 66.0, 66.0, 66.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1479.7000000000003, "alertThreshold": 2.0}]} 03:16:21 INFO - Return code: 0 03:16:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:16:21 INFO - # TBPL SUCCESS # 03:16:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:21 INFO - 2016-11-25 03:16:21.335 screenresolution[1655:10435] starting screenresolution argv=screenresolution get 03:16:21 INFO - 2016-11-25 03:16:21.340 screenresolution[1655:10435] Display 0: 1600x1200x32@60 03:16:21 INFO - 2016-11-25 03:16:21.346 screenresolution[1656:10438] starting screenresolution argv=screenresolution list 03:16:21 INFO - Available Modes on Display 0 03:16:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:21 INFO - Intel Iris: 03:16:21 INFO - Chipset Model: Intel Iris 03:16:21 INFO - Type: GPU 03:16:21 INFO - Bus: Built-In 03:16:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:21 INFO - Vendor: Intel (0x8086) 03:16:21 INFO - Device ID: 0x0a2e 03:16:21 INFO - Revision ID: 0x0009 03:16:21 INFO - Displays: 03:16:21 INFO - Display: 03:16:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:21 INFO - Display Serial Number: 1600x1200 60 03:16:21 INFO - Main Display: Yes 03:16:21 INFO - Mirror: Off 03:16:21 INFO - Online: Yes 03:16:21 INFO - Rotation: Supported 03:16:21 INFO - Return code: 0 03:16:21 INFO - Running post-action listener: _resource_record_post_action 03:16:21 INFO - [mozharness: 2016-11-25 11:16:21.590482Z] Finished run-tests step (success) 03:16:21 INFO - Running post-run listener: _resource_record_post_run 03:16:21 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 32214016; Write bytes: 655144448; Read time: 197; Write time: 1863 03:16:21 INFO - TinderboxPrint: CPU usage
53.1% 03:16:21 INFO - TinderboxPrint: I/O read bytes / time
32,214,016 / 197 03:16:21 INFO - TinderboxPrint: I/O write bytes / time
655,144,448 / 1,863 03:16:21 INFO - TinderboxPrint: CPU idle
2,270.4 (46.9%) 03:16:21 INFO - TinderboxPrint: CPU system
963.9 (19.9%) 03:16:21 INFO - TinderboxPrint: CPU user
1,611.3 (33.3%) 03:16:21 INFO - TinderboxPrint: Swap in / out
376,365,056 / 0 03:16:21 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 344533504; Write bytes: 345020416; Read time: 26653; Write time: 715 03:16:21 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 30243840; Write bytes: 303209984; Read time: 179; Write time: 1125 03:16:22 INFO - Running post-run listener: _upload_blobber_files 03:16:22 INFO - Blob upload gear active. 03:16:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16: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 03:16: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:16: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:16:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:16:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:23 INFO - (blobuploader) - INFO - Done attempting. 03:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:24 INFO - (blobuploader) - INFO - Done attempting. 03:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:27 INFO - (blobuploader) - INFO - Done attempting. 03:16:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:27 INFO - Return code: 0 03:16:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71032314e7452d66fab9c8bcdd4bdc320f0cc04ba7f5e01b6bfba9a326cc1fc47c331099579a81b5b8010d27b3ead2b060943558260cd967ab52f680fa3ec0f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517ac07305be99f3c0d9b89fa167851c019e0f395b49e0c557c8b8d7fad2941dafba4430e1f0e01517bad9c30ffee083fd007c453c659ec713502eb99fbf2d87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3f60293c90a7d9faf53696d779a41ce587a0b4dd9f493279c2288ebfe307447da12a6b31501bfec6c039cedb5044df57b3a309121663e8d3c7a0a52dbe3a7c1"} 03:16:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:27 INFO - Contents: 03:16:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71032314e7452d66fab9c8bcdd4bdc320f0cc04ba7f5e01b6bfba9a326cc1fc47c331099579a81b5b8010d27b3ead2b060943558260cd967ab52f680fa3ec0f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517ac07305be99f3c0d9b89fa167851c019e0f395b49e0c557c8b8d7fad2941dafba4430e1f0e01517bad9c30ffee083fd007c453c659ec713502eb99fbf2d87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3f60293c90a7d9faf53696d779a41ce587a0b4dd9f493279c2288ebfe307447da12a6b31501bfec6c039cedb5044df57b3a309121663e8d3c7a0a52dbe3a7c1"} 03:16:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:27 INFO - Copying logs to upload dir... 03:16:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.272631 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-25 03:16:27.458708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 03:16:27.462055) ========= 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.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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/Mozilla-Aurora/sha512/71032314e7452d66fab9c8bcdd4bdc320f0cc04ba7f5e01b6bfba9a326cc1fc47c331099579a81b5b8010d27b3ead2b060943558260cd967ab52f680fa3ec0f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517ac07305be99f3c0d9b89fa167851c019e0f395b49e0c557c8b8d7fad2941dafba4430e1f0e01517bad9c30ffee083fd007c453c659ec713502eb99fbf2d87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3f60293c90a7d9faf53696d779a41ce587a0b4dd9f493279c2288ebfe307447da12a6b31501bfec6c039cedb5044df57b3a309121663e8d3c7a0a52dbe3a7c1"} build_url:https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/Dp6InkKRR--9rXzQKEvTxw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/71032314e7452d66fab9c8bcdd4bdc320f0cc04ba7f5e01b6bfba9a326cc1fc47c331099579a81b5b8010d27b3ead2b060943558260cd967ab52f680fa3ec0f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517ac07305be99f3c0d9b89fa167851c019e0f395b49e0c557c8b8d7fad2941dafba4430e1f0e01517bad9c30ffee083fd007c453c659ec713502eb99fbf2d87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e3f60293c90a7d9faf53696d779a41ce587a0b4dd9f493279c2288ebfe307447da12a6b31501bfec6c039cedb5044df57b3a309121663e8d3c7a0a52dbe3a7c1"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 03:16:27.598564) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:16:27.598961) ========= 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.QheMDLHgjX/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.lLrwq0nm2t/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.005082 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:16:27.629094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 03:16:27.629894) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 03:16:27.630615) ========= ========= Total master_lag: 2.89 =========