builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0313 starttime: 1476489403.44 results: success (0) buildid: 20161014145635 builduid: 7c9d6527a8a64a97ba4a35b7194c614d revision: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:43.438846) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:43.439233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:43.439553) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:43.482048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:43.482397) ========= 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.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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-10-14 16:56:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-10-14 16:56:44 (47.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.555674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.060119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.060420) ========= 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.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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.037986 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:44.121329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 16:56:44.121672) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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-10-14 16:56:44,207 truncating revision to first 12 chars 2016-10-14 16:56:44,207 Setting DEBUG logging. 2016-10-14 16:56:44,207 attempt 1/10 2016-10-14 16:56:44,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6ed5592738b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 16:56:46,147 unpacking tar archive at: fx-team-6ed5592738b6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.212548 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 16:56:46.361779) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:46.362105) ========= script_repo_revision: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:46.362497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:46.362759) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 16:56:46.380623) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-14 16:56:46.381008) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:56:46 INFO - MultiFileLogger online at 20161014 16:56:46 in /builds/slave/test 16:56:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:56:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:46 INFO - {'append_to_log': False, 16:56:46 INFO - 'base_work_dir': '/builds/slave/test', 16:56:46 INFO - 'blob_upload_branch': 'Fx-Team', 16:56:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:46 INFO - 'branch': 'Fx-Team', 16:56:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:46 INFO - 'config_files': ('talos/mac_config.py',), 16:56:46 INFO - 'default_actions': ('clobber', 16:56:46 INFO - 'read-buildbot-config', 16:56:46 INFO - 'download-and-extract', 16:56:46 INFO - 'populate-webroot', 16:56:46 INFO - 'create-virtualenv', 16:56:46 INFO - 'install', 16:56:46 INFO - 'run-tests'), 16:56:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:46 INFO - 'download_minidump_stackwalk': True, 16:56:46 INFO - 'download_symbols': 'ondemand', 16:56:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:46 INFO - 'installer_path': 'installer.exe', 16:56:46 INFO - 'log_level': 'info', 16:56:46 INFO - 'log_name': 'talos', 16:56:46 INFO - 'log_to_console': True, 16:56:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:56:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:56:46 INFO - 'opt_config_files': (), 16:56:46 INFO - 'pip_index': False, 16:56:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:46 INFO - 'cmd': ('bash', 16:56:46 INFO - '-c', 16:56:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:46 INFO - 'enabled': True, 16:56:46 INFO - 'halt_on_failure': False, 16:56:46 INFO - 'name': 'check_screen_resolution'},), 16:56:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:46 INFO - 'cmd': ('bash', 16:56:46 INFO - '-c', 16:56:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:46 INFO - 'enabled': True, 16:56:46 INFO - 'halt_on_failure': False, 16:56:46 INFO - 'name': 'check_screen_resolution'},), 16:56:46 INFO - 'run_cmd_checks_enabled': True, 16:56:46 INFO - 'sps_profile': False, 16:56:46 INFO - 'sps_profile_interval': 0, 16:56:46 INFO - 'suite': 'dromaeojs', 16:56:46 INFO - 'system_bits': '32', 16:56:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:46 INFO - 'title': 't-yosemite-r7-0313', 16:56:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:46 INFO - 'use_talos_json': True, 16:56:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:46 INFO - 'work_dir': 'build'} 16:56:46 INFO - [mozharness: 2016-10-14 23:56:46.584063Z] Running clobber step. 16:56:46 INFO - Running pre-action listener: _resource_record_pre_action 16:56:46 INFO - Running main action method: clobber 16:56:46 INFO - rmtree: /builds/slave/test/build 16:56:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:48 INFO - Running post-action listener: _resource_record_post_action 16:56:48 INFO - [mozharness: 2016-10-14 23:56:48.813513Z] Finished clobber step (success) 16:56:48 INFO - [mozharness: 2016-10-14 23:56:48.813686Z] Running read-buildbot-config step. 16:56:48 INFO - Running pre-action listener: _resource_record_pre_action 16:56:48 INFO - Running main action method: read_buildbot_config 16:56:48 INFO - Using buildbot properties: 16:56:48 INFO - { 16:56:48 INFO - "project": "", 16:56:48 INFO - "product": "firefox", 16:56:48 INFO - "script_repo_revision": "production", 16:56:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:56:48 INFO - "repository": "", 16:56:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:56:48 INFO - "buildid": "20161014145635", 16:56:48 INFO - "pgo_build": "False", 16:56:48 INFO - "basedir": "/builds/slave/test", 16:56:48 INFO - "buildnumber": 185, 16:56:48 INFO - "slavename": "t-yosemite-r7-0313", 16:56:48 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:56:48 INFO - "platform": "yosemite_r7", 16:56:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:56:48 INFO - "branch": "fx-team", 16:56:48 INFO - "repo_path": "integration/fx-team", 16:56:48 INFO - "revision": "6ed5592738b6c40ea8aefcf8b699de9f60f30a91", 16:56:48 INFO - "stage_platform": "macosx64", 16:56:48 INFO - "builduid": "7c9d6527a8a64a97ba4a35b7194c614d", 16:56:48 INFO - "slavebuilddir": "test" 16:56:48 INFO - } 16:56:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:56:48 INFO - Running post-action listener: _resource_record_post_action 16:56:48 INFO - [mozharness: 2016-10-14 23:56:48.817988Z] Finished read-buildbot-config step (success) 16:56:48 INFO - [mozharness: 2016-10-14 23:56:48.818128Z] Running download-and-extract step. 16:56:48 INFO - Running pre-action listener: _resource_record_pre_action 16:56:48 INFO - Running main action method: download_and_extract 16:56:48 INFO - mkdir: /builds/slave/test/build/tests 16:56:48 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')]} 16:56:48 INFO - trying https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:56:48 INFO - Downloading https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 16:56:50 INFO - Downloaded 1199 bytes. 16:56:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:56:50 INFO - Using the following test package requirements: 16:56:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:56:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:56:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:56:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'jsshell-mac.zip'], 16:56:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:56:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:56:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:56:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:56:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:56:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:56:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:56:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:56:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:56:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:56:50 INFO - Fetch https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:56:50 INFO - Http code: 200 16:56:50 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 16:56:50 INFO - x-amz-cf-id: l6tK0L7MBztxOuTD1w6bOVMy1M_a48Sjoae0VJZ0N4Ie3Se6XNZzdQ== 16:56:50 INFO - x-amz-version-id: rPHp6iDHFAwOwdOJjnvA3FsfoSGqmHPX 16:56:51 INFO - Expected file size: 16516711 16:56:51 INFO - Obtained file size: 16516711 16:56:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:56:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:56:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:56:57 INFO - Fetch https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:56:58 INFO - Http code: 200 16:56:58 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:56:58 INFO - x-amz-cf-id: P8YIW1RgNioFx16cgVrogz2YAUFcYbGto-COhdRfZpd6EdeO0Kjofw== 16:56:58 INFO - x-amz-version-id: rPHp6iDHFAwOwdOJjnvA3FsfoSGqmHPX 16:56:58 INFO - Expected file size: 16516711 16:56:58 INFO - Obtained file size: 16516711 16:57:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:57:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:57:04 INFO - Fetch https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:57:05 INFO - Http code: 200 16:57:05 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:57:05 INFO - x-amz-cf-id: dcjqreoV5xPydC4wsyDxZWxnwTz_SIqwuMVmH_3WvpBYMboyTg2Z8w== 16:57:05 INFO - x-amz-version-id: 3o0WaNCcps95KyPu.6DKdmqBH89J17XW 16:57:06 INFO - Expected file size: 14409028 16:57:06 INFO - Obtained file size: 14409028 16:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:07 INFO - trying https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:57:07 INFO - Downloading https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 16:57:10 INFO - Downloaded 111964497 bytes. 16:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:57:10 INFO - mkdir: /builds/slave/test/properties 16:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:10 INFO - Contents: 16:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:57:10 INFO - Running post-action listener: _resource_record_post_action 16:57:10 INFO - Running post-action listener: set_extra_try_arguments 16:57:10 INFO - [mozharness: 2016-10-14 23:57:10.674560Z] Finished download-and-extract step (success) 16:57:10 INFO - [mozharness: 2016-10-14 23:57:10.674711Z] Running populate-webroot step. 16:57:10 INFO - Running pre-action listener: _resource_record_pre_action 16:57:10 INFO - Running main action method: populate_webroot 16:57:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:10 INFO - '--tppagecycles', 16:57:10 INFO - '7'], 16:57:10 INFO - 'tests': ['tsvgm']}}, 16:57:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['damp', 'tps']}, 16:57:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'tests': ['damp', 'tps']}, 16:57:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['dromaeo_dom']}, 16:57:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['basic_compositor_video']}, 16:57:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['a11yr', 16:57:10 INFO - 'ts_paint', 16:57:10 INFO - 'tpaint', 16:57:10 INFO - 'sessionrestore', 16:57:10 INFO - 'sessionrestore_no_auto_restore', 16:57:10 INFO - 'tabpaint']}, 16:57:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tsvgx', 16:57:10 INFO - 'tsvgr_opacity', 16:57:10 INFO - 'tart', 16:57:10 INFO - 'tscrollx', 16:57:10 INFO - 'cart']}, 16:57:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:10 INFO - 'tsvgr_opacity', 16:57:10 INFO - 'tart', 16:57:10 INFO - 'tscrollx', 16:57:10 INFO - 'cart']}, 16:57:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s'], 16:57:10 INFO - 'tests': ['tp5o']}, 16:57:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'tests': ['tp5o']}, 16:57:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'talos_options': ['--disable-e10s', 16:57:10 INFO - '--xperf_path', 16:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:10 INFO - 'tests': ['tp5n']}, 16:57:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:10 INFO - 'talos_options': ['--xperf_path', 16:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:10 INFO - 'tests': ['tp5n']}}, 16:57:10 INFO - 'talos.zip': {'path': '', 16:57:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:10 INFO - Running post-action listener: _resource_record_post_action 16:57:10 INFO - [mozharness: 2016-10-14 23:57:10.693252Z] Finished populate-webroot step (success) 16:57:10 INFO - [mozharness: 2016-10-14 23:57:10.693363Z] Running create-virtualenv step. 16:57:10 INFO - Running pre-action listener: _resource_record_pre_action 16:57:10 INFO - Running main action method: create_virtualenv 16:57:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:10 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 16:57:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:10 INFO - Using real prefix '/tools/python27' 16:57:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:14 INFO - Installing pip.................done. 16:57:14 INFO - Return code: 0 16:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:57:14 INFO - Reading from file tmpfile_stdout 16:57:14 INFO - Output received: 16:57:14 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) 16:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57:14 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')]} 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:14 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')]} 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:14 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:14 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 16:57:14 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 16:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:14 INFO - 'HOME': '/Users/cltbld', 16:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:14 INFO - 'LOGNAME': 'cltbld', 16:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:14 INFO - 'MOZ_NO_REMOTE': '1', 16:57:14 INFO - 'NO_EM_RESTART': '1', 16:57:14 INFO - 'PAGER': '/bin/cat', 16:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:14 INFO - 'PWD': '/builds/slave/test', 16:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:14 INFO - 'SHELL': '/bin/bash', 16:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:14 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:14 INFO - 'USER': 'cltbld', 16:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:14 INFO - 'XPC_FLAGS': '0x0', 16:57:14 INFO - 'XPC_SERVICE_NAME': '0', 16:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:14 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 16:57:14 INFO - Cleaning up... 16:57:14 INFO - Return code: 0 16:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57:14 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')]} 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:14 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')]} 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:14 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:14 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 16:57:14 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 16:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:14 INFO - 'HOME': '/Users/cltbld', 16:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:14 INFO - 'LOGNAME': 'cltbld', 16:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:14 INFO - 'MOZ_NO_REMOTE': '1', 16:57:14 INFO - 'NO_EM_RESTART': '1', 16:57:14 INFO - 'PAGER': '/bin/cat', 16:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:14 INFO - 'PWD': '/builds/slave/test', 16:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:14 INFO - 'SHELL': '/bin/bash', 16:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:14 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:14 INFO - 'USER': 'cltbld', 16:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:14 INFO - 'XPC_FLAGS': '0x0', 16:57:14 INFO - 'XPC_SERVICE_NAME': '0', 16:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:15 INFO - Downloading/unpacking psutil>=3.1.1 16:57:15 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 16:57:15 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 16:57:15 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 16:57:15 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 16:57:15 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 16:57:15 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 16:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:18 INFO - Installing collected packages: psutil 16:57:18 INFO - Running setup.py install for psutil 16:57:19 INFO - building 'psutil._psutil_osx' extension 16:57:19 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 16:57:19 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 16:57:19 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 16:57:19 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 16:57:19 INFO - building 'psutil._psutil_posix' extension 16:57:19 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 16:57:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:57:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:57:19 INFO - ^ 16:57:19 INFO - 1 warning generated. 16:57:19 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 16:57:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:20 INFO - Successfully installed psutil 16:57:20 INFO - Cleaning up... 16:57:20 INFO - Return code: 0 16:57:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:20 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 16:57:20 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 16:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:20 INFO - 'HOME': '/Users/cltbld', 16:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:20 INFO - 'LOGNAME': 'cltbld', 16:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:20 INFO - 'MOZ_NO_REMOTE': '1', 16:57:20 INFO - 'NO_EM_RESTART': '1', 16:57:20 INFO - 'PAGER': '/bin/cat', 16:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:20 INFO - 'PWD': '/builds/slave/test', 16:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:20 INFO - 'SHELL': '/bin/bash', 16:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:20 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:20 INFO - 'USER': 'cltbld', 16:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:20 INFO - 'XPC_FLAGS': '0x0', 16:57:20 INFO - 'XPC_SERVICE_NAME': '0', 16:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57:20 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 16:57:20 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 16:57:20 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 16:57:20 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 16:57:20 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 16:57:20 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 16:57:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:22 INFO - Installing collected packages: mozsystemmonitor 16:57:22 INFO - Running setup.py install for mozsystemmonitor 16:57:23 INFO - Successfully installed mozsystemmonitor 16:57:23 INFO - Cleaning up... 16:57:23 INFO - Return code: 0 16:57:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57:23 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')]} 16:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:23 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')]} 16:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:23 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:23 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 16:57:23 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 16:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:23 INFO - 'HOME': '/Users/cltbld', 16:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:23 INFO - 'LOGNAME': 'cltbld', 16:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:23 INFO - 'MOZ_NO_REMOTE': '1', 16:57:23 INFO - 'NO_EM_RESTART': '1', 16:57:23 INFO - 'PAGER': '/bin/cat', 16:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:23 INFO - 'PWD': '/builds/slave/test', 16:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:23 INFO - 'SHELL': '/bin/bash', 16:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:23 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:23 INFO - 'USER': 'cltbld', 16:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:23 INFO - 'XPC_FLAGS': '0x0', 16:57:23 INFO - 'XPC_SERVICE_NAME': '0', 16:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:23 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 16:57:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57:25 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 16:57:25 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 16:57:25 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 16:57:25 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 16:57:25 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 16:57:25 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 16:57:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:26 INFO - warning: no files found matching '*.txt' 16:57:26 INFO - no previously-included directories found matching 'build' 16:57:26 INFO - no previously-included directories found matching 'dist' 16:57:26 INFO - no previously-included directories found matching '.git*' 16:57:26 INFO - Installing collected packages: jsonschema, functools32 16:57:26 INFO - Running setup.py install for functools32 16:57:26 INFO - warning: no files found matching '*.txt' 16:57:26 INFO - no previously-included directories found matching 'build' 16:57:26 INFO - no previously-included directories found matching 'dist' 16:57:26 INFO - no previously-included directories found matching '.git*' 16:57:26 INFO - Successfully installed jsonschema functools32 16:57:26 INFO - Cleaning up... 16:57:26 INFO - Return code: 0 16:57:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:57:26 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')]} 16:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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')]} 16:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:26 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 16:57:26 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 16:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:26 INFO - 'HOME': '/Users/cltbld', 16:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:26 INFO - 'LOGNAME': 'cltbld', 16:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:26 INFO - 'MOZ_NO_REMOTE': '1', 16:57:26 INFO - 'NO_EM_RESTART': '1', 16:57:26 INFO - 'PAGER': '/bin/cat', 16:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:26 INFO - 'PWD': '/builds/slave/test', 16:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:26 INFO - 'SHELL': '/bin/bash', 16:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:26 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:26 INFO - 'USER': 'cltbld', 16:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:26 INFO - 'XPC_FLAGS': '0x0', 16:57:26 INFO - 'XPC_SERVICE_NAME': '0', 16:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:57:26 INFO - Cleaning up... 16:57:26 INFO - Return code: 0 16:57:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:26 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')]} 16:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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')]} 16:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:26 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 16:57:26 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 16:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:26 INFO - 'HOME': '/Users/cltbld', 16:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:26 INFO - 'LOGNAME': 'cltbld', 16:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:26 INFO - 'MOZ_NO_REMOTE': '1', 16:57:26 INFO - 'NO_EM_RESTART': '1', 16:57:26 INFO - 'PAGER': '/bin/cat', 16:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:26 INFO - 'PWD': '/builds/slave/test', 16:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:26 INFO - 'SHELL': '/bin/bash', 16:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:26 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:26 INFO - 'USER': 'cltbld', 16:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:26 INFO - 'XPC_FLAGS': '0x0', 16:57:26 INFO - 'XPC_SERVICE_NAME': '0', 16:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:27 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 16:57:27 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 16:57:27 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 16:57:27 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 16:57:27 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 16:57:27 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 16:57:29 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 INFO - Downloading docopt-0.6.1.tar.gz 16:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:30 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:30 INFO - Running setup.py install for blobuploader 16:57:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:31 INFO - Running setup.py install for requests 16:57:31 INFO - Running setup.py install for docopt 16:57:31 INFO - Successfully installed blobuploader requests docopt 16:57:31 INFO - Cleaning up... 16:57:31 INFO - Return code: 0 16:57:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:31 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')]} 16:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:31 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')]} 16:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:31 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:31 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 16:57:31 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 16:57:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:31 INFO - 'HOME': '/Users/cltbld', 16:57:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:31 INFO - 'LOGNAME': 'cltbld', 16:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:31 INFO - 'MOZ_NO_REMOTE': '1', 16:57:31 INFO - 'NO_EM_RESTART': '1', 16:57:31 INFO - 'PAGER': '/bin/cat', 16:57:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:31 INFO - 'PWD': '/builds/slave/test', 16:57:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:31 INFO - 'SHELL': '/bin/bash', 16:57:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:31 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:31 INFO - 'USER': 'cltbld', 16:57:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:31 INFO - 'XPC_FLAGS': '0x0', 16:57:31 INFO - 'XPC_SERVICE_NAME': '0', 16:57:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-HnYtXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-BVSrTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-_lR0U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-Xdpfg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-0Axnm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-rcXPt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-3YeLKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-2QM9Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:32 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-rVHDAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-hgkSHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-dRN97e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-Hskczo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-hqKQ4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-7DrHFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-hZyMnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-RE9gvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:33 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-bqEAkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:33 INFO - Running setup.py install for manifestparser 16:57:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:33 INFO - Running setup.py install for mozcrash 16:57:34 INFO - Running setup.py install for mozdebug 16:57:34 INFO - Running setup.py install for mozdevice 16:57:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:57:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:34 INFO - Running setup.py install for mozfile 16:57:34 INFO - Running setup.py install for mozhttpd 16:57:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:34 INFO - Running setup.py install for mozinfo 16:57:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:34 INFO - Running setup.py install for mozInstall 16:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Running setup.py install for mozleak 16:57:35 INFO - Running setup.py install for mozlog 16:57:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Running setup.py install for moznetwork 16:57:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Running setup.py install for mozprocess 16:57:35 INFO - Running setup.py install for mozprofile 16:57:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Running setup.py install for mozrunner 16:57:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:35 INFO - Running setup.py install for mozscreenshot 16:57:36 INFO - Running setup.py install for moztest 16:57:36 INFO - Running setup.py install for mozversion 16:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:36 INFO - Cleaning up... 16:57:36 INFO - Return code: 0 16:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:36 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:36 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 16:57:36 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 16:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:36 INFO - 'HOME': '/Users/cltbld', 16:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:36 INFO - 'LOGNAME': 'cltbld', 16:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:36 INFO - 'MOZ_NO_REMOTE': '1', 16:57:36 INFO - 'NO_EM_RESTART': '1', 16:57:36 INFO - 'PAGER': '/bin/cat', 16:57:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:36 INFO - 'PWD': '/builds/slave/test', 16:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:36 INFO - 'SHELL': '/bin/bash', 16:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:36 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:36 INFO - 'USER': 'cltbld', 16:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:36 INFO - 'XPC_FLAGS': '0x0', 16:57:36 INFO - 'XPC_SERVICE_NAME': '0', 16:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:36 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-Ew3on8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:36 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)) 16:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:36 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-mpyLF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:36 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-lMTaOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-PRBPNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-rph_14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-t5ZxYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-aARGor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-ZW_sIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-fqHFVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-IL1EBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-Ocd1_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-Umxnl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:37 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)) 16:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:37 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-vRX8rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:38 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)) 16:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:38 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-KLTHN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:38 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-898tAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:38 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)) 16:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:38 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-f08JaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:38 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)) 16:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:38 INFO - Running setup.py (path:/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/pip-8UXdsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:38 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)) 16:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:57:38 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)) 16:57:38 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)) 16:57:38 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)) 16:57:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:38 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 16:57:38 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 16:57:38 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 16:57:38 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 16:57:38 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 16:57:38 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 16:57:40 INFO - Downloading blessings-1.6.tar.gz 16:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:41 INFO - Installing collected packages: blessings 16:57:41 INFO - Running setup.py install for blessings 16:57:41 INFO - Successfully installed blessings 16:57:41 INFO - Cleaning up... 16:57:41 INFO - Return code: 0 16:57:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:41 INFO - Reading from file tmpfile_stdout 16:57:41 INFO - Current package versions: 16:57:41 INFO - blessings == 1.6 16:57:41 INFO - blobuploader == 1.2.4 16:57:41 INFO - docopt == 0.6.1 16:57:41 INFO - functools32 == 3.2.3-2 16:57:41 INFO - jsonschema == 2.5.1 16:57:41 INFO - manifestparser == 1.1 16:57:41 INFO - mozInstall == 1.12 16:57:41 INFO - mozcrash == 0.17 16:57:41 INFO - mozdebug == 0.1 16:57:41 INFO - mozdevice == 0.48 16:57:41 INFO - mozfile == 1.2 16:57:41 INFO - mozhttpd == 0.7 16:57:41 INFO - mozinfo == 0.9 16:57:41 INFO - mozleak == 0.1 16:57:41 INFO - mozlog == 3.4 16:57:41 INFO - moznetwork == 0.27 16:57:41 INFO - mozprocess == 0.23 16:57:41 INFO - mozprofile == 0.28 16:57:41 INFO - mozrunner == 6.12 16:57:41 INFO - mozscreenshot == 0.1 16:57:41 INFO - mozsystemmonitor == 0.3 16:57:41 INFO - moztest == 0.7 16:57:41 INFO - mozversion == 1.4 16:57:41 INFO - psutil == 3.1.1 16:57:41 INFO - requests == 1.2.3 16:57:41 INFO - wsgiref == 0.1.2 16:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:41 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 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57:41 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 16:57:41 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 16:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:41 INFO - 'HOME': '/Users/cltbld', 16:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:41 INFO - 'LOGNAME': 'cltbld', 16:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:41 INFO - 'MOZ_NO_REMOTE': '1', 16:57:41 INFO - 'NO_EM_RESTART': '1', 16:57:41 INFO - 'PAGER': '/bin/cat', 16:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:41 INFO - 'PWD': '/builds/slave/test', 16:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:41 INFO - 'SHELL': '/bin/bash', 16:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:41 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:41 INFO - 'USER': 'cltbld', 16:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:41 INFO - 'XPC_FLAGS': '0x0', 16:57:41 INFO - 'XPC_SERVICE_NAME': '0', 16:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 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)) 16:57:41 INFO - Cleaning up... 16:57:41 INFO - Return code: 0 16:57:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e33a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9649d6b3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, '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.TQpednQnXB/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.8cgvPlnL7t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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 16:57: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', 'jsonschema'] in /builds/slave/test/build 16:57: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 jsonschema 16:57:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:57:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:41 INFO - 'HOME': '/Users/cltbld', 16:57:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:41 INFO - 'LOGNAME': 'cltbld', 16:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:41 INFO - 'MOZ_NO_REMOTE': '1', 16:57:41 INFO - 'NO_EM_RESTART': '1', 16:57:41 INFO - 'PAGER': '/bin/cat', 16:57:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:41 INFO - 'PWD': '/builds/slave/test', 16:57:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:41 INFO - 'SHELL': '/bin/bash', 16:57:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:57:41 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:57:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:41 INFO - 'USER': 'cltbld', 16:57:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:41 INFO - 'XPC_FLAGS': '0x0', 16:57:41 INFO - 'XPC_SERVICE_NAME': '0', 16:57:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:57:42 INFO - Cleaning up... 16:57:42 INFO - Return code: 0 16:57:42 INFO - Running post-action listener: _resource_record_post_action 16:57:42 INFO - Running post-action listener: _start_resource_monitoring 16:57:42 INFO - Starting resource monitoring. 16:57:42 INFO - [mozharness: 2016-10-14 23:57:42.165812Z] Finished create-virtualenv step (success) 16:57:42 INFO - [mozharness: 2016-10-14 23:57:42.166665Z] Running install step. 16:57:42 INFO - Running pre-action listener: _resource_record_pre_action 16:57:42 INFO - Running main action method: install 16:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:42 INFO - Reading from file tmpfile_stdout 16:57:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:42 INFO - Reading from file tmpfile_stdout 16:57:42 INFO - Output received: 16:57:42 INFO - Usage: mozinstall [options] installer 16:57:42 INFO - Options: 16:57:42 INFO - -h, --help show this help message and exit 16:57:42 INFO - -d DEST, --destination=DEST 16:57:42 INFO - Directory to install application into. [default: 16:57:42 INFO - "/builds/slave/test"] 16:57:42 INFO - --app=APP Application being installed. [default: firefox] 16:57:42 INFO - mkdir: /builds/slave/test/build/application 16:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:58:17 INFO - Reading from file tmpfile_stdout 16:58:17 INFO - Output received: 16:58:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:58:17 INFO - Running post-action listener: _resource_record_post_action 16:58:17 INFO - [mozharness: 2016-10-14 23:58:17.337708Z] Finished install step (success) 16:58:17 INFO - [mozharness: 2016-10-14 23:58:17.337833Z] Running run-tests step. 16:58:17 INFO - Running pre-action listener: _resource_record_pre_action 16:58:17 INFO - Running main action method: run_tests 16:58:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:17 INFO - 2016-10-14 16:58:17.351 screenresolution[1641:7675] starting screenresolution argv=screenresolution get 16:58:17 INFO - 2016-10-14 16:58:17.354 screenresolution[1641:7675] Display 0: 1600x1200x32@60 16:58:17 INFO - 2016-10-14 16:58:17.360 screenresolution[1642:7677] starting screenresolution argv=screenresolution list 16:58:17 INFO - Available Modes on Display 0 16:58:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:17 INFO - Intel Iris: 16:58:17 INFO - Chipset Model: Intel Iris 16:58:17 INFO - Type: GPU 16:58:17 INFO - Bus: Built-In 16:58:17 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:17 INFO - Vendor: Intel (0x8086) 16:58:17 INFO - Device ID: 0x0a2e 16:58:17 INFO - Revision ID: 0x0009 16:58:17 INFO - Displays: 16:58:17 INFO - Display: 16:58:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:17 INFO - Display Serial Number: 1600x1200 60 16:58:17 INFO - Main Display: Yes 16:58:17 INFO - Mirror: Off 16:58:17 INFO - Online: Yes 16:58:17 INFO - Rotation: Supported 16:58:17 INFO - Return code: 0 16:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:17 INFO - Python 2.7.3 16:58:17 INFO - Return code: 0 16:58:17 INFO - grabbing minidump binary from tooltool 16:58:17 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')]} 16:58:17 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 0x10e1d8d30>, '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 0x10dffedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e1d0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:17 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 16:58:17 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 16:58:17 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 16:58:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:17 INFO - Return code: 0 16:58:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:58:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:58:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0313', '--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 16:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0313 --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 16:58:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TQpednQnXB/Render', 16:58:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:17 INFO - 'HOME': '/Users/cltbld', 16:58:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:17 INFO - 'LOGNAME': 'cltbld', 16:58:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:17 INFO - 'MOZ_NO_REMOTE': '1', 16:58:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:17 INFO - 'NO_EM_RESTART': '1', 16:58:17 INFO - 'PAGER': '/bin/cat', 16:58:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:17 INFO - 'PWD': '/builds/slave/test', 16:58:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:17 INFO - 'SHELL': '/bin/bash', 16:58:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8cgvPlnL7t/Listeners', 16:58:17 INFO - 'TMPDIR': '/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/', 16:58:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:17 INFO - 'USER': 'cltbld', 16:58:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:17 INFO - 'XPC_FLAGS': '0x0', 16:58:17 INFO - 'XPC_SERVICE_NAME': '0', 16:58:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0313', '--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 16:58:17 INFO - mozversion application_buildid: 20161014145635 16:58:17 INFO - mozversion application_changeset: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 16:58:17 INFO - mozversion application_display_name: Nightly 16:58:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:17 INFO - mozversion application_name: Firefox 16:58:17 INFO - mozversion application_remotingname: firefox 16:58:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:17 INFO - mozversion application_vendor: Mozilla 16:58:17 INFO - mozversion application_version: 52.0a1 16:58:17 INFO - mozversion platform_buildid: 20161014145635 16:58:17 INFO - mozversion platform_changeset: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 16:58:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:17 INFO - mozversion platform_version: 52.0a1 16:58:17 INFO - using testdate: 1476489497 16:58:17 INFO - actual date: 1476489497 16:58:17 INFO - starting webserver on 'localhost:49279' 16:58:17 INFO - SUITE-START | Running 2 tests 16:58:17 INFO - TEST-START | dromaeo_css 16:58:17 INFO - operating with platform_type : mac_ 16:58:17 INFO - Initialising browser for dromaeo_css test... 16:58:17 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/tmpc4uvP6/profile http://localhost:49279/getInfo.html) 16:58:20 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 16:58:20 INFO - PROCESS | 1652 | colorDepth:24 16:58:20 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 16:58:20 INFO - PROCESS | 1652 | __metrics 16:58:20 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:58:20 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:58:21 INFO - TEST-INFO | 1652: exit 0 16:58:21 INFO - Browser initialized. 16:58:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:21 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/tmpc4uvP6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:33 INFO - PROCESS | 1654 | RSS: Main: 231702528 16:58:33 INFO - PROCESS | 1654 | 16:59:25 INFO - PROCESS | 1654 | 1476489565308 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:01:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 17:01:40 INFO - PROCESS | 1654 | RSS: Main: 406601728 17:01:40 INFO - PROCESS | 1654 | 17:04:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 17:04:43 INFO - PROCESS | 1654 | RSS: Main: 373649408 17:04:43 INFO - PROCESS | 1654 | 17:07:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 17:07:46 INFO - PROCESS | 1654 | RSS: Main: 334045184 17:07:46 INFO - PROCESS | 1654 | 17:10:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 17:10:49 INFO - PROCESS | 1654 | RSS: Main: 334987264 17:10:49 INFO - PROCESS | 1654 | 17:13:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 17:13:53 INFO - PROCESS | 1654 | RSS: Main: 327393280 17:13:53 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 17:16:56 INFO - PROCESS | 1654 | RSS: Main: 379723776 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | __start_tp_report 17:16:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 17:16:56 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 17:16:56 INFO - PROCESS | 1654 | |i|pagename|runs| 17:16:56 INFO - PROCESS | 1654 | |0;dojo.html;3191.6489186189515;3338.3323335332934;3358.7480938929584;3396.422608156613;3424.589049314083;5544.556435485161;5669.489745922866;5735.569832262581;5778;5832.300123985127;5639.915401268984;5682.602217844742;5687.374388817227;5698.373178950312;5702.201691763146;5111.284420181178;5159.664621799589;5160.948390516084;5177.042247184264;5199.09015922214;5299.178627312754;5304.3634763828395;5317.7607007684555;5318.494742999409;5326.280952071459;4112.259793237216;5182.714950677711;5214.661047031931;5246.213068039806;5277.604179686519;5200.427952925175;5259.921101183485;5276.472352764731;5277.973610131925;5346.919796203021;5045.344105266328;5159;5174.715390653512;5212.6611770235195;5222;5618.325800903876;5620.269364982567;5633.464820842013;5661.094224924033;5676.602637815355;6192.225971753531;6240.563160578761;6241.875162496724;6252.3747625237565;6262.686865656745;6123.1914755765065;6244.188255526798;6312.873742525169;6314.526410519184;6319.115323854664;5712.828615141552;5774.076147816413;5775.88448231033;5791.131330300489;5879.118132280192;6209.75804839034;6240.31356550779;6245.250569931637;6248.781292654735;6256.499480041586;6168.907466388007;6190.81427557174;6194.752209911643;6198.876022479615;6205.913965056097;6079.756809727562;6176.4441200292185;6186.1648677428875;6240.00159974402;6240.687965601702;6124.474457250848;6124.816255512342;6141.792871882774;6210.72051757672;6213.875722485615;6187.133801267826;6226.470749986302;6228.688565571703;6239.376062393724;6246.6876656167005;4839.322494850724;4848.490908454632;4901.044296362246;4912.606991440676;4935.185694360463;4395;4404.581564751344;4440.222960981815;4454.910901782011;4462.995825939138;5760.84783043393;5801.796937107181;5801.854953626109;5819.76720931158;5829.329627092939;6243.375662433811;6256.499480041586;6278.937210627835;6306.527010474141;6308.716107775161;5662.943370566324;5728.627639203439;5736.799212027559;5753.309602847685;5784.1034639630925;5393.514583687487;5413.242146099549;5417.5395091416885;5446.673199608036;5456.61803673739;6302.960011598035;6309.305976342507;6318.178636777189;6339.5562310637815;6341.239051313687;6091.086337049478;6152.892479353759;6285.654289013965;6306.4639505642535;6334.3665633436285;5077.517635824591;6197.938020619736;6209.099680546386;6278.4035516625845;6404.4876409886165;6202.658853763086;6203.627782333075;6208.596441231305;6213.099100630293;6217.191765070512;5528.419515950767;6041.456268935817;6275.780347687809;6304.779332723333;6320.5259605528845;5912.586118971631;5919.822405327847;5923.526117910471;6091.847703807441;6116.847078823065;6121.300552271563;6123.1606109212;6123.5876691309595;6127.678242056131;6134.865219626364;5934.643921364732;6012.278526576839;6012.969935150296;6030.7286172121485;6053.4551890330085;5642.915356269741;6102.176206212104;6164.753409863555;6165.075238714228;6171.352008039091;5706.657600543981;5725.227094342211;5726.398728133652;5729.885402292014;5731.254936858182 17:16:56 INFO - PROCESS | 1654 | |1;ext.html;473.9715617062976;485.83238782619986;493.9753012349382;517.8135871086406;551.8620344913771;30546.083617491484;31154.376912461736;32149.357012859728;32151.99999999997;32183;32318.67681323186;35090;41891;45210.773946130306;45389.773051134696;8109.310708589762;9675.129238368545;9692.515374231296;9693.612255509772;9705.854412183788;9536.332456728032;9574;9589.041095890425;9598.568064437117;9605.567749451291;9602;9657.32398732089;9659.275554333453;9681.903180968206;9732.610695572168;9521.857172142389;9589.328746987714;9594.28042896782;9610.90389096107;9622.470764107971;9401.153896149379;9434.481103539303;9501.667441639578;9509.953905070437;9527.952360238223;40511.392329115086;40747.38878916819;40758.79620601878;40772.77681669555;40792.388114178015;3613.728970327236;3939.72421930465;4064.8983775405554;4163.542010378856;4235.9364609530885;30188.24529386761;30614;30695.846520767478;31635.525467118012;31692.524612130837;2726.3184203949013;3192.197292492272;3203.8878639247514;3209.9679003209903;3241.9027429177163;489538;490374;493699;493936;507302;59883.80232395328;59930.30313635897;60063.69968150131;60107.69946150329;60138.699306503186;34545.13637159041;34971.125721856646;35088.47367289493;36517.45223821645;62439.68780156161;16728.749068763977;16841.07374094412;16857.819952603444;16907.40824071176;16946.830531694526;12773.105882588316;12789.296588687526;12835.358232088358;12845.871541284654;12846.421911014028;19226.03869806532;19239.326623568108;19289.421317360502;19295.324663636704;19327.8067219326;7708.344790692854;7750.689972401154;7782.182870798598;7814.2576455237795;7858.371330293563;846.1792061700141;891.9598618062203;973.454865275448;975.5853762151057;1019.0522813783105;29696.554551681744;29830.850845745634;30135.69864301373;30557.69442305593;30719.539206911915;855.7133360324236;1023.646841839579;1042.9739256518496;1063.5373612478597;1087.7280679830042;13454.425495331634;15567.61080972962;15667.529974100795;15873.07875138655;16037.358505659642;640756;646675;648633;649442;650293;48526.5147348522;58085.419145808846;58627.70686146542;58899.70550147222;58923.70538147282;1233.8334324866207;1272.815441760958;1337.7324535092825;1362.7615167345873;1382.6197795606088;28703.9533467144;29286.853565732035;30226;30728.692713073477;31213.68786312108;48979.75510122427;49657.75171124121;49721.75139124426;49791.75104124601;49792.50622481331;421097;422182.0072387;423369;423537;423990;23171.95726192359;23304.6504302439;25934.35164120912;26208.213753587424;26398.20805375842;45113.548864510936;46847.828804280165;47210.527894721985;47282;47567.52432475631;38659;38802.417963730004;38916.41625375678;40001;40126;38409.42385864158;38870.2225955485;39193.80403097966;39737.80131099326;40675.59324406836;37899.431508527945;38558.6144138555;38733.2253354937;39005.414918776805;39238.01904952399;33827.15432114217;34211;35124.473132903535;35369.5723897974;35807.64192358043;22945.915187779035;24011.75988240095;25243.87378063098;25621.10326138576;25891.0938117165 17:16:56 INFO - PROCESS | 1654 | |2;jquery.html;295.7294075920533;371.80480247869866;373.6413043478261;381.7213434193039;403.7476577139288;15180.696386072286;15436.922815385922;16461.588460288483;20728.896355518238;21251.787482125175;18066.18702158406;19961.900190499025;20874.26940057098;21651.350459486202;21842.89078554609;5261.605379596526;5725.828225153242;6009.188759517453;6016.669083200422;6022.759089636409;5607.663540187602;5779.133130030487;5958.314793798703;5974.55190860685;5989.460948514633;5603.411641777616;5915.733791979371;5925.170476133345;5927;5929;5044.772985215674;5781.508571771405;5949.107633854913;5956.106584012389;5961.791337303217;5501.807436739735;5702.914456283159;5729.627574207705;5739.454751798614;5781.046127388976;13116.27860467674;13176.379737937626;13322.533711320057;13328.666783330398;24733;2154.062982602573;2196.879171645559;2252.549490101986;2285.897134628929;2391.0794344177443;9879.950600247024;10197.18422526196;10783.46082695862;10882.782344353147;15528;1785.3394244129624;1790.5523619095227;1791.9910400447914;1824.8083951185067;1860;111245.67214736393;119279;121125.39437302845;121859;122052.38973805163;8381.234192716389;9129.452232865917;9767.267454940766;9820;9950.203983681287;12336.136470446983;12359.567415140607;12380.81428778569;12386.442610082568;12402.689932751753;7816.335611473089;8081.878771818428;8138.837223255502;8207.95896020528;8304.294134998472;8252.628631711588;8461.830763384698;8523.445976011539;8647.654093836301;8715.825683486295;3760.3795373763023;3806.8096595170687;3832.9425058624142;3939.2318497892634;3940.2907476653904;1551.9146446945301;1912.5123093611319;1915.683912154479;1916.3580200632944;1916.4154932745369;372.68135743939087;382.14971687994546;420.8653230966061;829.2785276809094;894.0924961164424;11560.710982225344;11578.568500614965;11715.941420293015;12064.879351206551;12066.276023438622;381.44880647464703;423.8156401965155;437.44881449373383;438.99689210154645;442.0253341382244;5578.497935185772;5681.886362272731;6097.085437184458;6211.503079753609;6244.0964951297865;415106;490395;500633;584510;592605;67663;68311.31688683148;69368;94301;111848;973.4062222044547;995.7602784533158;1002.5989604158395;1043.1029314789275;1045.4197920154388;17865.73201402006;18691.813081869008;18895.527611809815;19195.32816351421;19224.615507690047;51671.741641291555;51685.483145168066;52847;53115.67210819761;53471.66320841855;73884.63057684677;78281;78638.6068069656;81078.3784324322;81223.59388203021;7311.3785328247695;7743.5353878767455;7971.521708697497;7983.680652774056;8195.746169803113;11435;12324.198927069712;12587.370631468573;12622.873771262537;12684.048696347996;10036.297459177787;10374.533146008598;10523.63192784933;10694;10882.45587720595;4782.067496838223;8069.556174410463;8882.40116778986;10256.230782691477;10590.735231619272;11176.70877470133;11572.18994670365;11656.941715291709;11793.705157371134;11847.111466639864;7792.376609871083;7866.646000930086;7962.442629015914;8355.331573473986;8390.202930721573;8291.709790157556;10001.54993025301;10874.67375978722;11169;11432.714182145513 17:16:56 INFO - PROCESS | 1654 | |3;mootools.html;1357.0026030867316;1519.4378080110357;1529.5946574157847;1738.5132162994357;1915.7605299337583;7824.256695613914;8288.378371622122;8320.875186872194;8798.120187981198;8810.86783698245;8619.224269815715;8690.739277821676;8701.608427620757;8706.347023973212;8739.475631462117;2335.1009861203434;2364.444355576447;2365.124903785602;2367.739548649647;2376.310869847742;2307.261676263596;2309.6535519672016;2355.599548076831;2358.080348664014;2365.775251351119;2322.7212734471887;2348.342464110052;2357.1514254868234;2360.752121027293;2362.4684445999683;2294.89672964717;2324.244620498336;2330.6737056811976;2335.6262997920253;2342.8828558572004;2313.271319534358;2322.3613506285906;2326.4765427778784;2329.219711396667;2330.044681680503;8554.144585541397;8647;8701.521416322099;8716.956415217883;8758.2993360531;5088.084144853925;5342.893142137135;5355.464453554652;5361.705106219157;5373.328333958255;3432.6052503962114;3580.445031020196;3656.8171591420323;3660.249648821985;3669.5779985301765;933.276710549323;939.6221996721591;971.6793458158791;986.5511192407438;990.3315262197988;11444.48499817502;11459.484323205392;11544.942275288653;11597.13021523389;11597.246178998423;4330.566943305645;4333.285007973649;4491.775411229425;4520.977395113069;4571.885702857455;8993.41542799729;8996.145366190201;8999.32505062123;9010.234130099016;9025.368224224372;5191.091558977164;5205.089109405839;5205.869853253699;5206.193040078794;5208.8437346879655;4100.507939047274;4293.785310734451;4525.366448697185;4539.614132798749;4861.295112208781;3492.650734926538;3791.6208379161862;3796.6393192646656;3803.82882770276;3805.752626079296;1137.7553825927466;1162.0819552553558;1167.550493060161;1171.888670576311;1174.682835634391;799.8360336131195;909.2089881802742;921.4517362169498;940.4952076677262;950.7813202963218;4980.7509624518625;5542.251796007487;5785.363610002896;5947.375525569752;6054.364291749391;383.1627893053687;389.8089935931373;391.36598710089265;393.9586343433898;948.3835506920557;3650.9817450913106;3835.5780864104927;3902.66827319681;3928.489296391508;4037.4549435826375;8798.428102173466;10624.203184761174;10700.30448020876;10720.517576709066;10738.570457181626;9845.704628861145;10529.84205236922;10658;10663.73340666474;10674;7955.24425179607;8024.959875200587;8027.879581806277;8035.959820200862;8057.274845263954;4446.62203712688;5771.220885180447;6000.5799594028;6023.27720673522;6243.875122497434;9875.259355548218;9887.357321774061;9922.40465572068;10088.747781305232;10091.495425228562;9029.27765778723;9702.126808587262;9844.409335439897;9966;10147.79704405893;7003.929960700328;7490.5131166474;7561.168271490022;7631.923680763121;7645.961770191114;8150.144234855255;8226.012878454385;8237.299829514559;8309.252167304972;8310.875336870073;7363.079615048119;7385.8522829542035;7467.1039475263315;7472.364848987897;7576.924230757621;7207.171175314906;7236.493445458767;7306.415486761152;7360.411167106726;7453.701851925862;6877.862442751017;6904.206016307988;6908.758193463204;6984.441244700311;6992.860142797013;4791.976040119777;4825;4846.830360937351;4854;4985.52637499437;4895.608351331956;4924.606031517542;5008.298838162733;5052.8484145475695;5135.691858488353 17:16:56 INFO - PROCESS | 1654 | |4;prototype.html;295.1043582726425;302.65497333040327;312.3238189320122;318.3791606367584;319.31666234258677;4281.743095414274;4779.3786807715;4973.726445045521;5306.3632364116265;5378.8924221515545;4355.847545335914;4911.631627627933;4916.508349165082;4947.480514545975;5241.685498870071;3344.0302312329395;4090.509138903336;4094.4472496213;4127;4129.587041295861;3500.086294040785;4078.9592104079024;4082.6121518455698;4131.132462182945;4135.338345864662;3408.386490431721;4079.73481723687;4084.36692312692;4106.466159399289;4142.8757137285775;3603.261331427051;4072.6131017553284;4078.082431452929;4087.4073259377374;4104.281750693616;3013.6835632258517;3129.233337832223;3464.6535346465403;3562.09166662502;3595.227026189356;4547.977260113711;4593.966357569553;4780;5260.843493903627;5295.364556253275;3879.670228030621;4347.913021744564;4367.6069153776;4652.930206046912;4681.50844161365;5368.30212072432;5631.690257035862;5635.647444613304;5676.631018983753;5723.456271654186;3044.4215599036334;3194.472911969522;3880.3597406427907;3886.1839013807135;3889.2610404023144;5641.68970706611;5791.594588378815;5919.585629005971;5933.22868027158;5957.225560677084;3931.9017024574614;3935.7244992850797;3947.085663453223;3970.451523905679;3971.2851686696094;3355.7818741782194;3587.1623641981355;3852.24881148179;3982.3230050891416;3995.600439955981;4593.678442508993;4600.976995115003;4605.706919552469;4609.792559334771;4667.183242932473;5230.241614965808;5701.743421546041;5703.828885133453;5742.712864356766;5768.211854325173;1186.7329850783506;1214.6578031275315;1296.7406518696298;1312.1995582694549;1333.6732500537237;857.4083882121316;887.2059506741431;894.9821003579892;901.2924853989587;905.1762895764822;4668.50980647034;4939.8885250818275;5200.271961925334;5202.583793296527;5223.764930578133;4702.106599746037;4838.959623680855;4985.329914478618;5658.773649054074;5734.254546908958;5124.128898087334;5163.870903227375;5165.096108181053;5178.6374953752875;5180.300659411007;2501.4121681404854;2522.5963845784586;2534.797216222698;2539.3143851160453;2576.5233431815172;4450.46594408673;4681.578657920803;4923.187674033816;4924;4932.90134197314;4047.534533528623;4437.534058923831;4660.650451216173;4686.789094490688;4929.718273248981;4084.5492704377134;4873.926891096708;4875.463698993108;4945.982950400253;4986.2271347940405;4120.979395103005;4723.834665786819;4731.9763401184155;4760.4763476016915;4775.7373344464995;4698.671093023592;4707.6704630676895;4712.316714076508;4734.834280800155;4738.360321356573;4383.167198232326;4708.858734237979;4895.510448955076;4933.605311574994;4963.379577552806;2791.804573679823;2941.3087924337337;3183.952240716345;3323.401787678241;3341.2315167512093;4244.405783190294;4694.723059316298;4759.454206616093;4790.909863138326;4876.902461950812;3797.3924172132324;3929.5088113985753;4482.394876691605;4619.88450288732;4642.117997580449;4189.874303770892;4270.530241673476;4534.977325113486;4574.588287054181;4601.263797792337;4098.4467096941535;4690.484046754923;5109.897802044013;5476.959377718221;5509.146082357241;4982.701037937591;5446.400895901527;5447.237386765777;5641.210230567642;5661.197707134995;4461.02968358155;5454.91817622728;5471.835844924659;5476.780928762964;5481.260029895913 17:16:56 INFO - PROCESS | 1654 | |5;yui.html;740.8220928723332;757.8749506331454;768.8961990131334;779.5985067690137;871.0984131423977;15148.621284467894;15906.840931590696;15912;15934.123623200734;16299.83700162998;14329.498467553638;14463.20452375119;14469.493567725132;14488.348024338904;14501.637459063528;868.0885070675781;884.1732979664002;885.3536918049828;885.6545947080643;885.6723012485357;860.7331727164599;885.6368888755611;887.219247062584;888.6356593796545;889.2130464538865;942.5051847779936;944.8629948657441;953.9713808585719;959.0840747086551;959.592173326337;952.3666761603525;952.4523399045577;954.0268925695786;954.0268925695786;956.1442508954447;702.7891632510277;702.817267510451;703.022798310349;704.8061783009662;704.8977898204782;12082.15424920256;12573.622791316184;12588.496460141583;14873.47942821996;15524.301406436738;14263.429462821474;15038.849611503963;15062.774058389134;15115.16866572338;15184.544463666107;9485.577163425472;11879.22785018971;11929.224600401032;11949.103817213743;12029.819552706716;3804.2962052020466;3812.6568608825337;3832.367659336206;3833.4441505981754;3936.0159960009996;114813;117116.99999999914;119918;121288;121511;11312.94343528277;11365.812279561704;11482.598109066143;11486.540538378371;11604.129690273263;19651.705224421647;23905.16331928374;23924.282271531883;23965.7603423967;24011.399715007265;7944.086430060502;8148.755537333889;8258.545779982158;8395.83208335842;8406.831863362699;4330.350447432847;4508.368828364031;4565.315202719618;4586.885327866763;4731.006488637425;3633.94549081764;3739.8130093495215;3802.619738026175;3810.7332486725663;3819.1979684266616;622.7664625765339;630.8170630517191;632.1434456311723;643.8068579426154;646.1374065622352;620.3765215958024;629.8330942300294;676.1987045351275;676.5906626491001;687.220005293985;7474.626268686544;7959.641816118288;8795.361391582499;9414.105659962293;9456.952715236379;636.898096304589;654.0875478707177;665.7763071341742;693.1855070292487;694.1496666583395;4418.823247070081;4477.1493416250805;4562.1560011398;4566.680332376702;4684.344191813149;139577.30211348878;154364.36906892812;154703.22648386686;162763;167912;111806.8450528936;126836;129047.12858614257;129587;130730.34634826765;81856;112585;113637;114824.81921858789;115523;7691.38468922496;8314.792130196793;8640.13598640131;8860.689875854314;8920;51250.487495126064;63380.683096584224;65920;66491.71477843632;67276.6636166816;87024;92869;96884;100988.49505752718;105090.47454762677;11755.235909665844;11954.402279886144;11968.46141923598;12006.879931200576;12052.819207712068;12945.288009159587;13076.673083172996;13099.607011789662;13646.385912634154;13648.044636875324;11718.23831450953;11842.425265164235;11970.102242332034;11991.820122697993;12256.816147757612;11780.646580602595;12123.696907577381;12153.270803751802;12466.75066498683;12552.748945020865;11975.940120299343;12109.939450302692;12360.196587221802;12393.442295096922;12507.437165327765;8436.182312127936;9596.76008099803;9831.890467212235;9897.604095836086;10384.532696028848;8198.42611017247;8506.72890698709;9069.410488318239;9075.54622268897;9267.72196834096 17:16:56 INFO - PROCESS | 1654 | __end_tp_report 17:16:56 INFO - PROCESS | 1654 | __start_cc_report 17:16:56 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1766 17:16:56 INFO - PROCESS | 1654 | __end_cc_report 17:16:56 INFO - PROCESS | 1654 | __startTimestamp1476490616810__endTimestamp 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | ------- Summary: start ------- 17:16:56 INFO - PROCESS | 1654 | Number of tests: 6 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5725.47 Median:5879.12 stddev:648.96 (11.0%) stddev-sans-first:619.76 17:16:56 INFO - PROCESS | 1654 | Values: 3191.6 3338.3 3358.7 3396.4 3424.6 5544.6 5669.5 5735.6 5778.0 5832.3 5639.9 5682.6 5687.4 5698.4 5702.2 5111.3 5159.7 5160.9 5177.0 5199.1 5299.2 5304.4 5317.8 5318.5 5326.3 4112.3 5182.7 5214.7 5246.2 5277.6 5200.4 5259.9 5276.5 5278.0 5346.9 5045.3 5159.0 5174.7 5212.7 5222.0 5618.3 5620.3 5633.5 5661.1 5676.6 6192.2 6240.6 6241.9 6252.4 6262.7 6123.2 6244.2 6312.9 6314.5 6319.1 5712.8 5774.1 5775.9 5791.1 5879.1 6209.8 6240.3 6245.3 6248.8 6256.5 6168.9 6190.8 6194.8 6198.9 6205.9 6079.8 6176.4 6186.2 6240.0 6240.7 6124.5 6124.8 6141.8 6210.7 6213.9 6187.1 6226.5 6228.7 6239.4 6246.7 4839.3 4848.5 4901.0 4912.6 4935.2 4395.0 4404.6 4440.2 4454.9 4463.0 5760.8 5801.8 5801.9 5819.8 5829.3 6243.4 6256.5 6278.9 6306.5 6308.7 5662.9 5728.6 5736.8 5753.3 5784.1 5393.5 5413.2 5417.5 5446.7 5456.6 6303.0 6309.3 6318.2 6339.6 6341.2 6091.1 6152.9 6285.7 6306.5 6334.4 5077.5 6197.9 6209.1 6278.4 6404.5 6202.7 6203.6 6208.6 6213.1 6217.2 5528.4 6041.5 6275.8 6304.8 6320.5 5912.6 5919.8 5923.5 6091.8 6116.8 6121.3 6123.2 6123.6 6127.7 6134.9 5934.6 6012.3 6013.0 6030.7 6053.5 5642.9 6102.2 6164.8 6165.1 6171.4 5706.7 5725.2 5726.4 5729.9 5731.3 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:65412.24 Median:40063.50 stddev:141577.36 (353.4%) stddev-sans-first:141890.57 17:16:56 INFO - PROCESS | 1654 | Values: 474.0 485.8 494.0 517.8 551.9 30546.1 31154.4 32149.4 32152.0 32183.0 32318.7 35090.0 41891.0 45210.8 45389.8 8109.3 9675.1 9692.5 9693.6 9705.9 9536.3 9574.0 9589.0 9598.6 9605.6 9602.0 9657.3 9659.3 9681.9 9732.6 9521.9 9589.3 9594.3 9610.9 9622.5 9401.2 9434.5 9501.7 9510.0 9528.0 40511.4 40747.4 40758.8 40772.8 40792.4 3613.7 3939.7 4064.9 4163.5 4235.9 30188.2 30614.0 30695.8 31635.5 31692.5 2726.3 3192.2 3203.9 3210.0 3241.9 489538.0 490374.0 493699.0 493936.0 507302.0 59883.8 59930.3 60063.7 60107.7 60138.7 34545.1 34971.1 35088.5 36517.5 62439.7 16728.7 16841.1 16857.8 16907.4 16946.8 12773.1 12789.3 12835.4 12845.9 12846.4 19226.0 19239.3 19289.4 19295.3 19327.8 7708.3 7750.7 7782.2 7814.3 7858.4 846.2 892.0 973.5 975.6 1019.1 29696.6 29830.9 30135.7 30557.7 30719.5 855.7 1023.6 1043.0 1063.5 1087.7 13454.4 15567.6 15667.5 15873.1 16037.4 640756.0 646675.0 648633.0 649442.0 650293.0 48526.5 58085.4 58627.7 58899.7 58923.7 1233.8 1272.8 1337.7 1362.8 1382.6 28704.0 29286.9 30226.0 30728.7 31213.7 48979.8 49657.8 49721.8 49791.8 49792.5 421097.0 422182.0 423369.0 423537.0 423990.0 23172.0 23304.7 25934.4 26208.2 26398.2 45113.5 46847.8 47210.5 47282.0 47567.5 38659.0 38802.4 38916.4 40001.0 40126.0 38409.4 38870.2 39193.8 39737.8 40675.6 37899.4 38558.6 38733.2 39005.4 39238.0 33827.2 34211.0 35124.5 35369.6 35807.6 22945.9 24011.8 25243.9 25621.1 25891.1 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:30550.03 Median:2172.02 stddev:86982.17 (4004.7%) stddev-sans-first:87196.52 17:16:56 INFO - PROCESS | 1654 | Values: 295.7 371.8 373.6 381.7 403.7 15180.7 15436.9 16461.6 20728.9 21251.8 18066.2 19961.9 20874.3 21651.4 21842.9 5261.6 5725.8 6009.2 6016.7 6022.8 5607.7 5779.1 5958.3 5974.6 5989.5 5603.4 5915.7 5925.2 5927.0 5929.0 5044.8 5781.5 5949.1 5956.1 5961.8 5501.8 5702.9 5729.6 5739.5 5781.0 13116.3 13176.4 13322.5 13328.7 24733.0 2154.1 2196.9 2252.5 2285.9 2391.1 9880.0 10197.2 10783.5 10882.8 15528.0 1785.3 1790.6 1792.0 1824.8 1860.0 111245.7 119279.0 121125.4 121859.0 122052.4 8381.2 9129.5 9767.3 9820.0 9950.2 12336.1 12359.6 12380.8 12386.4 12402.7 7816.3 8081.9 8138.8 8208.0 8304.3 8252.6 8461.8 8523.4 8647.7 8715.8 3760.4 3806.8 3832.9 3939.2 3940.3 1551.9 1912.5 1915.7 1916.4 1916.4 372.7 382.1 420.9 829.3 894.1 11560.7 11578.6 11715.9 12064.9 12066.3 381.4 423.8 437.4 439.0 442.0 5578.5 5681.9 6097.1 6211.5 6244.1 415106.0 490395.0 500633.0 584510.0 592605.0 67663.0 68311.3 69368.0 94301.0 111848.0 973.4 995.8 1002.6 1043.1 1045.4 17865.7 18691.8 18895.5 19195.3 19224.6 51671.7 51685.5 52847.0 53115.7 53471.7 73884.6 78281.0 78638.6 81078.4 81223.6 7311.4 7743.5 7971.5 7983.7 8195.7 11435.0 12324.2 12587.4 12622.9 12684.0 10036.3 10374.5 10523.6 10694.0 10882.5 4782.1 8069.6 8882.4 10256.2 10590.7 11176.7 11572.2 11656.9 11793.7 11847.1 7792.4 7866.6 7962.4 8355.3 8390.2 8291.7 10001.5 10874.7 11169.0 11432.7 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5581.77 Median:5070.47 stddev:3147.74 (62.1%) stddev-sans-first:3140.55 17:16:56 INFO - PROCESS | 1654 | Values: 1357.0 1519.4 1529.6 1738.5 1915.8 7824.3 8288.4 8320.9 8798.1 8810.9 8619.2 8690.7 8701.6 8706.3 8739.5 2335.1 2364.4 2365.1 2367.7 2376.3 2307.3 2309.7 2355.6 2358.1 2365.8 2322.7 2348.3 2357.2 2360.8 2362.5 2294.9 2324.2 2330.7 2335.6 2342.9 2313.3 2322.4 2326.5 2329.2 2330.0 8554.1 8647.0 8701.5 8717.0 8758.3 5088.1 5342.9 5355.5 5361.7 5373.3 3432.6 3580.4 3656.8 3660.2 3669.6 933.3 939.6 971.7 986.6 990.3 11444.5 11459.5 11544.9 11597.1 11597.2 4330.6 4333.3 4491.8 4521.0 4571.9 8993.4 8996.1 8999.3 9010.2 9025.4 5191.1 5205.1 5205.9 5206.2 5208.8 4100.5 4293.8 4525.4 4539.6 4861.3 3492.7 3791.6 3796.6 3803.8 3805.8 1137.8 1162.1 1167.6 1171.9 1174.7 799.8 909.2 921.5 940.5 950.8 4980.8 5542.3 5785.4 5947.4 6054.4 383.2 389.8 391.4 394.0 948.4 3651.0 3835.6 3902.7 3928.5 4037.5 8798.4 10624.2 10700.3 10720.5 10738.6 9845.7 10529.8 10658.0 10663.7 10674.0 7955.2 8025.0 8027.9 8036.0 8057.3 4446.6 5771.2 6000.6 6023.3 6243.9 9875.3 9887.4 9922.4 10088.7 10091.5 9029.3 9702.1 9844.4 9966.0 10147.8 7003.9 7490.5 7561.2 7631.9 7646.0 8150.1 8226.0 8237.3 8309.3 8310.9 7363.1 7385.9 7467.1 7472.4 7576.9 7207.2 7236.5 7306.4 7360.4 7453.7 6877.9 6904.2 6908.8 6984.4 6992.9 4792.0 4825.0 4846.8 4854.0 4985.5 4895.6 4924.6 5008.3 5052.8 5135.7 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4226.02 Median:4656.79 stddev:1280.62 (27.5%) stddev-sans-first:1249.76 17:16:56 INFO - PROCESS | 1654 | Values: 295.1 302.7 312.3 318.4 319.3 4281.7 4779.4 4973.7 5306.4 5378.9 4355.8 4911.6 4916.5 4947.5 5241.7 3344.0 4090.5 4094.4 4127.0 4129.6 3500.1 4079.0 4082.6 4131.1 4135.3 3408.4 4079.7 4084.4 4106.5 4142.9 3603.3 4072.6 4078.1 4087.4 4104.3 3013.7 3129.2 3464.7 3562.1 3595.2 4548.0 4594.0 4780.0 5260.8 5295.4 3879.7 4347.9 4367.6 4652.9 4681.5 5368.3 5631.7 5635.6 5676.6 5723.5 3044.4 3194.5 3880.4 3886.2 3889.3 5641.7 5791.6 5919.6 5933.2 5957.2 3931.9 3935.7 3947.1 3970.5 3971.3 3355.8 3587.2 3852.2 3982.3 3995.6 4593.7 4601.0 4605.7 4609.8 4667.2 5230.2 5701.7 5703.8 5742.7 5768.2 1186.7 1214.7 1296.7 1312.2 1333.7 857.4 887.2 895.0 901.3 905.2 4668.5 4939.9 5200.3 5202.6 5223.8 4702.1 4839.0 4985.3 5658.8 5734.3 5124.1 5163.9 5165.1 5178.6 5180.3 2501.4 2522.6 2534.8 2539.3 2576.5 4450.5 4681.6 4923.2 4924.0 4932.9 4047.5 4437.5 4660.7 4686.8 4929.7 4084.5 4873.9 4875.5 4946.0 4986.2 4121.0 4723.8 4732.0 4760.5 4775.7 4698.7 4707.7 4712.3 4734.8 4738.4 4383.2 4708.9 4895.5 4933.6 4963.4 2791.8 2941.3 3184.0 3323.4 3341.2 4244.4 4694.7 4759.5 4790.9 4876.9 3797.4 3929.5 4482.4 4619.9 4642.1 4189.9 4270.5 4535.0 4574.6 4601.3 4098.4 4690.5 5109.9 5477.0 5509.1 4982.7 5446.4 5447.2 5641.2 5661.2 4461.0 5454.9 5471.8 5476.8 5481.3 17:16:56 INFO - PROCESS | 1654 | 17:16:56 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:25042.64 Median:4133.18 stddev:40868.06 (988.8%) stddev-sans-first:40941.97 17:16:56 INFO - PROCESS | 1654 | Values: 740.8 757.9 768.9 779.6 871.1 15148.6 15906.8 15912.0 15934.1 16299.8 14329.5 14463.2 14469.5 14488.3 14501.6 868.1 884.2 885.4 885.7 885.7 860.7 885.6 887.2 888.6 889.2 942.5 944.9 954.0 959.1 959.6 952.4 952.5 954.0 954.0 956.1 702.8 702.8 703.0 704.8 704.9 12082.2 12573.6 12588.5 14873.5 15524.3 14263.4 15038.8 15062.8 15115.2 15184.5 9485.6 11879.2 11929.2 11949.1 12029.8 3804.3 3812.7 3832.4 3833.4 3936.0 114813.0 117117.0 119918.0 121288.0 121511.0 11312.9 11365.8 11482.6 11486.5 11604.1 19651.7 23905.2 23924.3 23965.8 24011.4 7944.1 8148.8 8258.5 8395.8 8406.8 4330.4 4508.4 4565.3 4586.9 4731.0 3633.9 3739.8 3802.6 3810.7 3819.2 622.8 630.8 632.1 643.8 646.1 620.4 629.8 676.2 676.6 687.2 7474.6 7959.6 8795.4 9414.1 9457.0 636.9 654.1 665.8 693.2 694.1 4418.8 4477.1 4562.2 4566.7 4684.3 139577.3 154364.4 154703.2 162763.0 167912.0 111806.8 126836.0 129047.1 129587.0 130730.3 81856.0 112585.0 113637.0 114824.8 115523.0 7691.4 8314.8 8640.1 8860.7 8920.0 51250.5 63380.7 65920.0 66491.7 67276.7 87024.0 92869.0 96884.0 100988.5 105090.5 11755.2 11954.4 11968.5 12006.9 12052.8 12945.3 13076.7 13099.6 13646.4 13648.0 11718.2 11842.4 11970.1 11991.8 12256.8 11780.6 12123.7 12153.3 12466.8 12552.7 11975.9 12109.9 12360.2 12393.4 12507.4 8436.2 9596.8 9831.9 9897.6 10384.5 8198.4 8506.7 9069.4 9075.5 9267.7 17:16:56 INFO - PROCESS | 1654 | -------- Summary: end -------- 17:16:56 INFO - PROCESS | 1654 | 17:16:57 INFO - TEST-INFO | 1654: exit 0 17:16:57 INFO - TEST-OK | dromaeo_css | took 1119499ms 17:16:57 INFO - TEST-START | kraken 17:16:57 INFO - operating with platform_type : mac_ 17:16:57 INFO - Initialising browser for kraken test... 17:16:57 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/tmpcfv9Uu/profile http://localhost:49279/getInfo.html) 17:16:59 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 17:16:59 INFO - PROCESS | 1660 | colorDepth:24 17:16:59 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 17:16:59 INFO - PROCESS | 1660 | __metrics 17:17:00 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:17:00 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:00 INFO - TEST-INFO | 1660: exit 0 17:17:00 INFO - Browser initialized. 17:17:00 INFO - Running cycle 1/1 for kraken test... 17:17:00 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/T/tmpcfv9Uu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:12 INFO - PROCESS | 1661 | RSS: Main: 230776832 17:17:12 INFO - PROCESS | 1661 | 17:17:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:16 INFO - PROCESS | 1661 | RSS: Main: 290361344 17:17:16 INFO - PROCESS | 1661 | 17:17:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 17:17:19 INFO - PROCESS | 1661 | RSS: Main: 292065280 17:17:19 INFO - PROCESS | 1661 | 17:17:23 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 17:17:23 INFO - PROCESS | 1661 | RSS: Main: 385597440 17:17:23 INFO - PROCESS | 1661 | 17:17:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 17:17:26 INFO - PROCESS | 1661 | RSS: Main: 285736960 17:17:26 INFO - PROCESS | 1661 | 17:17:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:29 INFO - PROCESS | 1661 | RSS: Main: 290488320 17:17:29 INFO - PROCESS | 1661 | 17:17:31 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:32 INFO - PROCESS | 1661 | RSS: Main: 327925760 17:17:32 INFO - PROCESS | 1661 | 17:17:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:36 INFO - PROCESS | 1661 | RSS: Main: 328187904 17:17:36 INFO - PROCESS | 1661 | 17:17:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 17:17:39 INFO - PROCESS | 1661 | RSS: Main: 326610944 17:17:39 INFO - PROCESS | 1661 | 17:17:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:41 INFO - PROCESS | 1661 | RSS: Main: 302624768 17:17:41 INFO - PROCESS | 1661 | 17:17:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:44 INFO - PROCESS | 1661 | RSS: Main: 306102272 17:17:44 INFO - PROCESS | 1661 | 17:17:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:47 INFO - PROCESS | 1661 | RSS: Main: 308617216 17:17:47 INFO - PROCESS | 1661 | 17:17:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:51 INFO - PROCESS | 1661 | RSS: Main: 317317120 17:17:51 INFO - PROCESS | 1661 | 17:17:53 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:54 INFO - PROCESS | 1661 | RSS: Main: 316628992 17:17:54 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 17:17:56 INFO - PROCESS | 1661 | RSS: Main: 360562688 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | __start_tp_report 17:17:56 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 17:17:56 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 17:17:56 INFO - PROCESS | 1661 | |i|pagename|runs| 17:17:56 INFO - PROCESS | 1661 | |0;ai-astar;110;114;115;113;113;115;112;114;113;113 17:17:56 INFO - PROCESS | 1661 | |1;audio-beat-detection;149;114;120;181;102;138;140;141;145;112 17:17:56 INFO - PROCESS | 1661 | |2;audio-dft;184;181;203;184;183;184;180;185;233;243 17:17:56 INFO - PROCESS | 1661 | |3;audio-fft;79;59;59;88;60;57;60;61;109;83 17:17:56 INFO - PROCESS | 1661 | |4;audio-oscillator;85;69;91;69;67;70;92;83;99;122 17:17:56 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;86;89;87;89;84;90;87;88;86 17:17:56 INFO - PROCESS | 1661 | |6;imaging-darkroom;94;96;95;88;130;94;94;96;101;97 17:17:56 INFO - PROCESS | 1661 | |7;imaging-desaturate;81;84;78;80;80;81;83;100;126;121 17:17:56 INFO - PROCESS | 1661 | |8;json-parse-financial;57;58;58;58;54;57;56;56;56;56 17:17:56 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;63;67;76;77;98;99;98;83;69;69 17:17:56 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;84;96;108;83;85;95;108;105;106;86 17:17:56 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;142;143;140;146;142;148;160;146;177;144 17:17:56 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;171;170;171;185;171;170;173;169;168;171 17:17:56 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;69;70;66;85;80;89;88;87;84;68 17:17:56 INFO - PROCESS | 1661 | __end_tp_report 17:17:56 INFO - PROCESS | 1661 | __start_cc_report 17:17:56 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2023 17:17:56 INFO - PROCESS | 1661 | __end_cc_report 17:17:56 INFO - PROCESS | 1661 | __startTimestamp1476490676631__endTimestamp 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | ------- Summary: start ------- 17:17:56 INFO - PROCESS | 1661 | Number of tests: 14 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.48 (1.3%) stddev-sans-first:1.01 17:17:56 INFO - PROCESS | 1661 | Values: 110.0 114.0 115.0 113.0 113.0 115.0 112.0 114.0 113.0 113.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:140.50 stddev:23.00 (16.4%) stddev-sans-first:23.76 17:17:56 INFO - PROCESS | 1661 | Values: 149.0 114.0 120.0 181.0 102.0 138.0 140.0 141.0 145.0 112.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:196.00 Median:184.50 stddev:23.17 (12.6%) stddev-sans-first:24.16 17:17:56 INFO - PROCESS | 1661 | Values: 184.0 181.0 203.0 184.0 183.0 184.0 180.0 185.0 233.0 243.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:71.50 Median:60.50 stddev:17.53 (29.0%) stddev-sans-first:18.38 17:17:56 INFO - PROCESS | 1661 | Values: 79.0 59.0 59.0 88.0 60.0 57.0 60.0 61.0 109.0 83.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:84.00 stddev:17.37 (20.7%) stddev-sans-first:18.42 17:17:56 INFO - PROCESS | 1661 | Values: 85.0 69.0 91.0 69.0 67.0 70.0 92.0 83.0 99.0 122.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.87 17:17:56 INFO - PROCESS | 1661 | Values: 88.0 86.0 89.0 87.0 89.0 84.0 90.0 87.0 88.0 86.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:94.50 stddev:11.53 (12.2%) stddev-sans-first:12.11 17:17:56 INFO - PROCESS | 1661 | Values: 94.0 96.0 95.0 88.0 130.0 94.0 94.0 96.0 101.0 97.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:91.40 Median:80.50 stddev:18.04 (22.4%) stddev-sans-first:18.74 17:17:56 INFO - PROCESS | 1661 | Values: 81.0 84.0 78.0 80.0 80.0 81.0 83.0 100.0 126.0 121.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.26 (2.2%) stddev-sans-first:1.33 17:17:56 INFO - PROCESS | 1661 | Values: 57.0 58.0 58.0 58.0 54.0 57.0 56.0 56.0 56.0 56.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:79.90 Median:80.00 stddev:13.92 (17.4%) stddev-sans-first:13.35 17:17:56 INFO - PROCESS | 1661 | Values: 63.0 67.0 76.0 77.0 98.0 99.0 98.0 83.0 69.0 69.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:95.60 Median:84.50 stddev:10.55 (12.5%) stddev-sans-first:10.33 17:17:56 INFO - PROCESS | 1661 | Values: 84.0 96.0 108.0 83.0 85.0 95.0 108.0 105.0 106.0 86.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:146.00 stddev:11.37 (7.8%) stddev-sans-first:11.79 17:17:56 INFO - PROCESS | 1661 | Values: 142.0 143.0 140.0 146.0 142.0 148.0 160.0 146.0 177.0 144.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:171.00 stddev:4.79 (2.8%) stddev-sans-first:5.07 17:17:56 INFO - PROCESS | 1661 | Values: 171.0 170.0 171.0 185.0 171.0 170.0 173.0 169.0 168.0 171.0 17:17:56 INFO - PROCESS | 1661 | 17:17:56 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.60 Median:84.50 stddev:9.29 (11.0%) stddev-sans-first:9.18 17:17:56 INFO - PROCESS | 1661 | Values: 69.0 70.0 66.0 85.0 80.0 89.0 88.0 87.0 84.0 68.0 17:17:56 INFO - PROCESS | 1661 | -------- Summary: end -------- 17:17:56 INFO - PROCESS | 1661 | 17:17:57 INFO - TEST-INFO | 1661: exit 0 17:17:57 INFO - TEST-OK | kraken | took 60084ms 17:17:57 INFO - SUITE-END | took 1179s 17:17:57 INFO - Completed test suite (00:19:39) 17:17:57 INFO - javascript benchmark 17:17:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3191.6489186189515, 3338.3323335332934, 3358.7480938929584, 3396.422608156613, 3424.589049314083, 5544.556435485161, 5669.489745922866, 5735.569832262581, 5778.0, 5832.300123985127, 5639.915401268984, 5682.602217844742, 5687.374388817227, 5698.373178950312, 5702.201691763146, 5111.284420181178, 5159.664621799589, 5160.948390516084, 5177.042247184264, 5199.09015922214, 5299.178627312754, 5304.3634763828395, 5317.7607007684555, 5318.494742999409, 5326.280952071459, 4112.259793237216, 5182.714950677711, 5214.661047031931, 5246.213068039806, 5277.604179686519, 5200.427952925175, 5259.921101183485, 5276.472352764731, 5277.973610131925, 5346.919796203021, 5045.344105266328, 5159.0, 5174.715390653512, 5212.6611770235195, 5222.0, 5618.325800903876, 5620.269364982567, 5633.464820842013, 5661.094224924033, 5676.602637815355, 6192.225971753531, 6240.563160578761, 6241.875162496724, 6252.3747625237565, 6262.686865656745, 6123.1914755765065, 6244.188255526798, 6312.873742525169, 6314.526410519184, 6319.115323854664, 5712.828615141552, 5774.076147816413, 5775.88448231033, 5791.131330300489, 5879.118132280192, 6209.75804839034, 6240.31356550779, 6245.250569931637, 6248.781292654735, 6256.499480041586, 6168.907466388007, 6190.81427557174, 6194.752209911643, 6198.876022479615, 6205.913965056097, 6079.756809727562, 6176.4441200292185, 6186.1648677428875, 6240.00159974402, 6240.687965601702, 6124.474457250848, 6124.816255512342, 6141.792871882774, 6210.72051757672, 6213.875722485615, 6187.133801267826, 6226.470749986302, 6228.688565571703, 6239.376062393724, 6246.6876656167005, 4839.322494850724, 4848.490908454632, 4901.044296362246, 4912.606991440676, 4935.185694360463, 4395.0, 4404.581564751344, 4440.222960981815, 4454.910901782011, 4462.995825939138, 5760.84783043393, 5801.796937107181, 5801.854953626109, 5819.76720931158, 5829.329627092939, 6243.375662433811, 6256.499480041586, 6278.937210627835, 6306.527010474141, 6308.716107775161, 5662.943370566324, 5728.627639203439, 5736.799212027559, 5753.309602847685, 5784.1034639630925, 5393.514583687487, 5413.242146099549, 5417.5395091416885, 5446.673199608036, 5456.61803673739, 6302.960011598035, 6309.305976342507, 6318.178636777189, 6339.5562310637815, 6341.239051313687, 6091.086337049478, 6152.892479353759, 6285.654289013965, 6306.4639505642535, 6334.3665633436285, 5077.517635824591, 6197.938020619736, 6209.099680546386, 6278.4035516625845, 6404.4876409886165, 6202.658853763086, 6203.627782333075, 6208.596441231305, 6213.099100630293, 6217.191765070512, 5528.419515950767, 6041.456268935817, 6275.780347687809, 6304.779332723333, 6320.5259605528845, 5912.586118971631, 5919.822405327847, 5923.526117910471, 6091.847703807441, 6116.847078823065, 6121.300552271563, 6123.1606109212, 6123.5876691309595, 6127.678242056131, 6134.865219626364, 5934.643921364732, 6012.278526576839, 6012.969935150296, 6030.7286172121485, 6053.4551890330085, 5642.915356269741, 6102.176206212104, 6164.753409863555, 6165.075238714228, 6171.352008039091, 5706.657600543981, 5725.227094342211, 5726.398728133652, 5729.885402292014, 5731.254936858182], "value": 5683.768656371495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.9715617062976, 485.83238782619986, 493.9753012349382, 517.8135871086406, 551.8620344913771, 30546.083617491484, 31154.376912461736, 32149.357012859728, 32151.99999999997, 32183.0, 32318.67681323186, 35090.0, 41891.0, 45210.773946130306, 45389.773051134696, 8109.310708589762, 9675.129238368545, 9692.515374231296, 9693.612255509772, 9705.854412183788, 9536.332456728032, 9574.0, 9589.041095890425, 9598.568064437117, 9605.567749451291, 9602.0, 9657.32398732089, 9659.275554333453, 9681.903180968206, 9732.610695572168, 9521.857172142389, 9589.328746987714, 9594.28042896782, 9610.90389096107, 9622.470764107971, 9401.153896149379, 9434.481103539303, 9501.667441639578, 9509.953905070437, 9527.952360238223, 40511.392329115086, 40747.38878916819, 40758.79620601878, 40772.77681669555, 40792.388114178015, 3613.728970327236, 3939.72421930465, 4064.8983775405554, 4163.542010378856, 4235.9364609530885, 30188.24529386761, 30614.0, 30695.846520767478, 31635.525467118012, 31692.524612130837, 2726.3184203949013, 3192.197292492272, 3203.8878639247514, 3209.9679003209903, 3241.9027429177163, 489538.0, 490374.0, 493699.0, 493936.0, 507302.0, 59883.80232395328, 59930.30313635897, 60063.69968150131, 60107.69946150329, 60138.699306503186, 34545.13637159041, 34971.125721856646, 35088.47367289493, 36517.45223821645, 62439.68780156161, 16728.749068763977, 16841.07374094412, 16857.819952603444, 16907.40824071176, 16946.830531694526, 12773.105882588316, 12789.296588687526, 12835.358232088358, 12845.871541284654, 12846.421911014028, 19226.03869806532, 19239.326623568108, 19289.421317360502, 19295.324663636704, 19327.8067219326, 7708.344790692854, 7750.689972401154, 7782.182870798598, 7814.2576455237795, 7858.371330293563, 846.1792061700141, 891.9598618062203, 973.454865275448, 975.5853762151057, 1019.0522813783105, 29696.554551681744, 29830.850845745634, 30135.69864301373, 30557.69442305593, 30719.539206911915, 855.7133360324236, 1023.646841839579, 1042.9739256518496, 1063.5373612478597, 1087.7280679830042, 13454.425495331634, 15567.61080972962, 15667.529974100795, 15873.07875138655, 16037.358505659642, 640756.0, 646675.0, 648633.0, 649442.0, 650293.0, 48526.5147348522, 58085.419145808846, 58627.70686146542, 58899.70550147222, 58923.70538147282, 1233.8334324866207, 1272.815441760958, 1337.7324535092825, 1362.7615167345873, 1382.6197795606088, 28703.9533467144, 29286.853565732035, 30226.0, 30728.692713073477, 31213.68786312108, 48979.75510122427, 49657.75171124121, 49721.75139124426, 49791.75104124601, 49792.50622481331, 421097.0, 422182.0072387, 423369.0, 423537.0, 423990.0, 23171.95726192359, 23304.6504302439, 25934.35164120912, 26208.213753587424, 26398.20805375842, 45113.548864510936, 46847.828804280165, 47210.527894721985, 47282.0, 47567.52432475631, 38659.0, 38802.417963730004, 38916.41625375678, 40001.0, 40126.0, 38409.42385864158, 38870.2225955485, 39193.80403097966, 39737.80131099326, 40675.59324406836, 37899.431508527945, 38558.6144138555, 38733.2253354937, 39005.414918776805, 39238.01904952399, 33827.15432114217, 34211.0, 35124.473132903535, 35369.5723897974, 35807.64192358043, 22945.915187779035, 24011.75988240095, 25243.87378063098, 25621.10326138576, 25891.0938117165], "value": 19452.992788196672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.7294075920533, 371.80480247869866, 373.6413043478261, 381.7213434193039, 403.7476577139288, 15180.696386072286, 15436.922815385922, 16461.588460288483, 20728.896355518238, 21251.787482125175, 18066.18702158406, 19961.900190499025, 20874.26940057098, 21651.350459486202, 21842.89078554609, 5261.605379596526, 5725.828225153242, 6009.188759517453, 6016.669083200422, 6022.759089636409, 5607.663540187602, 5779.133130030487, 5958.314793798703, 5974.55190860685, 5989.460948514633, 5603.411641777616, 5915.733791979371, 5925.170476133345, 5927.0, 5929.0, 5044.772985215674, 5781.508571771405, 5949.107633854913, 5956.106584012389, 5961.791337303217, 5501.807436739735, 5702.914456283159, 5729.627574207705, 5739.454751798614, 5781.046127388976, 13116.27860467674, 13176.379737937626, 13322.533711320057, 13328.666783330398, 24733.0, 2154.062982602573, 2196.879171645559, 2252.549490101986, 2285.897134628929, 2391.0794344177443, 9879.950600247024, 10197.18422526196, 10783.46082695862, 10882.782344353147, 15528.0, 1785.3394244129624, 1790.5523619095227, 1791.9910400447914, 1824.8083951185067, 1860.0, 111245.67214736393, 119279.0, 121125.39437302845, 121859.0, 122052.38973805163, 8381.234192716389, 9129.452232865917, 9767.267454940766, 9820.0, 9950.203983681287, 12336.136470446983, 12359.567415140607, 12380.81428778569, 12386.442610082568, 12402.689932751753, 7816.335611473089, 8081.878771818428, 8138.837223255502, 8207.95896020528, 8304.294134998472, 8252.628631711588, 8461.830763384698, 8523.445976011539, 8647.654093836301, 8715.825683486295, 3760.3795373763023, 3806.8096595170687, 3832.9425058624142, 3939.2318497892634, 3940.2907476653904, 1551.9146446945301, 1912.5123093611319, 1915.683912154479, 1916.3580200632944, 1916.4154932745369, 372.68135743939087, 382.14971687994546, 420.8653230966061, 829.2785276809094, 894.0924961164424, 11560.710982225344, 11578.568500614965, 11715.941420293015, 12064.879351206551, 12066.276023438622, 381.44880647464703, 423.8156401965155, 437.44881449373383, 438.99689210154645, 442.0253341382244, 5578.497935185772, 5681.886362272731, 6097.085437184458, 6211.503079753609, 6244.0964951297865, 415106.0, 490395.0, 500633.0, 584510.0, 592605.0, 67663.0, 68311.31688683148, 69368.0, 94301.0, 111848.0, 973.4062222044547, 995.7602784533158, 1002.5989604158395, 1043.1029314789275, 1045.4197920154388, 17865.73201402006, 18691.813081869008, 18895.527611809815, 19195.32816351421, 19224.615507690047, 51671.741641291555, 51685.483145168066, 52847.0, 53115.67210819761, 53471.66320841855, 73884.63057684677, 78281.0, 78638.6068069656, 81078.3784324322, 81223.59388203021, 7311.3785328247695, 7743.5353878767455, 7971.521708697497, 7983.680652774056, 8195.746169803113, 11435.0, 12324.198927069712, 12587.370631468573, 12622.873771262537, 12684.048696347996, 10036.297459177787, 10374.533146008598, 10523.63192784933, 10694.0, 10882.45587720595, 4782.067496838223, 8069.556174410463, 8882.40116778986, 10256.230782691477, 10590.735231619272, 11176.70877470133, 11572.18994670365, 11656.941715291709, 11793.705157371134, 11847.111466639864, 7792.376609871083, 7866.646000930086, 7962.442629015914, 8355.331573473986, 8390.202930721573, 8291.709790157556, 10001.54993025301, 10874.67375978722, 11169.0, 11432.714182145513], "value": 8426.120303729047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.0026030867316, 1519.4378080110357, 1529.5946574157847, 1738.5132162994357, 1915.7605299337583, 7824.256695613914, 8288.378371622122, 8320.875186872194, 8798.120187981198, 8810.86783698245, 8619.224269815715, 8690.739277821676, 8701.608427620757, 8706.347023973212, 8739.475631462117, 2335.1009861203434, 2364.444355576447, 2365.124903785602, 2367.739548649647, 2376.310869847742, 2307.261676263596, 2309.6535519672016, 2355.599548076831, 2358.080348664014, 2365.775251351119, 2322.7212734471887, 2348.342464110052, 2357.1514254868234, 2360.752121027293, 2362.4684445999683, 2294.89672964717, 2324.244620498336, 2330.6737056811976, 2335.6262997920253, 2342.8828558572004, 2313.271319534358, 2322.3613506285906, 2326.4765427778784, 2329.219711396667, 2330.044681680503, 8554.144585541397, 8647.0, 8701.521416322099, 8716.956415217883, 8758.2993360531, 5088.084144853925, 5342.893142137135, 5355.464453554652, 5361.705106219157, 5373.328333958255, 3432.6052503962114, 3580.445031020196, 3656.8171591420323, 3660.249648821985, 3669.5779985301765, 933.276710549323, 939.6221996721591, 971.6793458158791, 986.5511192407438, 990.3315262197988, 11444.48499817502, 11459.484323205392, 11544.942275288653, 11597.13021523389, 11597.246178998423, 4330.566943305645, 4333.285007973649, 4491.775411229425, 4520.977395113069, 4571.885702857455, 8993.41542799729, 8996.145366190201, 8999.32505062123, 9010.234130099016, 9025.368224224372, 5191.091558977164, 5205.089109405839, 5205.869853253699, 5206.193040078794, 5208.8437346879655, 4100.507939047274, 4293.785310734451, 4525.366448697185, 4539.614132798749, 4861.295112208781, 3492.650734926538, 3791.6208379161862, 3796.6393192646656, 3803.82882770276, 3805.752626079296, 1137.7553825927466, 1162.0819552553558, 1167.550493060161, 1171.888670576311, 1174.682835634391, 799.8360336131195, 909.2089881802742, 921.4517362169498, 940.4952076677262, 950.7813202963218, 4980.7509624518625, 5542.251796007487, 5785.363610002896, 5947.375525569752, 6054.364291749391, 383.1627893053687, 389.8089935931373, 391.36598710089265, 393.9586343433898, 948.3835506920557, 3650.9817450913106, 3835.5780864104927, 3902.66827319681, 3928.489296391508, 4037.4549435826375, 8798.428102173466, 10624.203184761174, 10700.30448020876, 10720.517576709066, 10738.570457181626, 9845.704628861145, 10529.84205236922, 10658.0, 10663.73340666474, 10674.0, 7955.24425179607, 8024.959875200587, 8027.879581806277, 8035.959820200862, 8057.274845263954, 4446.62203712688, 5771.220885180447, 6000.5799594028, 6023.27720673522, 6243.875122497434, 9875.259355548218, 9887.357321774061, 9922.40465572068, 10088.747781305232, 10091.495425228562, 9029.27765778723, 9702.126808587262, 9844.409335439897, 9966.0, 10147.79704405893, 7003.929960700328, 7490.5131166474, 7561.168271490022, 7631.923680763121, 7645.961770191114, 8150.144234855255, 8226.012878454385, 8237.299829514559, 8309.252167304972, 8310.875336870073, 7363.079615048119, 7385.8522829542035, 7467.1039475263315, 7472.364848987897, 7576.924230757621, 7207.171175314906, 7236.493445458767, 7306.415486761152, 7360.411167106726, 7453.701851925862, 6877.862442751017, 6904.206016307988, 6908.758193463204, 6984.441244700311, 6992.860142797013, 4791.976040119777, 4825.0, 4846.830360937351, 4854.0, 4985.52637499437, 4895.608351331956, 4924.606031517542, 5008.298838162733, 5052.8484145475695, 5135.691858488353], "value": 4416.29362703104, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.1043582726425, 302.65497333040327, 312.3238189320122, 318.3791606367584, 319.31666234258677, 4281.743095414274, 4779.3786807715, 4973.726445045521, 5306.3632364116265, 5378.8924221515545, 4355.847545335914, 4911.631627627933, 4916.508349165082, 4947.480514545975, 5241.685498870071, 3344.0302312329395, 4090.509138903336, 4094.4472496213, 4127.0, 4129.587041295861, 3500.086294040785, 4078.9592104079024, 4082.6121518455698, 4131.132462182945, 4135.338345864662, 3408.386490431721, 4079.73481723687, 4084.36692312692, 4106.466159399289, 4142.8757137285775, 3603.261331427051, 4072.6131017553284, 4078.082431452929, 4087.4073259377374, 4104.281750693616, 3013.6835632258517, 3129.233337832223, 3464.6535346465403, 3562.09166662502, 3595.227026189356, 4547.977260113711, 4593.966357569553, 4780.0, 5260.843493903627, 5295.364556253275, 3879.670228030621, 4347.913021744564, 4367.6069153776, 4652.930206046912, 4681.50844161365, 5368.30212072432, 5631.690257035862, 5635.647444613304, 5676.631018983753, 5723.456271654186, 3044.4215599036334, 3194.472911969522, 3880.3597406427907, 3886.1839013807135, 3889.2610404023144, 5641.68970706611, 5791.594588378815, 5919.585629005971, 5933.22868027158, 5957.225560677084, 3931.9017024574614, 3935.7244992850797, 3947.085663453223, 3970.451523905679, 3971.2851686696094, 3355.7818741782194, 3587.1623641981355, 3852.24881148179, 3982.3230050891416, 3995.600439955981, 4593.678442508993, 4600.976995115003, 4605.706919552469, 4609.792559334771, 4667.183242932473, 5230.241614965808, 5701.743421546041, 5703.828885133453, 5742.712864356766, 5768.211854325173, 1186.7329850783506, 1214.6578031275315, 1296.7406518696298, 1312.1995582694549, 1333.6732500537237, 857.4083882121316, 887.2059506741431, 894.9821003579892, 901.2924853989587, 905.1762895764822, 4668.50980647034, 4939.8885250818275, 5200.271961925334, 5202.583793296527, 5223.764930578133, 4702.106599746037, 4838.959623680855, 4985.329914478618, 5658.773649054074, 5734.254546908958, 5124.128898087334, 5163.870903227375, 5165.096108181053, 5178.6374953752875, 5180.300659411007, 2501.4121681404854, 2522.5963845784586, 2534.797216222698, 2539.3143851160453, 2576.5233431815172, 4450.46594408673, 4681.578657920803, 4923.187674033816, 4924.0, 4932.90134197314, 4047.534533528623, 4437.534058923831, 4660.650451216173, 4686.789094490688, 4929.718273248981, 4084.5492704377134, 4873.926891096708, 4875.463698993108, 4945.982950400253, 4986.2271347940405, 4120.979395103005, 4723.834665786819, 4731.9763401184155, 4760.4763476016915, 4775.7373344464995, 4698.671093023592, 4707.6704630676895, 4712.316714076508, 4734.834280800155, 4738.360321356573, 4383.167198232326, 4708.858734237979, 4895.510448955076, 4933.605311574994, 4963.379577552806, 2791.804573679823, 2941.3087924337337, 3183.952240716345, 3323.401787678241, 3341.2315167512093, 4244.405783190294, 4694.723059316298, 4759.454206616093, 4790.909863138326, 4876.902461950812, 3797.3924172132324, 3929.5088113985753, 4482.394876691605, 4619.88450288732, 4642.117997580449, 4189.874303770892, 4270.530241673476, 4534.977325113486, 4574.588287054181, 4601.263797792337, 4098.4467096941535, 4690.484046754923, 5109.897802044013, 5476.959377718221, 5509.146082357241, 4982.701037937591, 5446.400895901527, 5447.237386765777, 5641.210230567642, 5661.197707134995, 4461.02968358155, 5454.91817622728, 5471.835844924659, 5476.780928762964, 5481.260029895913], "value": 3831.3065058099423, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.8220928723332, 757.8749506331454, 768.8961990131334, 779.5985067690137, 871.0984131423977, 15148.621284467894, 15906.840931590696, 15912.0, 15934.123623200734, 16299.83700162998, 14329.498467553638, 14463.20452375119, 14469.493567725132, 14488.348024338904, 14501.637459063528, 868.0885070675781, 884.1732979664002, 885.3536918049828, 885.6545947080643, 885.6723012485357, 860.7331727164599, 885.6368888755611, 887.219247062584, 888.6356593796545, 889.2130464538865, 942.5051847779936, 944.8629948657441, 953.9713808585719, 959.0840747086551, 959.592173326337, 952.3666761603525, 952.4523399045577, 954.0268925695786, 954.0268925695786, 956.1442508954447, 702.7891632510277, 702.817267510451, 703.022798310349, 704.8061783009662, 704.8977898204782, 12082.15424920256, 12573.622791316184, 12588.496460141583, 14873.47942821996, 15524.301406436738, 14263.429462821474, 15038.849611503963, 15062.774058389134, 15115.16866572338, 15184.544463666107, 9485.577163425472, 11879.22785018971, 11929.224600401032, 11949.103817213743, 12029.819552706716, 3804.2962052020466, 3812.6568608825337, 3832.367659336206, 3833.4441505981754, 3936.0159960009996, 114813.0, 117116.99999999914, 119918.0, 121288.0, 121511.0, 11312.94343528277, 11365.812279561704, 11482.598109066143, 11486.540538378371, 11604.129690273263, 19651.705224421647, 23905.16331928374, 23924.282271531883, 23965.7603423967, 24011.399715007265, 7944.086430060502, 8148.755537333889, 8258.545779982158, 8395.83208335842, 8406.831863362699, 4330.350447432847, 4508.368828364031, 4565.315202719618, 4586.885327866763, 4731.006488637425, 3633.94549081764, 3739.8130093495215, 3802.619738026175, 3810.7332486725663, 3819.1979684266616, 622.7664625765339, 630.8170630517191, 632.1434456311723, 643.8068579426154, 646.1374065622352, 620.3765215958024, 629.8330942300294, 676.1987045351275, 676.5906626491001, 687.220005293985, 7474.626268686544, 7959.641816118288, 8795.361391582499, 9414.105659962293, 9456.952715236379, 636.898096304589, 654.0875478707177, 665.7763071341742, 693.1855070292487, 694.1496666583395, 4418.823247070081, 4477.1493416250805, 4562.1560011398, 4566.680332376702, 4684.344191813149, 139577.30211348878, 154364.36906892812, 154703.22648386686, 162763.0, 167912.0, 111806.8450528936, 126836.0, 129047.12858614257, 129587.0, 130730.34634826765, 81856.0, 112585.0, 113637.0, 114824.81921858789, 115523.0, 7691.38468922496, 8314.792130196793, 8640.13598640131, 8860.689875854314, 8920.0, 51250.487495126064, 63380.683096584224, 65920.0, 66491.71477843632, 67276.6636166816, 87024.0, 92869.0, 96884.0, 100988.49505752718, 105090.47454762677, 11755.235909665844, 11954.402279886144, 11968.46141923598, 12006.879931200576, 12052.819207712068, 12945.288009159587, 13076.673083172996, 13099.607011789662, 13646.385912634154, 13648.044636875324, 11718.23831450953, 11842.425265164235, 11970.102242332034, 11991.820122697993, 12256.816147757612, 11780.646580602595, 12123.696907577381, 12153.270803751802, 12466.75066498683, 12552.748945020865, 11975.940120299343, 12109.939450302692, 12360.196587221802, 12393.442295096922, 12507.437165327765, 8436.182312127936, 9596.76008099803, 9831.890467212235, 9897.604095836086, 10384.532696028848, 8198.42611017247, 8506.72890698709, 9069.410488318239, 9075.54622268897, 9267.72196834096], "value": 7746.3054877327695, "unit": "score"}], "name": "dromaeo_css", "value": 7043.680822524326, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 115.0, 113.0, 113.0, 115.0, 112.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 120.0, 181.0, 102.0, 138.0, 140.0, 141.0, 145.0, 112.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 203.0, 184.0, 183.0, 184.0, 180.0, 185.0, 233.0, 243.0], "value": 196.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 60.0, 57.0, 60.0, 61.0, 109.0, 83.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 91.0, 69.0, 67.0, 70.0, 92.0, 83.0, 99.0, 122.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 87.0, 89.0, 84.0, 90.0, 87.0, 88.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 88.0, 130.0, 94.0, 94.0, 96.0, 101.0, 97.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 78.0, 80.0, 80.0, 81.0, 83.0, 100.0, 126.0, 121.0], "value": 91.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 54.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 76.0, 77.0, 98.0, 99.0, 98.0, 83.0, 69.0, 69.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 96.0, 108.0, 83.0, 85.0, 95.0, 108.0, 105.0, 106.0, 86.0], "value": 95.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 143.0, 140.0, 146.0, 142.0, 148.0, 160.0, 146.0, 177.0, 144.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 171.0, 185.0, 171.0, 170.0, 173.0, 169.0, 168.0, 171.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 85.0, 80.0, 89.0, 88.0, 87.0, 84.0, 68.0], "value": 78.6, "unit": "score"}], "name": "kraken", "value": 1508.3, "alertThreshold": 2.0}]} 17:17:57 INFO - Return code: 0 17:17:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:17:57 INFO - # TBPL SUCCESS # 17:17:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:17:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:17:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:17:57 INFO - 2016-10-14 17:17:57.962 screenresolution[1665:9882] starting screenresolution argv=screenresolution get 17:17:57 INFO - 2016-10-14 17:17:57.965 screenresolution[1665:9882] Display 0: 1600x1200x32@60 17:17:57 INFO - 2016-10-14 17:17:57.971 screenresolution[1666:9885] starting screenresolution argv=screenresolution list 17:17:57 INFO - Available Modes on Display 0 17:17:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:17:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:17:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:17:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:17:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:17:58 INFO - Intel Iris: 17:17:58 INFO - Chipset Model: Intel Iris 17:17:58 INFO - Type: GPU 17:17:58 INFO - Bus: Built-In 17:17:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:17:58 INFO - Vendor: Intel (0x8086) 17:17:58 INFO - Device ID: 0x0a2e 17:17:58 INFO - Revision ID: 0x0009 17:17:58 INFO - Displays: 17:17:58 INFO - Display: 17:17:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:17:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:17:58 INFO - Display Serial Number: 1600x1200 60 17:17:58 INFO - Main Display: Yes 17:17:58 INFO - Mirror: Off 17:17:58 INFO - Online: Yes 17:17:58 INFO - Rotation: Supported 17:17:58 INFO - Return code: 0 17:17:58 INFO - Running post-action listener: _resource_record_post_action 17:17:58 INFO - [mozharness: 2016-10-15 00:17:58.207368Z] Finished run-tests step (success) 17:17:58 INFO - Running post-run listener: _resource_record_post_run 17:17:58 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37307392; Write bytes: 709376000; Read time: 237; Write time: 1961 17:17:58 INFO - TinderboxPrint: CPU usage
53.7% 17:17:58 INFO - TinderboxPrint: I/O read bytes / time
37,307,392 / 237 17:17:58 INFO - TinderboxPrint: I/O write bytes / time
709,376,000 / 1,961 17:17:58 INFO - TinderboxPrint: CPU idle
2,248.8 (46.3%) 17:17:58 INFO - TinderboxPrint: CPU system
976.4 (20.1%) 17:17:58 INFO - TinderboxPrint: CPU user
1,636.5 (33.7%) 17:17:58 INFO - TinderboxPrint: Swap in / out
445,464,576 / 0 17:17:58 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 414431744; Write bytes: 403113472; Read time: 30508; Write time: 817 17:17:58 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29035520; Write bytes: 295899648; Read time: 172; Write time: 1106 17:17:58 INFO - Running post-run listener: _upload_blobber_files 17:17:58 INFO - Blob upload gear active. 17:17:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:17:58 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:17:58 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:17:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:00 INFO - (blobuploader) - INFO - Done attempting. 17:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:01 INFO - (blobuploader) - INFO - Done attempting. 17:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:03 INFO - (blobuploader) - INFO - Done attempting. 17:18:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:03 INFO - Return code: 0 17:18:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ee833a96652f903e6a9f3cad0330fc180b729c2d8ef102ac8463274cb747122f6f2bce3074ec94d04ff853a8b59928869da59183d6f261c63b5d80cb3609610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/374821d3fedffc9e0433f8c06f8e543d5f318f93e93bd3afaf7ac46e0ca29ab2ab80542c4730bb53335916246ef790b95e202c4a3fbccc8829c6f6550a5003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a58be5c22e336afde4ef8d62237ea9efe52952d0026b752913160f4aaf723c135e244f21c0fe09e40c2f7888d1d859182a19ab39441b2ed935ad34b8ea62d06f"} 17:18:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:03 INFO - Contents: 17:18:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ee833a96652f903e6a9f3cad0330fc180b729c2d8ef102ac8463274cb747122f6f2bce3074ec94d04ff853a8b59928869da59183d6f261c63b5d80cb3609610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/374821d3fedffc9e0433f8c06f8e543d5f318f93e93bd3afaf7ac46e0ca29ab2ab80542c4730bb53335916246ef790b95e202c4a3fbccc8829c6f6550a5003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a58be5c22e336afde4ef8d62237ea9efe52952d0026b752913160f4aaf723c135e244f21c0fe09e40c2f7888d1d859182a19ab39441b2ed935ad34b8ea62d06f"} 17:18:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:03 INFO - Copying logs to upload dir... 17:18:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.588771 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-14 17:18:04.019727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 17:18:04.027017) ========= 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.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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/Fx-Team/sha512/9ee833a96652f903e6a9f3cad0330fc180b729c2d8ef102ac8463274cb747122f6f2bce3074ec94d04ff853a8b59928869da59183d6f261c63b5d80cb3609610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/374821d3fedffc9e0433f8c06f8e543d5f318f93e93bd3afaf7ac46e0ca29ab2ab80542c4730bb53335916246ef790b95e202c4a3fbccc8829c6f6550a5003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a58be5c22e336afde4ef8d62237ea9efe52952d0026b752913160f4aaf723c135e244f21c0fe09e40c2f7888d1d859182a19ab39441b2ed935ad34b8ea62d06f"} build_url:https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011523 build_url: 'https://queue.taskcluster.net/v1/task/B6mQmQf9QB2afVxzznKJLA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ee833a96652f903e6a9f3cad0330fc180b729c2d8ef102ac8463274cb747122f6f2bce3074ec94d04ff853a8b59928869da59183d6f261c63b5d80cb3609610", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/374821d3fedffc9e0433f8c06f8e543d5f318f93e93bd3afaf7ac46e0ca29ab2ab80542c4730bb53335916246ef790b95e202c4a3fbccc8829c6f6550a5003cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a58be5c22e336afde4ef8d62237ea9efe52952d0026b752913160f4aaf723c135e244f21c0fe09e40c2f7888d1d859182a19ab39441b2ed935ad34b8ea62d06f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 17:18:04.062905) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 17:18:04.063239) ========= 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.TQpednQnXB/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.8cgvPlnL7t/Listeners TMPDIR=/var/folders/b0/r5l_zcbd7q3gp8hj0t34qjvc00000w/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.005224 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 17:18:04.112335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 17:18:04.115742) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 17:18:04.116153) ========= ========= Total master_lag: 0.19 =========