builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0252 starttime: 1479789905.94 results: success (0) buildid: 20161121182450 builduid: 62d2a20c84d84c05a229ca320e111856 revision: 8a3e765c52b23d55b39dc483e34de440e8d49ab9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:05.935388) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:05.935851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:05.936129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:05.984046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 20:45:05.984445) ========= 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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-21 20:45:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2016-11-21 20:45:06 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.493079 ========= master_lag: 1.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-21 20:45:07.992460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:08.000867) ========= 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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.025281 ========= master_lag: 0.75 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:08.778571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-21 20:45:08.782068) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 8a3e765c52b23d55b39dc483e34de440e8d49ab9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 8a3e765c52b23d55b39dc483e34de440e8d49ab9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-21 20:45:08,887 truncating revision to first 12 chars 2016-11-21 20:45:08,887 Setting DEBUG logging. 2016-11-21 20:45:08,887 attempt 1/10 2016-11-21 20:45:08,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/8a3e765c52b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 20:45:10,328 unpacking tar archive at: graphics-8a3e765c52b2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.550461 ========= master_lag: 0.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-21 20:45:12.297165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:12.297503) ========= script_repo_revision: 8a3e765c52b23d55b39dc483e34de440e8d49ab9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 20:45:12.301922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-11-21 20:45:12.302197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2016-11-21 20:45:13.979234) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-21 20:45:13.979648) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:14 INFO - MultiFileLogger online at 20161121 20:45:14 in /builds/slave/test 20:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 20:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:14 INFO - {'append_to_log': False, 20:45:14 INFO - 'base_work_dir': '/builds/slave/test', 20:45:14 INFO - 'blob_upload_branch': 'Graphics', 20:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:14 INFO - 'branch': 'Graphics', 20:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:14 INFO - 'config_files': ('talos/mac_config.py',), 20:45:14 INFO - 'default_actions': ('clobber', 20:45:14 INFO - 'read-buildbot-config', 20:45:14 INFO - 'download-and-extract', 20:45:14 INFO - 'populate-webroot', 20:45:14 INFO - 'create-virtualenv', 20:45:14 INFO - 'install', 20:45:14 INFO - 'run-tests'), 20:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:14 INFO - 'download_minidump_stackwalk': True, 20:45:14 INFO - 'download_symbols': 'ondemand', 20:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:14 INFO - 'installer_path': 'installer.exe', 20:45:14 INFO - 'log_level': 'info', 20:45:14 INFO - 'log_name': 'talos', 20:45:14 INFO - 'log_to_console': True, 20:45:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:45:14 INFO - 'opt_config_files': (), 20:45:14 INFO - 'pip_index': False, 20:45:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:14 INFO - 'cmd': ('bash', 20:45:14 INFO - '-c', 20:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:14 INFO - 'enabled': True, 20:45:14 INFO - 'halt_on_failure': False, 20:45:14 INFO - 'name': 'check_screen_resolution'},), 20:45:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:14 INFO - 'cmd': ('bash', 20:45:14 INFO - '-c', 20:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:14 INFO - 'enabled': True, 20:45:14 INFO - 'halt_on_failure': False, 20:45:14 INFO - 'name': 'check_screen_resolution'},), 20:45:14 INFO - 'run_cmd_checks_enabled': True, 20:45:14 INFO - 'sps_profile': False, 20:45:14 INFO - 'sps_profile_interval': 0, 20:45:14 INFO - 'suite': 'dromaeojs', 20:45:14 INFO - 'system_bits': '32', 20:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:14 INFO - 'title': 't-yosemite-r7-0252', 20:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:14 INFO - 'use_talos_json': True, 20:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:14 INFO - 'work_dir': 'build'} 20:45:14 INFO - [mozharness: 2016-11-22 04:45:14.193631Z] Running clobber step. 20:45:14 INFO - Running pre-action listener: _resource_record_pre_action 20:45:14 INFO - Running main action method: clobber 20:45:14 INFO - rmtree: /builds/slave/test/build 20:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:16 INFO - Running post-action listener: _resource_record_post_action 20:45:16 INFO - [mozharness: 2016-11-22 04:45:16.520611Z] Finished clobber step (success) 20:45:16 INFO - [mozharness: 2016-11-22 04:45:16.520737Z] Running read-buildbot-config step. 20:45:16 INFO - Running pre-action listener: _resource_record_pre_action 20:45:16 INFO - Running main action method: read_buildbot_config 20:45:16 INFO - Using buildbot properties: 20:45:16 INFO - { 20:45:16 INFO - "project": "", 20:45:16 INFO - "product": "firefox", 20:45:16 INFO - "script_repo_revision": "default", 20:45:16 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 20:45:16 INFO - "repository": "", 20:45:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 20:45:16 INFO - "buildid": "20161121182450", 20:45:16 INFO - "pgo_build": "False", 20:45:16 INFO - "basedir": "/builds/slave/test", 20:45:16 INFO - "buildnumber": 2, 20:45:16 INFO - "slavename": "t-yosemite-r7-0252", 20:45:16 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:45:16 INFO - "platform": "yosemite_r7", 20:45:16 INFO - "scheduler": "tests-graphics-macosx64-talos", 20:45:16 INFO - "branch": "graphics", 20:45:16 INFO - "repo_path": "projects/graphics", 20:45:16 INFO - "revision": "8a3e765c52b23d55b39dc483e34de440e8d49ab9", 20:45:16 INFO - "stage_platform": "macosx64", 20:45:16 INFO - "builduid": "62d2a20c84d84c05a229ca320e111856", 20:45:16 INFO - "slavebuilddir": "test" 20:45:16 INFO - } 20:45:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:45:16 INFO - Running post-action listener: _resource_record_post_action 20:45:16 INFO - [mozharness: 2016-11-22 04:45:16.523938Z] Finished read-buildbot-config step (success) 20:45:16 INFO - [mozharness: 2016-11-22 04:45:16.524060Z] Running download-and-extract step. 20:45:16 INFO - Running pre-action listener: _resource_record_pre_action 20:45:16 INFO - Running main action method: download_and_extract 20:45:16 INFO - mkdir: /builds/slave/test/build/tests 20:45:16 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')]} 20:45:16 INFO - trying https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:45:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 20:45:17 INFO - Downloaded 1199 bytes. 20:45:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:45:17 INFO - Using the following test package requirements: 20:45:17 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:45:17 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:45:17 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:45:17 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'jsshell-mac.zip'], 20:45:17 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:45:17 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:45:17 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:45:17 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:45:17 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:45:17 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:45:17 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:45:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:45:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:45:17 INFO - Fetch https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:45:18 INFO - Http code: 200 20:45:18 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 20:45:18 INFO - x-amz-cf-id: GiUqmSMPnqIqS4FJSTdofANKJkO20yaxS164MRi3Ig_mQQw6yCY3lA== 20:45:18 INFO - x-amz-version-id: OjN_WQVksk0Ln20TetrwGUsTZjJsQjnQ 20:45:18 INFO - Expected file size: 16282104 20:45:18 INFO - Obtained file size: 16282104 20:45:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:45:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:45:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:45:25 INFO - Fetch https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:45:25 INFO - Http code: 200 20:45:25 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 20:45:25 INFO - x-amz-cf-id: _dSTbn-c1eXrMzBApiOHgj9xjkpsTlw8j_8k_ZVNUNroXlF1jCCbGw== 20:45:25 INFO - x-amz-version-id: OjN_WQVksk0Ln20TetrwGUsTZjJsQjnQ 20:45:26 INFO - Expected file size: 16282104 20:45:26 INFO - Obtained file size: 16282104 20:45:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:45:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:45:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:45:34 INFO - Http code: 200 20:45:34 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 20:45:34 INFO - x-amz-cf-id: owszbnvvDFnxTtm-Q-bIfsFGyfWjwz3d4nibQwryP9wXtVI06bLURA== 20:45:34 INFO - x-amz-version-id: 1hXK4HPVTXBhcTgR0iGXgMQvDY1vdkDn 20:45:34 INFO - Expected file size: 14409392 20:45:34 INFO - Obtained file size: 14409392 20:45:34 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')]} 20:45:34 INFO - trying https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:45:34 INFO - Downloading https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 20:45:37 INFO - Downloaded 107572829 bytes. 20:45:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:45:37 INFO - mkdir: /builds/slave/test/properties 20:45:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:37 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:37 INFO - Contents: 20:45:37 INFO - build_url:https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:45:38 INFO - Running post-action listener: _resource_record_post_action 20:45:38 INFO - Running post-action listener: set_extra_try_arguments 20:45:38 INFO - [mozharness: 2016-11-22 04:45:38.206842Z] Finished download-and-extract step (success) 20:45:38 INFO - [mozharness: 2016-11-22 04:45:38.206970Z] Running populate-webroot step. 20:45:38 INFO - Running pre-action listener: _resource_record_pre_action 20:45:38 INFO - Running main action method: populate_webroot 20:45:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:38 INFO - '--tppagecycles', 20:45:38 INFO - '7'], 20:45:38 INFO - 'tests': ['tsvgm']}}, 20:45:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['damp', 'tps']}, 20:45:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'tests': ['damp', 'tps']}, 20:45:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['dromaeo_dom']}, 20:45:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['basic_compositor_video']}, 20:45:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:45:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['a11yr', 20:45:38 INFO - 'ts_paint', 20:45:38 INFO - 'tpaint', 20:45:38 INFO - 'sessionrestore', 20:45:38 INFO - 'sessionrestore_no_auto_restore', 20:45:38 INFO - 'tabpaint']}, 20:45:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['tsvgx', 20:45:38 INFO - 'tsvgr_opacity', 20:45:38 INFO - 'tart', 20:45:38 INFO - 'tscrollx', 20:45:38 INFO - 'cart']}, 20:45:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:38 INFO - 'tsvgr_opacity', 20:45:38 INFO - 'tart', 20:45:38 INFO - 'tscrollx', 20:45:38 INFO - 'cart']}, 20:45:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'talos_options': ['--disable-e10s'], 20:45:38 INFO - 'tests': ['tp5o']}, 20:45:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:45:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'talos_options': ['--disable-e10s', 20:45:38 INFO - '--xperf_path', 20:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:38 INFO - 'tests': ['tp5n']}, 20:45:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:45:38 INFO - 'talos_options': ['--xperf_path', 20:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:38 INFO - 'tests': ['tp5n']}}, 20:45:38 INFO - 'talos.zip': {'path': '', 20:45:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:38 INFO - Running post-action listener: _resource_record_post_action 20:45:38 INFO - [mozharness: 2016-11-22 04:45:38.224937Z] Finished populate-webroot step (success) 20:45:38 INFO - [mozharness: 2016-11-22 04:45:38.225072Z] Running create-virtualenv step. 20:45:38 INFO - Running pre-action listener: _resource_record_pre_action 20:45:38 INFO - Running main action method: create_virtualenv 20:45:38 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:38 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 20:45:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:38 INFO - Using real prefix '/tools/python27' 20:45:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:39 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:41 INFO - Installing pip.................done. 20:45:41 INFO - Return code: 0 20:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:45:42 INFO - Reading from file tmpfile_stdout 20:45:42 INFO - Output received: 20:45:42 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) 20:45:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:42 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:42 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 20:45:42 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 20:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:42 INFO - 'HOME': '/Users/cltbld', 20:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:42 INFO - 'LOGNAME': 'cltbld', 20:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:42 INFO - 'MOZ_NO_REMOTE': '1', 20:45:42 INFO - 'NO_EM_RESTART': '1', 20:45:42 INFO - 'PAGER': '/bin/cat', 20:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:42 INFO - 'PWD': '/builds/slave/test', 20:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:42 INFO - 'SHELL': '/bin/bash', 20:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:42 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:42 INFO - 'USER': 'cltbld', 20:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:42 INFO - 'XPC_FLAGS': '0x0', 20:45:42 INFO - 'XPC_SERVICE_NAME': '0', 20:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:42 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 20:45:42 INFO - Cleaning up... 20:45:42 INFO - Return code: 0 20:45:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:42 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:42 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 20:45:42 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 20:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:42 INFO - 'HOME': '/Users/cltbld', 20:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:42 INFO - 'LOGNAME': 'cltbld', 20:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:42 INFO - 'MOZ_NO_REMOTE': '1', 20:45:42 INFO - 'NO_EM_RESTART': '1', 20:45:42 INFO - 'PAGER': '/bin/cat', 20:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:42 INFO - 'PWD': '/builds/slave/test', 20:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:42 INFO - 'SHELL': '/bin/bash', 20:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:42 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:42 INFO - 'USER': 'cltbld', 20:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:42 INFO - 'XPC_FLAGS': '0x0', 20:45:42 INFO - 'XPC_SERVICE_NAME': '0', 20:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:42 INFO - Downloading/unpacking psutil>=3.1.1 20:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:46 INFO - Installing collected packages: psutil 20:45:46 INFO - Running setup.py install for psutil 20:45:46 INFO - building 'psutil._psutil_osx' extension 20:45:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:45:47 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 20:45:47 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 20:45:47 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 20:45:47 INFO - building 'psutil._psutil_posix' extension 20:45:47 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 20:45:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:45:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:45:47 INFO - ^ 20:45:47 INFO - 1 warning generated. 20:45:47 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 20:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:47 INFO - Successfully installed psutil 20:45:47 INFO - Cleaning up... 20:45:47 INFO - Return code: 0 20:45:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:47 INFO - 'HOME': '/Users/cltbld', 20:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:47 INFO - 'LOGNAME': 'cltbld', 20:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:47 INFO - 'MOZ_NO_REMOTE': '1', 20:45:47 INFO - 'NO_EM_RESTART': '1', 20:45:47 INFO - 'PAGER': '/bin/cat', 20:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:47 INFO - 'PWD': '/builds/slave/test', 20:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:47 INFO - 'SHELL': '/bin/bash', 20:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:47 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:47 INFO - 'USER': 'cltbld', 20:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:47 INFO - 'XPC_FLAGS': '0x0', 20:45:47 INFO - 'XPC_SERVICE_NAME': '0', 20:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:45:48 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 20:45:48 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 20:45:48 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 20:45:48 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 20:45:48 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 20:45:48 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 20:45:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:45:50 INFO - Installing collected packages: mozsystemmonitor 20:45:50 INFO - Running setup.py install for mozsystemmonitor 20:45:50 INFO - Successfully installed mozsystemmonitor 20:45:50 INFO - Cleaning up... 20:45:50 INFO - Return code: 0 20:45:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:45:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:50 INFO - 'HOME': '/Users/cltbld', 20:45:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:50 INFO - 'LOGNAME': 'cltbld', 20:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:50 INFO - 'MOZ_NO_REMOTE': '1', 20:45:50 INFO - 'NO_EM_RESTART': '1', 20:45:50 INFO - 'PAGER': '/bin/cat', 20:45:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:50 INFO - 'PWD': '/builds/slave/test', 20:45:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:50 INFO - 'SHELL': '/bin/bash', 20:45:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:50 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:50 INFO - 'USER': 'cltbld', 20:45:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:50 INFO - 'XPC_FLAGS': '0x0', 20:45:50 INFO - 'XPC_SERVICE_NAME': '0', 20:45:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:51 INFO - Downloading/unpacking jsonschema==2.5.1 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:51 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 20:45:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:45:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:53 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 20:45:54 INFO - Downloading functools32-3.2.3-2.tar.gz 20:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:45:54 INFO - warning: no files found matching '*.txt' 20:45:54 INFO - no previously-included directories found matching 'build' 20:45:54 INFO - no previously-included directories found matching 'dist' 20:45:54 INFO - no previously-included directories found matching '.git*' 20:45:54 INFO - Installing collected packages: jsonschema, functools32 20:45:54 INFO - Running setup.py install for functools32 20:45:54 INFO - warning: no files found matching '*.txt' 20:45:54 INFO - no previously-included directories found matching 'build' 20:45:54 INFO - no previously-included directories found matching 'dist' 20:45:54 INFO - no previously-included directories found matching '.git*' 20:45:54 INFO - Successfully installed jsonschema functools32 20:45:54 INFO - Cleaning up... 20:45:54 INFO - Return code: 0 20:45:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:45:54 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')]} 20:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:54 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')]} 20:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:54 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:54 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 20:45:54 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 20:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:54 INFO - 'HOME': '/Users/cltbld', 20:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:54 INFO - 'LOGNAME': 'cltbld', 20:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:54 INFO - 'MOZ_NO_REMOTE': '1', 20:45:54 INFO - 'NO_EM_RESTART': '1', 20:45:54 INFO - 'PAGER': '/bin/cat', 20:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:54 INFO - 'PWD': '/builds/slave/test', 20:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:54 INFO - 'SHELL': '/bin/bash', 20:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:54 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:54 INFO - 'USER': 'cltbld', 20:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:54 INFO - 'XPC_FLAGS': '0x0', 20:45:54 INFO - 'XPC_SERVICE_NAME': '0', 20:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:45:54 INFO - Cleaning up... 20:45:54 INFO - Return code: 0 20:45:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45:54 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')]} 20:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:54 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')]} 20:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:54 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:54 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 20:45:54 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 20:45:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:54 INFO - 'HOME': '/Users/cltbld', 20:45:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:54 INFO - 'LOGNAME': 'cltbld', 20:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:54 INFO - 'MOZ_NO_REMOTE': '1', 20:45:54 INFO - 'NO_EM_RESTART': '1', 20:45:54 INFO - 'PAGER': '/bin/cat', 20:45:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:54 INFO - 'PWD': '/builds/slave/test', 20:45:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:54 INFO - 'SHELL': '/bin/bash', 20:45:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:54 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:54 INFO - 'USER': 'cltbld', 20:45:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:54 INFO - 'XPC_FLAGS': '0x0', 20:45:54 INFO - 'XPC_SERVICE_NAME': '0', 20:45:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:55 INFO - Downloading/unpacking blobuploader==1.2.4 20:45:55 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 20:45:55 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 20:45:55 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 20:45:55 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 20:45:55 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 20:45:55 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 20:45:57 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:58 INFO - Downloading docopt-0.6.1.tar.gz 20:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:58 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:58 INFO - Running setup.py install for blobuploader 20:45:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:58 INFO - Running setup.py install for requests 20:45:59 INFO - Running setup.py install for docopt 20:45:59 INFO - Successfully installed blobuploader requests docopt 20:45:59 INFO - Cleaning up... 20:45:59 INFO - Return code: 0 20:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:59 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')]} 20:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:59 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')]} 20:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:59 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:45:59 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 20:45:59 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 20:45:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:45:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:59 INFO - 'HOME': '/Users/cltbld', 20:45:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:59 INFO - 'LOGNAME': 'cltbld', 20:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:59 INFO - 'MOZ_NO_REMOTE': '1', 20:45:59 INFO - 'NO_EM_RESTART': '1', 20:45:59 INFO - 'PAGER': '/bin/cat', 20:45:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:59 INFO - 'PWD': '/builds/slave/test', 20:45:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:59 INFO - 'SHELL': '/bin/bash', 20:45:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:45:59 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:45:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:59 INFO - 'USER': 'cltbld', 20:45:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:59 INFO - 'XPC_FLAGS': '0x0', 20:45:59 INFO - 'XPC_SERVICE_NAME': '0', 20:45:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:59 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ETV8M7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-mafgQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-83XL6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-KrDr1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-rS5m2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-HzR5qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-84_Rbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-xIJ7Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-NiJbAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-24jU2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:00 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-c75xyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-PsUXaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-pm7Tau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-TZd1Hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-JpLdC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-QtT285-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:01 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-oBl7Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:46:01 INFO - Running setup.py install for manifestparser 20:46:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:46:01 INFO - Running setup.py install for mozcrash 20:46:01 INFO - Running setup.py install for mozdebug 20:46:02 INFO - Running setup.py install for mozdevice 20:46:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozfile 20:46:02 INFO - Running setup.py install for mozhttpd 20:46:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozinfo 20:46:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozInstall 20:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:46:02 INFO - Running setup.py install for mozleak 20:46:03 INFO - Running setup.py install for mozlog 20:46:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Running setup.py install for moznetwork 20:46:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Running setup.py install for mozprocess 20:46:03 INFO - Running setup.py install for mozprofile 20:46:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Running setup.py install for mozrunner 20:46:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:46:03 INFO - Running setup.py install for mozscreenshot 20:46:03 INFO - Running setup.py install for moztest 20:46:04 INFO - Running setup.py install for mozversion 20:46:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:46:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:46:04 INFO - Cleaning up... 20:46:04 INFO - Return code: 0 20:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:04 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')]} 20:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 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')]} 20:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:46:04 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 20:46:04 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 20:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:04 INFO - 'HOME': '/Users/cltbld', 20:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:04 INFO - 'LOGNAME': 'cltbld', 20:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:04 INFO - 'MOZ_NO_REMOTE': '1', 20:46:04 INFO - 'NO_EM_RESTART': '1', 20:46:04 INFO - 'PAGER': '/bin/cat', 20:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:04 INFO - 'PWD': '/builds/slave/test', 20:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:04 INFO - 'SHELL': '/bin/bash', 20:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:46:04 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:04 INFO - 'USER': 'cltbld', 20:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:04 INFO - 'XPC_FLAGS': '0x0', 20:46:04 INFO - 'XPC_SERVICE_NAME': '0', 20:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:46:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-TlXAkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:46:04 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:46:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-EwovkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:46:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-JDjO2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:46:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-iZDZUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 20:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:46:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ADf5vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-CpIAN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-DhL06l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-VJz48o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Q1mjv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-IhVtcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-T7ycp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-6boTuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:46:05 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)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-wYqggV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:46:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:46:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-FIRmCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:06 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-fd6te9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:46:06 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)) 20:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:46:06 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-SCvSc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:46:06 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)) 20:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:46:06 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Q5CAoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:46:06 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)) 20:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:46:06 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)) 20:46:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:46:06 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:46:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:46:06 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 20:46:06 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 20:46:06 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 20:46:06 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 20:46:06 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 20:46:06 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 20:46:08 INFO - Downloading blessings-1.6.tar.gz 20:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:09 INFO - Installing collected packages: blessings 20:46:09 INFO - Running setup.py install for blessings 20:46:09 INFO - Successfully installed blessings 20:46:09 INFO - Cleaning up... 20:46:09 INFO - Return code: 0 20:46:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:09 INFO - Reading from file tmpfile_stdout 20:46:09 INFO - Current package versions: 20:46:09 INFO - blessings == 1.6 20:46:09 INFO - blobuploader == 1.2.4 20:46:09 INFO - docopt == 0.6.1 20:46:09 INFO - functools32 == 3.2.3-2 20:46:09 INFO - jsonschema == 2.5.1 20:46:09 INFO - manifestparser == 1.1 20:46:09 INFO - mozInstall == 1.12 20:46:09 INFO - mozcrash == 1.0 20:46:09 INFO - mozdebug == 0.1 20:46:09 INFO - mozdevice == 0.49 20:46:09 INFO - mozfile == 1.2 20:46:09 INFO - mozhttpd == 0.7 20:46:09 INFO - mozinfo == 0.9 20:46:09 INFO - mozleak == 0.1 20:46:09 INFO - mozlog == 3.4 20:46:09 INFO - moznetwork == 0.27 20:46:09 INFO - mozprocess == 0.23 20:46:09 INFO - mozprofile == 0.28 20:46:09 INFO - mozrunner == 6.13 20:46:09 INFO - mozscreenshot == 0.1 20:46:09 INFO - mozsystemmonitor == 0.3 20:46:09 INFO - moztest == 0.7 20:46:09 INFO - mozversion == 1.4 20:46:09 INFO - psutil == 3.1.1 20:46:09 INFO - requests == 1.2.3 20:46:09 INFO - wsgiref == 0.1.2 20:46:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:09 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')]} 20:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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')]} 20:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:46:09 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 20:46:09 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 20:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:09 INFO - 'HOME': '/Users/cltbld', 20:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:09 INFO - 'LOGNAME': 'cltbld', 20:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:09 INFO - 'MOZ_NO_REMOTE': '1', 20:46:09 INFO - 'NO_EM_RESTART': '1', 20:46:09 INFO - 'PAGER': '/bin/cat', 20:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:09 INFO - 'PWD': '/builds/slave/test', 20:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:09 INFO - 'SHELL': '/bin/bash', 20:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:46:09 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:09 INFO - 'USER': 'cltbld', 20:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:09 INFO - 'XPC_FLAGS': '0x0', 20:46:09 INFO - 'XPC_SERVICE_NAME': '0', 20:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 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)) 20:46:09 INFO - Cleaning up... 20:46:09 INFO - Return code: 0 20:46:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:09 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')]} 20:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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')]} 20:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:09 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 0x100bd23f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc789d6b2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, '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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:46:09 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 20:46:09 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 20:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:09 INFO - 'HOME': '/Users/cltbld', 20:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:09 INFO - 'LOGNAME': 'cltbld', 20:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:09 INFO - 'MOZ_NO_REMOTE': '1', 20:46:09 INFO - 'NO_EM_RESTART': '1', 20:46:09 INFO - 'PAGER': '/bin/cat', 20:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:09 INFO - 'PWD': '/builds/slave/test', 20:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:09 INFO - 'SHELL': '/bin/bash', 20:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:46:09 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:09 INFO - 'USER': 'cltbld', 20:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:09 INFO - 'XPC_FLAGS': '0x0', 20:46:09 INFO - 'XPC_SERVICE_NAME': '0', 20:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:46:10 INFO - Cleaning up... 20:46:10 INFO - Return code: 0 20:46:10 INFO - Running post-action listener: _resource_record_post_action 20:46:10 INFO - Running post-action listener: _start_resource_monitoring 20:46:10 INFO - Starting resource monitoring. 20:46:10 INFO - [mozharness: 2016-11-22 04:46:10.149678Z] Finished create-virtualenv step (success) 20:46:10 INFO - [mozharness: 2016-11-22 04:46:10.150714Z] Running install step. 20:46:10 INFO - Running pre-action listener: _resource_record_pre_action 20:46:10 INFO - Running main action method: install 20:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:10 INFO - Reading from file tmpfile_stdout 20:46:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:10 INFO - Reading from file tmpfile_stdout 20:46:10 INFO - Output received: 20:46:10 INFO - Usage: mozinstall [options] installer 20:46:10 INFO - Options: 20:46:10 INFO - -h, --help show this help message and exit 20:46:10 INFO - -d DEST, --destination=DEST 20:46:10 INFO - Directory to install application into. [default: 20:46:10 INFO - "/builds/slave/test"] 20:46:10 INFO - --app=APP Application being installed. [default: firefox] 20:46:10 INFO - mkdir: /builds/slave/test/build/application 20:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:46:43 INFO - Reading from file tmpfile_stdout 20:46:43 INFO - Output received: 20:46:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:46:43 INFO - Running post-action listener: _resource_record_post_action 20:46:43 INFO - [mozharness: 2016-11-22 04:46:43.328150Z] Finished install step (success) 20:46:43 INFO - [mozharness: 2016-11-22 04:46:43.328298Z] Running run-tests step. 20:46:43 INFO - Running pre-action listener: _resource_record_pre_action 20:46:43 INFO - Running main action method: run_tests 20:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:46:43 INFO - 2016-11-21 20:46:43.342 screenresolution[1624:7495] starting screenresolution argv=screenresolution get 20:46:43 INFO - 2016-11-21 20:46:43.345 screenresolution[1624:7495] Display 0: 1600x1200x32@60 20:46:43 INFO - 2016-11-21 20:46:43.351 screenresolution[1625:7498] starting screenresolution argv=screenresolution list 20:46:43 INFO - Available Modes on Display 0 20:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:46:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:46:43 INFO - Intel Iris: 20:46:43 INFO - Chipset Model: Intel Iris 20:46:43 INFO - Type: GPU 20:46:43 INFO - Bus: Built-In 20:46:43 INFO - VRAM (Dynamic, Max): 1536 MB 20:46:43 INFO - Vendor: Intel (0x8086) 20:46:43 INFO - Device ID: 0x0a2e 20:46:43 INFO - Revision ID: 0x0009 20:46:43 INFO - Displays: 20:46:43 INFO - Display: 20:46:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:46:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:46:43 INFO - Display Serial Number: 1600x1200 60 20:46:43 INFO - Main Display: Yes 20:46:43 INFO - Mirror: Off 20:46:43 INFO - Online: Yes 20:46:43 INFO - Rotation: Supported 20:46:43 INFO - Return code: 0 20:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:43 INFO - Python 2.7.3 20:46:43 INFO - Return code: 0 20:46:43 INFO - grabbing minidump binary from tooltool 20:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:43 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 0x1009e8d30>, '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 0x10084fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1009e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:43 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 20:46:43 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 20:46:43 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 20:46:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:43 INFO - Return code: 0 20:46:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:46:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:46:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 20:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0252 --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 20:46:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yMNIPGbvFC/Render', 20:46:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:43 INFO - 'HOME': '/Users/cltbld', 20:46:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:43 INFO - 'LOGNAME': 'cltbld', 20:46:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:43 INFO - 'MOZ_NO_REMOTE': '1', 20:46:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:43 INFO - 'NO_EM_RESTART': '1', 20:46:43 INFO - 'PAGER': '/bin/cat', 20:46:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:43 INFO - 'PWD': '/builds/slave/test', 20:46:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:43 INFO - 'SHELL': '/bin/bash', 20:46:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBWcZb4oAb/Listeners', 20:46:43 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:46:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:43 INFO - 'USER': 'cltbld', 20:46:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:43 INFO - 'XPC_FLAGS': '0x0', 20:46:43 INFO - 'XPC_SERVICE_NAME': '0', 20:46:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 20:46:43 INFO - mozversion application_buildid: 20161121182450 20:46:43 INFO - mozversion application_changeset: 8a3e765c52b23d55b39dc483e34de440e8d49ab9 20:46:43 INFO - mozversion application_display_name: Nightly 20:46:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:43 INFO - mozversion application_name: Firefox 20:46:43 INFO - mozversion application_remotingname: firefox 20:46:43 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:46:43 INFO - mozversion application_vendor: Mozilla 20:46:43 INFO - mozversion application_version: 53.0a1 20:46:43 INFO - mozversion platform_buildid: 20161121182450 20:46:43 INFO - mozversion platform_changeset: 8a3e765c52b23d55b39dc483e34de440e8d49ab9 20:46:43 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:46:43 INFO - mozversion platform_version: 53.0a1 20:46:43 INFO - using testdate: 1479790003 20:46:43 INFO - actual date: 1479790003 20:46:43 INFO - starting webserver on 'localhost:49241' 20:46:43 INFO - SUITE-START | Running 2 tests 20:46:43 INFO - TEST-START | dromaeo_css 20:46:43 INFO - operating with platform_type : mac_ 20:46:43 INFO - Initialising browser for dromaeo_css test... 20:46:43 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3L9Mu5/profile http://localhost:49241/getInfo.html) 20:46:46 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 20:46:46 INFO - PROCESS | 1635 | colorDepth:24 20:46:46 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 20:46:46 INFO - PROCESS | 1635 | __metrics 20:46:46 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:46:46 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:46:47 INFO - TEST-INFO | 1635: exit 0 20:46:47 INFO - Browser initialized. 20:46:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:47 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmp3L9Mu5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:59 INFO - PROCESS | 1637 | RSS: Main: 237281280 20:46:59 INFO - PROCESS | 1637 | 20:47:51 INFO - PROCESS | 1637 | 1479790071058 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] 20:50:03 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 20:50:06 INFO - PROCESS | 1637 | RSS: Main: 429268992 20:50:06 INFO - PROCESS | 1637 | 20:53:08 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 20:53:09 INFO - PROCESS | 1637 | RSS: Main: 370401280 20:53:09 INFO - PROCESS | 1637 | 20:56:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 20:56:12 INFO - PROCESS | 1637 | RSS: Main: 360214528 20:56:12 INFO - PROCESS | 1637 | 20:59:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 20:59:15 INFO - PROCESS | 1637 | RSS: Main: 342949888 20:59:15 INFO - PROCESS | 1637 | 21:02:18 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 21:02:19 INFO - PROCESS | 1637 | RSS: Main: 329867264 21:02:19 INFO - PROCESS | 1637 | 21:05:22 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 21:05:23 INFO - PROCESS | 1637 | RSS: Main: 437284864 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | __start_tp_report 21:05:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 21:05:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 21:05:23 INFO - PROCESS | 1637 | |i|pagename|runs| 21:05:23 INFO - PROCESS | 1637 | |0;dojo.html;3288.6382497925233;3317.9382597568774;3319.672131147541;3356.0770788033274;3379.5268662387257;5451.100568406208;5530.391656917746;5562.276904002479;5591.412901645324;5604.607677462579;5491.121420572709;5503.889922201553;5574.219609254707;5588.357338906027;5647.661140331583;5062.13943629582;5144.536991670749;5151.4075881273575;5153.69077855328;5167.431582525919;5076.03555324489;5138.409082955452;5214.374275086995;5217.5565076968505;5224.0074385866565;5185.351831021122;5217.634765566412;5221.373435187783;5238.423773384925;5246.422893481714;5109.156989096795;5143.3313669223135;5155.2524883892;5160.406553246387;5203.219517072469;3968.464257325253;4921.064997650435;5030.597552195815;5034.144195486776;5049.84850454487;4965.602751779885;5154.865929495505;5460;5553.444655534455;5595;6061.515078793686;6072.392760723937;6135.417135372177;6140.416660417253;6148.9692551536955;6060.939390606081;6187.938120618781;6193.628382297032;6211.565190436626;6219.844503887393;4691.249400096002;5634.098544232903;5663.461971112738;5735.627184233012;5857.7656893724625;4856.78144483492;6294.118823364733;6297.4332310091395;6306.65313407767;6311.526635502356;6005.939940600538;6038.728257228435;6039.54703397247;6055;6071.726772295257;6020.187274717945;6034.456898879034;6088.330283668793;6102.176206212193;6119.6645886031865;6083.513318934474;6090.147379366892;6115.938840611626;6137.785177518855;6143.232095988002;6040;6093.847653808691;6095.146679464879;6105.481034112061;6118.479929206067;4716.740579268173;4813.855584332476;4848.151573474628;4858.514148585114;4858.951410485921;3510.596281427617;4315.8489452869;4339.978300108479;4370.082282720601;4447.066116115588;5647.152927060892;5650.943490565041;5653.23681303027;5658.953093677683;5671.546276297886;6015.3383127855905;6185.721642526097;6187.3503282155625;6192.721327540272;6206.224221972254;5517;5602.327720673546;5610.438956104438;5612.747426365823;5658.264425624725;5272.446393128743;5293.206019097166;5303.204519322133;5305.522502974673;5308.442613525602;6221.191245138103;6282.371762823681;6292.748290068437;6314.463270621956;6318.462930650762;4811.855644330676;6134.723937422916;6195.96902015487;6223.315435302204;6225.3774622537385;6306.684665766785;6320.936790632035;6321.747130114744;6325.810225693236;6359.109724638647;5889.087191485327;6074.574779765374;6099.725512352044;6121;6125.908111378422;6083.726232319467;6101.217066730222;6111.926012480528;6114.847128821815;6239.937600623935;6011.789587364421;6018.0282306381105;6026.216591843032;6035.577509574463;6071.726772295169;5977.9402205977385;5997.190379298739;6003.189569408249;6007.549433792396;6015.909761353496;4769.95230047709;5525.861853453695;5726;5778.219940308173;5787.276590426197;5908.3205431375945;5925.644461332334;5927.555433342603;5932.317783454785;5935.198748168942;4958.2810492477665;5614.7192640367;5758.913616295843;5762.30852297727;5763.3084029915 21:05:23 INFO - PROCESS | 1637 | |1;ext.html;484.1575658354464;512.4209643103294;517.554902783606;532.5313723922948;555.6166245290749;38100.23799524011;39444.40833387501;39639.405408918814;39686.60313396865;41301.58698413015;40534.59465405352;40850.97872553187;40867.18265634686;40923;40960;9074.999999999984;9275.443473391619;9276.536173191347;9288.071192880692;9300.953495232514;9188.081191880792;9301.162895339417;9305.929818070907;9318.906810931905;9320.487373194472;9252.907470925273;9274.211692006187;9322.627094916195;9328.48693321867;9328.647346134807;9249.398789078688;9291.628334866631;9309.53452327381;9311.115444032806;9315.021922698155;9194.034626364202;9269.90730092704;9281.907180928172;9288.907110928872;9293.02423245563;38791.806040969896;38977.220455591014;38993;38994.41508377377;39139.8043009786;3364.9495257571157;3470.930581388358;3631.4734363517405;3705.3515634763808;3878.495795546561;29157.41685166285;29832.70167298321;29845.806167753264;29942.85028574865;30401;2692.4615076984683;3036.75705943524;3129.8122112673313;3150.8739650413954;3173.5398367236853;483697;485390;486619;487953.12046879786;498544;59880;60251.698741506014;60313.69843150756;60339.09491357633;60390;33479.330413391595;34196.48705269423;34321;34738;61821.381786182465;12036.338001410006;15607.141607211712;15618.68762624741;15642.061476311457;15654;11918.821217681741;11992.460339284753;12010.099242556844;12014.918657320883;12048.939755301168;18205.54486137857;18209.817901821076;18213.90893045526;18222.544436388933;18231.908840455977;6776.796696099125;7095.751648692271;7346.669399877019;7546.547207167588;7557.508761930457;739.4306384084225;751.6842925971105;778.6924164954811;812.5043723328765;860.445012966633;24871.751282486945;26837.121401501707;27868.581971270447;28573.857130714212;30121.548176777367;975.8292298847815;998.510729742421;1015.2334987084704;1040.7242080848582;1040.9791804164026;14998.475053373299;15106.338302786684;15137.470188543348;15435.38258469671;15528.611784705472;587474;664850;675029;675875;677644;55467;55868.44131558632;56030.719846400505;56057.59856003551;56085.7195714027;1197.5569039455456;1289.9226046437243;1329.3751936589788;1333.7465881482487;1359.0147143321012;27882.302942426602;28361.574576380957;28899.00958593576;29473.263168420963;29523;48457;48680.2697959538;48768.2684759736;48906.75546622244;48930.75534622304;562919;566097;566518;567462;567860;25216.74783252144;25553.872230638728;25557;25599.872000640622;25704;43718.907027324574;44120.55879441164;44387.55612443834;44491.777541113384;44712;29384;36228.456573151954;36571.63428365682;37490.43764343482;37705.05737356588;35380;36338;36492;37647.623523765506;37734.81132594319;35469.64530354663;36203.27593448169;36443.817780910926;36617.90146295616;36622.450663240605;31520;32707;33156.33687326288;33216.50175247325;33261;24220;24278.87860560686;24338.513229734952;25032.749672503043;25054.749452505243 21:05:23 INFO - PROCESS | 1637 | |2;jquery.html;297.5150504677376;318.64948556587757;367.22881947909394;375.5943580932593;402.4948689394809;14522.056066355679;15231.154408666127;15561.844381556168;19657.410277691655;19709.50726231845;16104.919475402607;19500.804991950077;19559.608807823835;19572.70640940387;19649.26663933855;5692.089265717475;5949.970250148744;5956.821295361146;5964.850878728045;5999.310079340888;4118.814653340592;4382.474103107632;6267.686615669221;6483.773067942623;6617.834554136161;6387.87224255517;6516;6605.07528945948;6613.6693165341785;6622.933770662304;6573.079768832367;6616.636085015322;6619.404253617197;6620.635865027446;6622.53642245043;5507.173923911405;5614.073677843151;5650.03949328611;5661.631993920382;5684.886302273972;24300.513989720108;24824.627630585557;24989.5002099957;25211.991520339165;25329.873350633312;2157.2988778647004;2275.465265662568;2641.630171775953;3043.2087657209063;3152.1646763607664;14352;15290.770638440432;15582.766258506132;15856.44502442409;16015.35938562456;1633.4038076102256;1818.518092705421;1828.5337239004102;1856.637955598659;1906.008875384806;95897;97718.51140744322;99529;99745.50127249317;100033;10492.527836247387;10507.264491485676;10625.362478251329;10695.679129626124;10864.619738309122;13244.337783110806;13245.602631921058;13263.602091937257;13289.20264784116;13299.002574806927;6577.901331480031;8080.0303963523575;8150.266476017068;8203.261706446328;8264.190175340293;8103.918960810316;8104.865318855365;8122.959385203154;8258.958705206436;8269.586520674062;5430.348358197041;6295.433410993032;6419.871602567922;6422.935770642233;6424.486041116793;1590.6818636272792;1776.3693888669595;1824.2702918832308;1829.1585870499453;1832.358674463927;830.7050996896136;858.5964596639569;927.8608208768738;954.7899462118323;986.4968865878453;21132.577348452945;21177.258795942067;21246;21254.46863828417;21263.574728505653;914.7484441778431;926.3654396738256;929.6560272699145;945.7351941456403;957.8275910336206;10011.848637406645;10538.262321637412;10922.563097476012;11397.943010284895;11411.714707132222;497366;567277;581226;581717;602223;66447.66776166185;67305.65388692198;78628;106945.46527267314;111498;808.2200676347236;981.8232718110809;1002.4436437776958;1005.9849102263472;1006.7030226083323;14008.842559667515;15819.05085694862;19577.902110489358;19631.214751409785;19776.703349449483;49386;50808.74595626998;51431;52205.7389713049;53198.73400632972;68080.6595967017;69655;70485.64757176182;82516;86130.56934715286;6361.968190159019;7139.32176443237;7653.846923061619;7906.248906354117;8239.599268124553;10319.277650564389;12374.566890158801;12763.936180319039;12865.871341286467;12937.870621293667;10560.260781745204;10596.31123976939;11060.944695276472;11091.5563377464;11204.88795112071;10251.7437064074;10804.513796879002;11046.558137674725;11049.944750276198;11172.832407513732;10239.283250172417;10711.8928810714;11151.052160566443;11267.661970140909;11436.542538298374;7742.303192712683;7912.525248485109;7934.880976785237;8067.757967260992;8108.871027648531;8041.155678653658;10398.376097434179;10678.359298442118;11038.44807759625;11126.777464450828 21:05:23 INFO - PROCESS | 1637 | |3;mootools.html;1495.2000679636394;1519.8632123108919;1667.691477076741;1792.3816283382246;1825.178669598681;8146.91853081469;8570.314374850013;8579.099194584573;8580.828383432328;8586.656533738658;7461.3284804367595;7764.495307804988;7767.533947963127;7864.449488535804;7891.763247102596;2080.1263469342875;2119.1311562259475;2215.7230346206725;2297.8851057447146;2299.586074506588;1928.758905136858;2325.3953971967326;2327.069172331073;2331.0442718485424;2335.602947498929;2242.5066485373272;2302.3898666853297;2305.2392710405525;2310.607196776552;2311.861288322706;2271.091563374655;2279.350385140235;2296.6784650148825;2300.493891343902;2305.250793492122;2288.7940085392393;2294.7016887804643;2312.5606134834497;2319.8492098013744;2320.6170981787986;8350.498970061755;8546.102659220755;8550.315974722007;8564.486130832107;8572.314214862796;5051.52010559;5214.60890433219;5218.60860435465;5226.137687281594;5227.085260079509;3237.5953005874267;3492.336456073338;3549.9530535189906;3565.3938830398893;3583.229605634775;1009.6970908727352;1035.2494441529907;1064.8455973883742;1078.1374900079904;1080.4921686807188;10913.508892099875;11001.339919604849;11002.669919902415;11033.779324413546;11059.170562207786;4478.753668548196;4558.088382323548;4749.905001899942;4757.595604373598;4763.785629646674;9510.524473776422;9515.09606587387;9536.380135291183;9540.3321767477;9541.093596108358;5237.5548078413;5248.6588371755715;5249.317588713519;5250.1337279349245;5253.238280449314;4033.3143365627916;4507.549245075466;4700.976495117503;4737.644676649265;4840.056189043103;3515.4199557072798;3660.432632941898;3661.5606127264364;3689;3790.8104594770152;1248.0701877101435;1255.9309237991997;1256.0642321470564;1270.7013851744832;1275.9298238596966;867.5141920524401;874.1695389380114;881.532787622561;890.8619164029586;929.7303781903172;5529.612927095145;5728.942710572841;5745.913811292834;5820.912686309709;5847.181394604759;877.7586163805005;894.6823877523516;895.5925054100499;899.9280057595507;912.8950170730318;3781.86763463283;3809.2571948470336;3841.8463261469788;3867.7292589518465;3867.941980870289;9852.211823054138;10355.326903751233;10384.532696028697;10385.688429347132;10386.584536618451;10334.689959301082;10342.534585943651;10344.793104137874;10357.016083472057;10371.740706482398;7467.327940485382;7857.174996625272;8001.3598912088055;8010.399220058519;8015.358771298283;5638.802641907513;5703.600747947604;5778.797742079007;5796;5826.76692932278;8657.264132548804;9365;9402.38884472507;9494.28792840526;9608.567614457506;9544.522773861418;9615;9632.855507167258;9694;9785.972472890244;5666.9716651416475;6620.3710647488415;7136.785896423115;7269.527480713737;7276.890846637199;7802.492837965514;7848.254415830487;7885.1720569339395;7972.6412311444965;7993.320567751806;6940.583564986117;7133.714651414093;7143.892841607484;7259.891101633374;7362.926370736224;7046.718131274692;7060.576365417885;7138.250483699345;7144.642767861482;7255.274472552703;6623.138991931018;6655.966720166368;6656.600603963778;6668.566543174678;6730.562513436611;4764.595009424238;4781.545753153445;4828.275758636232;4892.68197567157;5017.523335283142;4420.933685994777;4891.5353041461;4976.576990955665;5012;5112.36095488064 21:05:23 INFO - PROCESS | 1637 | |4;prototype.html;296.47079962267355;298.9088328059942;306.25121577742414;312.05758609000833;312.9405412971535;4199.643030342417;4927.802887884481;5130.050940575991;5229;5362.329708786402;4168.958310416895;5079.974600126994;5082.644214904958;5097.094656046055;5115.565176959963;3723.3484140275477;3795.2978698940715;3823.9292997960615;4021.6380525752675;4066.3493840985448;3149.9370012599734;3477.8261086945677;3931.351327031051;4009.939850902239;4015.518137823465;3437.6906078452935;3928.3125453045745;3954.62431069048;3995.320795464778;4033.3949907513816;3091.5362695595727;3834.4631751554803;3887.5529314128953;3927.3912543555793;3947.50656167979;2923.4445455363625;3476.774009689362;3491.8428670709877;3494.1614012637037;3510.3681337359267;4393.760021579192;4757.952420475785;4969.353983982095;5109.9744501277255;5146.742662866879;4493.258612328962;4536.88657783558;4539.931901021488;4556.681032327739;4569.611583015414;4614.8154073837;4749.026449577863;4845.825983980499;5355.357357117132;5400.945990540084;3203.2632494526156;3610.368185567515;3721.683656889141;3827.808609569538;3844.75009124406;4531.410916580857;5624.353199382042;5636.66078577394;5680.5182998406735;5695.430456954355;3283.2612662150823;3907.4724912137067;3907.941380879289;3924.6860251179837;3926.9018274543364;3385.4921761735936;3977.244323578511;3985.8405663773124;3989.9027767363627;3998.220347032359;3766.5103536540623;4320.870373888725;4511.977440112779;4526.660500462479;4552.294394368878;4943.357363542788;5292.497212764782;5410.998965191452;5418.864528386822;5472.945270547243;1169.6841852699724;1213;1243.8134279857913;1264.589982169874;1295.8704129587154;784.3568274015366;841.7752170591774;898.389095415124;898.396362492947;899.4738078224312;4574.359589657451;4632.351470794091;4781.641376896747;4851.36932198819;4860.756962151878;4328.437303150633;4774.063950670313;5251.085647465693;5328.307320048369;5394.32570928634;4200.05498762782;4540.318952157203;4794.976025119922;5017.641708397047;5192.948785229889;2509.560826855293;2601.8308809927294;2608.356735256776;2662.108193755114;2801.9859900700367;4391.231534481453;4882.707037577757;4921.8523444296015;5587.916181257285;5618.864831364055;4638.420197475316;5136;5171.612129090333;5433.375161856358;5489.408071659254;4778.641601879873;5121.873187898731;5298.211778578335;5394.622376433769;5541.889162216733;4516.187086324493;4981.701097934136;5027.321311622884;5090.796368145233;5395.784168633368;4577.862664120082;4952.455229924777;5269.235960785742;5288.735563221747;5320.308359913187;5446.618736688394;5526.585506086979;5548.474169603392;5554.361248456479;5588.3573389060775;3056.78602497823;3114.0813460028894;3379.847906844149;3577.767445116059;3601.495790589372;4546.181687296318;5038.168702164102;5291.618771552739;5315.182953034898;5351.839444816662;4612.838550650711;4862.319275301531;5169.741512924414;5190.325257716473;5209.53114219722;4647.907041859076;4798.5853015225375;4808.519148085164;4929.975350123226;5202.921956170736;4083.3670781028986;4109.691698182992;4979.800807967641;5243.895122097613;5246.396664383645;4172.874813755592;4914.8053765053;5247.317848679647;5473.770475419522;5482.917756233739;4371.125774845107;4877.707617296756;5349.893002140013;5352.357717073976;5364.8122315718765 21:05:23 INFO - PROCESS | 1637 | |5;yui.html;646.712213065186;696.2410972040475;741.7366834773652;793.3018943329869;807.8263173417714;13805.792913106312;14800.037997530166;15212.239388030583;15216.619584510392;15282.847171528281;11193.44032798361;11881.881181188186;13447.327633618304;13630.659233519167;13762.174269543835;821.3757544266341;841.5623875584693;841.7558907916697;843.8860753798251;844.9662013519452;651.4430162211312;672.7544446277099;811.5779794506852;812.4515951732586;815.0993152566417;746.9402447804163;850.5577099908044;883.2580632268892;891.4651209274448;892.6830975003877;874.816288579399;879.9428037177595;882.250087425683;883.0904168706211;883.690708252113;507.43927959604474;647.5467172978933;650.8600650860088;651.6155468273694;652.5986518291264;12094.274343539415;13319.60041198756;13818.585442436743;13874;14205.857941420556;13163.276019818906;13213;13246.061571389444;13665.453381864714;13788.862111378958;11096.167787415896;11131.666050018512;11182;11244.831327530093;11570.01654859338;3618.2220822523022;3620;3631.527901372831;3662.9450558241647;3765.6631895676915;86944.56527717321;87748;89765;90946.5452672739;92048.53975730078;10492;10495.107915827088;10524.421156836295;10599.205059620559;10754.838677419844;20502.17991280332;20516.179352826017;20518.38444846657;20524.38426847197;20530;7095.680694368766;7475.663595138232;7607.65765540552;7630;7630.008098947102;4113.650339721097;4189.162167566499;4301.806418711166;4420.646348292194;4421.314696222091;3251.6748325167296;3345.130266130775;3384.983075084609;3388.9491657625153;3391.5082313064468;527.9577633789364;615.4338009031702;630.6157983226865;638.5402510192747;646.1374065622352;587.1632923084587;615.6767696959042;623.2080280344084;626.5833220908045;644.680882962927;7227.385672217815;8216.342692584698;8676;8710;9051.456912585134;561.831450564829;563.808305176242;580.0342429854329;640.8848603430091;641.4419455074022;3232.8383580820864;4077.2660921033907;4196.433481479961;4204.789760511962;4418.977905110518;76306.23693763102;81801.77297340544;110104;111237;118482;97397;101354.49322753338;102557.48721256346;104178;105012;78300;84331;85406.14593854106;88284;91299.54350228206;7699.692012319444;9041.90958090437;9207.815843683224;9404.670836520689;9492.430454172772;46535.83660408517;52902.677433064484;53799.73100134474;54763.7141771495;56112.43887561072;51579.22631160611;69914.9512757299;73706.63146684233;79800;80361;11752.471138798604;11799.52801887915;12121.151519393557;12240.143189976972;12433.37833108359;13531.323433828466;13810;13859.445622175;13887.236202008986;14549.709005819612;12219.144659873724;12349.382530873241;12479.812802808146;12552.811707824207;12898.48406063747;12532.310722910328;12813;12911.806322904977;13262.204267743966;13278.53525126616;12408;12411.317377544321;12463;12473.563425280072;12551.121421500407;10424.739381515219;10504.781671747905;10704.89295107039;10964.945175274073;11340.94329528347;10205.59177632916;10991;10996.23026388145;11031.282966607145;11084.944575277072 21:05:23 INFO - PROCESS | 1637 | __end_tp_report 21:05:23 INFO - PROCESS | 1637 | __start_cc_report 21:05:23 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2141 21:05:23 INFO - PROCESS | 1637 | __end_cc_report 21:05:23 INFO - PROCESS | 1637 | __startTimestamp1479791123029__endTimestamp 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | ------- Summary: start ------- 21:05:23 INFO - PROCESS | 1637 | Number of tests: 6 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5603.27 Median:5762.31 stddev:671.42 (11.7%) stddev-sans-first:648.46 21:05:23 INFO - PROCESS | 1637 | Values: 3288.6 3317.9 3319.7 3356.1 3379.5 5451.1 5530.4 5562.3 5591.4 5604.6 5491.1 5503.9 5574.2 5588.4 5647.7 5062.1 5144.5 5151.4 5153.7 5167.4 5076.0 5138.4 5214.4 5217.6 5224.0 5185.4 5217.6 5221.4 5238.4 5246.4 5109.2 5143.3 5155.3 5160.4 5203.2 3968.5 4921.1 5030.6 5034.1 5049.8 4965.6 5154.9 5460.0 5553.4 5595.0 6061.5 6072.4 6135.4 6140.4 6149.0 6060.9 6187.9 6193.6 6211.6 6219.8 4691.2 5634.1 5663.5 5735.6 5857.8 4856.8 6294.1 6297.4 6306.7 6311.5 6005.9 6038.7 6039.5 6055.0 6071.7 6020.2 6034.5 6088.3 6102.2 6119.7 6083.5 6090.1 6115.9 6137.8 6143.2 6040.0 6093.8 6095.1 6105.5 6118.5 4716.7 4813.9 4848.2 4858.5 4859.0 3510.6 4315.8 4340.0 4370.1 4447.1 5647.2 5650.9 5653.2 5659.0 5671.5 6015.3 6185.7 6187.4 6192.7 6206.2 5517.0 5602.3 5610.4 5612.7 5658.3 5272.4 5293.2 5303.2 5305.5 5308.4 6221.2 6282.4 6292.7 6314.5 6318.5 4811.9 6134.7 6196.0 6223.3 6225.4 6306.7 6320.9 6321.7 6325.8 6359.1 5889.1 6074.6 6099.7 6121.0 6125.9 6083.7 6101.2 6111.9 6114.8 6239.9 6011.8 6018.0 6026.2 6035.6 6071.7 5977.9 5997.2 6003.2 6007.5 6015.9 4770.0 5525.9 5726.0 5778.2 5787.3 5908.3 5925.6 5927.6 5932.3 5935.2 4958.3 5614.7 5758.9 5762.3 5763.3 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:68918.70 Median:38993.71 stddev:153876.43 (394.6%) stddev-sans-first:154222.30 21:05:23 INFO - PROCESS | 1637 | Values: 484.2 512.4 517.6 532.5 555.6 38100.2 39444.4 39639.4 39686.6 41301.6 40534.6 40851.0 40867.2 40923.0 40960.0 9075.0 9275.4 9276.5 9288.1 9301.0 9188.1 9301.2 9305.9 9318.9 9320.5 9252.9 9274.2 9322.6 9328.5 9328.6 9249.4 9291.6 9309.5 9311.1 9315.0 9194.0 9269.9 9281.9 9288.9 9293.0 38791.8 38977.2 38993.0 38994.4 39139.8 3364.9 3470.9 3631.5 3705.4 3878.5 29157.4 29832.7 29845.8 29942.9 30401.0 2692.5 3036.8 3129.8 3150.9 3173.5 483697.0 485390.0 486619.0 487953.1 498544.0 59880.0 60251.7 60313.7 60339.1 60390.0 33479.3 34196.5 34321.0 34738.0 61821.4 12036.3 15607.1 15618.7 15642.1 15654.0 11918.8 11992.5 12010.1 12014.9 12048.9 18205.5 18209.8 18213.9 18222.5 18231.9 6776.8 7095.8 7346.7 7546.5 7557.5 739.4 751.7 778.7 812.5 860.4 24871.8 26837.1 27868.6 28573.9 30121.5 975.8 998.5 1015.2 1040.7 1041.0 14998.5 15106.3 15137.5 15435.4 15528.6 587474.0 664850.0 675029.0 675875.0 677644.0 55467.0 55868.4 56030.7 56057.6 56085.7 1197.6 1289.9 1329.4 1333.7 1359.0 27882.3 28361.6 28899.0 29473.3 29523.0 48457.0 48680.3 48768.3 48906.8 48930.8 562919.0 566097.0 566518.0 567462.0 567860.0 25216.7 25553.9 25557.0 25599.9 25704.0 43718.9 44120.6 44387.6 44491.8 44712.0 29384.0 36228.5 36571.6 37490.4 37705.1 35380.0 36338.0 36492.0 37647.6 37734.8 35469.6 36203.3 36443.8 36617.9 36622.5 31520.0 32707.0 33156.3 33216.5 33261.0 24220.0 24278.9 24338.5 25032.7 25054.7 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:32220.43 Median:1735.41 stddev:93643.46 (5396.1%) stddev-sans-first:93875.48 21:05:23 INFO - PROCESS | 1637 | Values: 297.5 318.6 367.2 375.6 402.5 14522.1 15231.2 15561.8 19657.4 19709.5 16104.9 19500.8 19559.6 19572.7 19649.3 5692.1 5950.0 5956.8 5964.9 5999.3 4118.8 4382.5 6267.7 6483.8 6617.8 6387.9 6516.0 6605.1 6613.7 6622.9 6573.1 6616.6 6619.4 6620.6 6622.5 5507.2 5614.1 5650.0 5661.6 5684.9 24300.5 24824.6 24989.5 25212.0 25329.9 2157.3 2275.5 2641.6 3043.2 3152.2 14352.0 15290.8 15582.8 15856.4 16015.4 1633.4 1818.5 1828.5 1856.6 1906.0 95897.0 97718.5 99529.0 99745.5 100033.0 10492.5 10507.3 10625.4 10695.7 10864.6 13244.3 13245.6 13263.6 13289.2 13299.0 6577.9 8080.0 8150.3 8203.3 8264.2 8103.9 8104.9 8123.0 8259.0 8269.6 5430.3 6295.4 6419.9 6422.9 6424.5 1590.7 1776.4 1824.3 1829.2 1832.4 830.7 858.6 927.9 954.8 986.5 21132.6 21177.3 21246.0 21254.5 21263.6 914.7 926.4 929.7 945.7 957.8 10011.8 10538.3 10922.6 11397.9 11411.7 497366.0 567277.0 581226.0 581717.0 602223.0 66447.7 67305.7 78628.0 106945.5 111498.0 808.2 981.8 1002.4 1006.0 1006.7 14008.8 15819.1 19577.9 19631.2 19776.7 49386.0 50808.7 51431.0 52205.7 53198.7 68080.7 69655.0 70485.6 82516.0 86130.6 6362.0 7139.3 7653.8 7906.2 8239.6 10319.3 12374.6 12763.9 12865.9 12937.9 10560.3 10596.3 11060.9 11091.6 11204.9 10251.7 10804.5 11046.6 11049.9 11172.8 10239.3 10711.9 11151.1 11267.7 11436.5 7742.3 7912.5 7934.9 8067.8 8108.9 8041.2 10398.4 10678.4 11038.4 11126.8 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5482.60 Median:5216.61 stddev:3029.00 (58.1%) stddev-sans-first:3022.68 21:05:23 INFO - PROCESS | 1637 | Values: 1495.2 1519.9 1667.7 1792.4 1825.2 8146.9 8570.3 8579.1 8580.8 8586.7 7461.3 7764.5 7767.5 7864.4 7891.8 2080.1 2119.1 2215.7 2297.9 2299.6 1928.8 2325.4 2327.1 2331.0 2335.6 2242.5 2302.4 2305.2 2310.6 2311.9 2271.1 2279.4 2296.7 2300.5 2305.3 2288.8 2294.7 2312.6 2319.8 2320.6 8350.5 8546.1 8550.3 8564.5 8572.3 5051.5 5214.6 5218.6 5226.1 5227.1 3237.6 3492.3 3550.0 3565.4 3583.2 1009.7 1035.2 1064.8 1078.1 1080.5 10913.5 11001.3 11002.7 11033.8 11059.2 4478.8 4558.1 4749.9 4757.6 4763.8 9510.5 9515.1 9536.4 9540.3 9541.1 5237.6 5248.7 5249.3 5250.1 5253.2 4033.3 4507.5 4701.0 4737.6 4840.1 3515.4 3660.4 3661.6 3689.0 3790.8 1248.1 1255.9 1256.1 1270.7 1275.9 867.5 874.2 881.5 890.9 929.7 5529.6 5728.9 5745.9 5820.9 5847.2 877.8 894.7 895.6 899.9 912.9 3781.9 3809.3 3841.8 3867.7 3867.9 9852.2 10355.3 10384.5 10385.7 10386.6 10334.7 10342.5 10344.8 10357.0 10371.7 7467.3 7857.2 8001.4 8010.4 8015.4 5638.8 5703.6 5778.8 5796.0 5826.8 8657.3 9365.0 9402.4 9494.3 9608.6 9544.5 9615.0 9632.9 9694.0 9786.0 5667.0 6620.4 7136.8 7269.5 7276.9 7802.5 7848.3 7885.2 7972.6 7993.3 6940.6 7133.7 7143.9 7259.9 7362.9 7046.7 7060.6 7138.3 7144.6 7255.3 6623.1 6656.0 6656.6 6668.6 6730.6 4764.6 4781.5 4828.3 4892.7 5017.5 4420.9 4891.5 4976.6 5012.0 5112.4 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4252.63 Median:4698.47 stddev:1285.53 (27.4%) stddev-sans-first:1254.37 21:05:23 INFO - PROCESS | 1637 | Values: 296.5 298.9 306.3 312.1 312.9 4199.6 4927.8 5130.1 5229.0 5362.3 4169.0 5080.0 5082.6 5097.1 5115.6 3723.3 3795.3 3823.9 4021.6 4066.3 3149.9 3477.8 3931.4 4009.9 4015.5 3437.7 3928.3 3954.6 3995.3 4033.4 3091.5 3834.5 3887.6 3927.4 3947.5 2923.4 3476.8 3491.8 3494.2 3510.4 4393.8 4758.0 4969.4 5110.0 5146.7 4493.3 4536.9 4539.9 4556.7 4569.6 4614.8 4749.0 4845.8 5355.4 5400.9 3203.3 3610.4 3721.7 3827.8 3844.8 4531.4 5624.4 5636.7 5680.5 5695.4 3283.3 3907.5 3907.9 3924.7 3926.9 3385.5 3977.2 3985.8 3989.9 3998.2 3766.5 4320.9 4512.0 4526.7 4552.3 4943.4 5292.5 5411.0 5418.9 5472.9 1169.7 1213.0 1243.8 1264.6 1295.9 784.4 841.8 898.4 898.4 899.5 4574.4 4632.4 4781.6 4851.4 4860.8 4328.4 4774.1 5251.1 5328.3 5394.3 4200.1 4540.3 4795.0 5017.6 5192.9 2509.6 2601.8 2608.4 2662.1 2802.0 4391.2 4882.7 4921.9 5587.9 5618.9 4638.4 5136.0 5171.6 5433.4 5489.4 4778.6 5121.9 5298.2 5394.6 5541.9 4516.2 4981.7 5027.3 5090.8 5395.8 4577.9 4952.5 5269.2 5288.7 5320.3 5446.6 5526.6 5548.5 5554.4 5588.4 3056.8 3114.1 3379.8 3577.8 3601.5 4546.2 5038.2 5291.6 5315.2 5351.8 4612.8 4862.3 5169.7 5190.3 5209.5 4647.9 4798.6 4808.5 4930.0 5202.9 4083.4 4109.7 4979.8 5243.9 5246.4 4172.9 4914.8 5247.3 5473.8 5482.9 4371.1 4877.7 5349.9 5352.4 5364.8 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20269.39 Median:4192.80 stddev:29846.71 (711.9%) stddev-sans-first:29894.07 21:05:23 INFO - PROCESS | 1637 | Values: 646.7 696.2 741.7 793.3 807.8 13805.8 14800.0 15212.2 15216.6 15282.8 11193.4 11881.9 13447.3 13630.7 13762.2 821.4 841.6 841.8 843.9 845.0 651.4 672.8 811.6 812.5 815.1 746.9 850.6 883.3 891.5 892.7 874.8 879.9 882.3 883.1 883.7 507.4 647.5 650.9 651.6 652.6 12094.3 13319.6 13818.6 13874.0 14205.9 13163.3 13213.0 13246.1 13665.5 13788.9 11096.2 11131.7 11182.0 11244.8 11570.0 3618.2 3620.0 3631.5 3662.9 3765.7 86944.6 87748.0 89765.0 90946.5 92048.5 10492.0 10495.1 10524.4 10599.2 10754.8 20502.2 20516.2 20518.4 20524.4 20530.0 7095.7 7475.7 7607.7 7630.0 7630.0 4113.7 4189.2 4301.8 4420.6 4421.3 3251.7 3345.1 3385.0 3388.9 3391.5 528.0 615.4 630.6 638.5 646.1 587.2 615.7 623.2 626.6 644.7 7227.4 8216.3 8676.0 8710.0 9051.5 561.8 563.8 580.0 640.9 641.4 3232.8 4077.3 4196.4 4204.8 4419.0 76306.2 81801.8 110104.0 111237.0 118482.0 97397.0 101354.5 102557.5 104178.0 105012.0 78300.0 84331.0 85406.1 88284.0 91299.5 7699.7 9041.9 9207.8 9404.7 9492.4 46535.8 52902.7 53799.7 54763.7 56112.4 51579.2 69915.0 73706.6 79800.0 80361.0 11752.5 11799.5 12121.2 12240.1 12433.4 13531.3 13810.0 13859.4 13887.2 14549.7 12219.1 12349.4 12479.8 12552.8 12898.5 12532.3 12813.0 12911.8 13262.2 13278.5 12408.0 12411.3 12463.0 12473.6 12551.1 10424.7 10504.8 10704.9 10964.9 11340.9 10205.6 10991.0 10996.2 11031.3 11084.9 21:05:23 INFO - PROCESS | 1637 | -------- Summary: end -------- 21:05:23 INFO - PROCESS | 1637 | 21:05:23 INFO - TEST-INFO | 1637: exit 0 21:05:23 INFO - TEST-OK | dromaeo_css | took 1119753ms 21:05:23 INFO - TEST-START | kraken 21:05:23 INFO - operating with platform_type : mac_ 21:05:23 INFO - Initialising browser for kraken test... 21:05:23 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpAtlZ2m/profile http://localhost:49241/getInfo.html) 21:05:26 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 21:05:26 INFO - PROCESS | 1647 | colorDepth:24 21:05:26 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 21:05:26 INFO - PROCESS | 1647 | __metrics 21:05:26 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:05:26 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:27 INFO - TEST-INFO | 1647: exit 0 21:05:27 INFO - Browser initialized. 21:05:27 INFO - Running cycle 1/1 for kraken test... 21:05:27 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpAtlZ2m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:39 INFO - PROCESS | 1648 | RSS: Main: 243036160 21:05:39 INFO - PROCESS | 1648 | 21:05:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:43 INFO - PROCESS | 1648 | RSS: Main: 294502400 21:05:43 INFO - PROCESS | 1648 | 21:05:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 21:05:46 INFO - PROCESS | 1648 | RSS: Main: 295903232 21:05:46 INFO - PROCESS | 1648 | 21:05:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 21:05:51 INFO - PROCESS | 1648 | RSS: Main: 384503808 21:05:51 INFO - PROCESS | 1648 | 21:05:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 21:05:53 INFO - PROCESS | 1648 | RSS: Main: 288391168 21:05:53 INFO - PROCESS | 1648 | 21:05:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:56 INFO - PROCESS | 1648 | RSS: Main: 293228544 21:05:56 INFO - PROCESS | 1648 | 21:05:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:59 INFO - PROCESS | 1648 | RSS: Main: 337240064 21:05:59 INFO - PROCESS | 1648 | 21:06:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 21:06:03 INFO - PROCESS | 1648 | RSS: Main: 336535552 21:06:03 INFO - PROCESS | 1648 | 21:06:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 21:06:06 INFO - PROCESS | 1648 | RSS: Main: 333606912 21:06:06 INFO - PROCESS | 1648 | 21:06:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:08 INFO - PROCESS | 1648 | RSS: Main: 309862400 21:06:08 INFO - PROCESS | 1648 | 21:06:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:11 INFO - PROCESS | 1648 | RSS: Main: 311521280 21:06:11 INFO - PROCESS | 1648 | 21:06:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:14 INFO - PROCESS | 1648 | RSS: Main: 315441152 21:06:14 INFO - PROCESS | 1648 | 21:06:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:18 INFO - PROCESS | 1648 | RSS: Main: 325980160 21:06:18 INFO - PROCESS | 1648 | 21:06:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:22 INFO - PROCESS | 1648 | RSS: Main: 325734400 21:06:22 INFO - PROCESS | 1648 | 21:06:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 21:06:24 INFO - PROCESS | 1648 | RSS: Main: 368832512 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | __start_tp_report 21:06:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 21:06:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 21:06:24 INFO - PROCESS | 1648 | |i|pagename|runs| 21:06:24 INFO - PROCESS | 1648 | |0;ai-astar;113;114;114;115;115;115;114;114;115;114 21:06:24 INFO - PROCESS | 1648 | |1;audio-beat-detection;148;113;115;149;114;112;112;113;142;111 21:06:24 INFO - PROCESS | 1648 | |2;audio-dft;185;183;186;187;182;183;183;185;181;184 21:06:24 INFO - PROCESS | 1648 | |3;audio-fft;79;58;58;86;61;59;60;63;72;64 21:06:24 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;91;70;68;70;90;67;69;92 21:06:24 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;90;86;89;86;88;86;90;86;89;86 21:06:24 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;94;95;94;94;95;94;95;93;94 21:06:24 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;87;85;87;87;88;85;85;90;85 21:06:24 INFO - PROCESS | 1648 | |8;json-parse-financial;55;54;56;56;56;56;54;64;82;86 21:06:24 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;66;77;75;74;72;70;72;71;71;70 21:06:24 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;92;88;88;89;106;105;106;90;87;90 21:06:24 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;150;139;161;137;138;129;156;147;267;187 21:06:24 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;175;199;235;193;171;173;172;174;168;173 21:06:24 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;67;68;68;79;73;59;69;57;84 21:06:24 INFO - PROCESS | 1648 | __end_tp_report 21:06:24 INFO - PROCESS | 1648 | __start_cc_report 21:06:24 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1991 21:06:24 INFO - PROCESS | 1648 | __end_cc_report 21:06:24 INFO - PROCESS | 1648 | __startTimestamp1479791184058__endTimestamp 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | ------- Summary: start ------- 21:06:24 INFO - PROCESS | 1648 | Number of tests: 14 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.30 Median:114.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 21:06:24 INFO - PROCESS | 1648 | Values: 113.0 114.0 114.0 115.0 115.0 115.0 114.0 114.0 115.0 114.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:114.50 stddev:16.31 (14.2%) stddev-sans-first:14.55 21:06:24 INFO - PROCESS | 1648 | Values: 148.0 113.0 115.0 149.0 114.0 112.0 112.0 113.0 142.0 111.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.85 (1.0%) stddev-sans-first:1.92 21:06:24 INFO - PROCESS | 1648 | Values: 185.0 183.0 186.0 187.0 182.0 183.0 183.0 185.0 181.0 184.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.00 Median:63.50 stddev:9.75 (15.4%) stddev-sans-first:9.14 21:06:24 INFO - PROCESS | 1648 | Values: 79.0 58.0 58.0 86.0 61.0 59.0 60.0 63.0 72.0 64.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:11.06 (14.0%) stddev-sans-first:11.06 21:06:24 INFO - PROCESS | 1648 | Values: 88.0 70.0 91.0 70.0 68.0 70.0 90.0 67.0 69.0 92.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.78 (2.0%) stddev-sans-first:1.66 21:06:24 INFO - PROCESS | 1648 | Values: 90.0 86.0 89.0 86.0 88.0 86.0 90.0 86.0 89.0 86.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:06:24 INFO - PROCESS | 1648 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 93.0 94.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.71 (2.0%) stddev-sans-first:1.74 21:06:24 INFO - PROCESS | 1648 | Values: 85.0 87.0 85.0 87.0 87.0 88.0 85.0 85.0 90.0 85.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:56.00 stddev:12.02 (21.5%) stddev-sans-first:12.49 21:06:24 INFO - PROCESS | 1648 | Values: 55.0 54.0 56.0 56.0 56.0 56.0 54.0 64.0 82.0 86.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:3.05 (4.2%) stddev-sans-first:2.40 21:06:24 INFO - PROCESS | 1648 | Values: 66.0 77.0 75.0 74.0 72.0 70.0 72.0 71.0 71.0 70.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:88.50 stddev:8.10 (9.2%) stddev-sans-first:8.56 21:06:24 INFO - PROCESS | 1648 | Values: 92.0 88.0 88.0 89.0 106.0 105.0 106.0 90.0 87.0 90.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:161.10 Median:153.00 stddev:40.64 (26.6%) stddev-sans-first:42.91 21:06:24 INFO - PROCESS | 1648 | Values: 150.0 139.0 161.0 137.0 138.0 129.0 156.0 147.0 267.0 187.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:174.50 stddev:20.80 (11.9%) stddev-sans-first:21.84 21:06:24 INFO - PROCESS | 1648 | Values: 175.0 199.0 235.0 193.0 171.0 173.0 172.0 174.0 168.0 173.0 21:06:24 INFO - PROCESS | 1648 | 21:06:24 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.50 stddev:8.13 (11.9%) stddev-sans-first:8.59 21:06:24 INFO - PROCESS | 1648 | Values: 67.0 67.0 68.0 68.0 79.0 73.0 59.0 69.0 57.0 84.0 21:06:24 INFO - PROCESS | 1648 | -------- Summary: end -------- 21:06:24 INFO - PROCESS | 1648 | 21:06:25 INFO - TEST-INFO | 1648: exit 0 21:06:25 INFO - TEST-OK | kraken | took 61580ms 21:06:25 INFO - SUITE-END | took 1181s 21:06:25 INFO - Completed test suite (00:19:41) 21:06:25 INFO - javascript benchmark 21:06:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.6382497925233, 3317.9382597568774, 3319.672131147541, 3356.0770788033274, 3379.5268662387257, 5451.100568406208, 5530.391656917746, 5562.276904002479, 5591.412901645324, 5604.607677462579, 5491.121420572709, 5503.889922201553, 5574.219609254707, 5588.357338906027, 5647.661140331583, 5062.13943629582, 5144.536991670749, 5151.4075881273575, 5153.69077855328, 5167.431582525919, 5076.03555324489, 5138.409082955452, 5214.374275086995, 5217.5565076968505, 5224.0074385866565, 5185.351831021122, 5217.634765566412, 5221.373435187783, 5238.423773384925, 5246.422893481714, 5109.156989096795, 5143.3313669223135, 5155.2524883892, 5160.406553246387, 5203.219517072469, 3968.464257325253, 4921.064997650435, 5030.597552195815, 5034.144195486776, 5049.84850454487, 4965.602751779885, 5154.865929495505, 5460.0, 5553.444655534455, 5595.0, 6061.515078793686, 6072.392760723937, 6135.417135372177, 6140.416660417253, 6148.9692551536955, 6060.939390606081, 6187.938120618781, 6193.628382297032, 6211.565190436626, 6219.844503887393, 4691.249400096002, 5634.098544232903, 5663.461971112738, 5735.627184233012, 5857.7656893724625, 4856.78144483492, 6294.118823364733, 6297.4332310091395, 6306.65313407767, 6311.526635502356, 6005.939940600538, 6038.728257228435, 6039.54703397247, 6055.0, 6071.726772295257, 6020.187274717945, 6034.456898879034, 6088.330283668793, 6102.176206212193, 6119.6645886031865, 6083.513318934474, 6090.147379366892, 6115.938840611626, 6137.785177518855, 6143.232095988002, 6040.0, 6093.847653808691, 6095.146679464879, 6105.481034112061, 6118.479929206067, 4716.740579268173, 4813.855584332476, 4848.151573474628, 4858.514148585114, 4858.951410485921, 3510.596281427617, 4315.8489452869, 4339.978300108479, 4370.082282720601, 4447.066116115588, 5647.152927060892, 5650.943490565041, 5653.23681303027, 5658.953093677683, 5671.546276297886, 6015.3383127855905, 6185.721642526097, 6187.3503282155625, 6192.721327540272, 6206.224221972254, 5517.0, 5602.327720673546, 5610.438956104438, 5612.747426365823, 5658.264425624725, 5272.446393128743, 5293.206019097166, 5303.204519322133, 5305.522502974673, 5308.442613525602, 6221.191245138103, 6282.371762823681, 6292.748290068437, 6314.463270621956, 6318.462930650762, 4811.855644330676, 6134.723937422916, 6195.96902015487, 6223.315435302204, 6225.3774622537385, 6306.684665766785, 6320.936790632035, 6321.747130114744, 6325.810225693236, 6359.109724638647, 5889.087191485327, 6074.574779765374, 6099.725512352044, 6121.0, 6125.908111378422, 6083.726232319467, 6101.217066730222, 6111.926012480528, 6114.847128821815, 6239.937600623935, 6011.789587364421, 6018.0282306381105, 6026.216591843032, 6035.577509574463, 6071.726772295169, 5977.9402205977385, 5997.190379298739, 6003.189569408249, 6007.549433792396, 6015.909761353496, 4769.95230047709, 5525.861853453695, 5726.0, 5778.219940308173, 5787.276590426197, 5908.3205431375945, 5925.644461332334, 5927.555433342603, 5932.317783454785, 5935.198748168942, 4958.2810492477665, 5614.7192640367, 5758.913616295843, 5762.30852297727, 5763.3084029915], "value": 5560.980126622617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.1575658354464, 512.4209643103294, 517.554902783606, 532.5313723922948, 555.6166245290749, 38100.23799524011, 39444.40833387501, 39639.405408918814, 39686.60313396865, 41301.58698413015, 40534.59465405352, 40850.97872553187, 40867.18265634686, 40923.0, 40960.0, 9074.999999999984, 9275.443473391619, 9276.536173191347, 9288.071192880692, 9300.953495232514, 9188.081191880792, 9301.162895339417, 9305.929818070907, 9318.906810931905, 9320.487373194472, 9252.907470925273, 9274.211692006187, 9322.627094916195, 9328.48693321867, 9328.647346134807, 9249.398789078688, 9291.628334866631, 9309.53452327381, 9311.115444032806, 9315.021922698155, 9194.034626364202, 9269.90730092704, 9281.907180928172, 9288.907110928872, 9293.02423245563, 38791.806040969896, 38977.220455591014, 38993.0, 38994.41508377377, 39139.8043009786, 3364.9495257571157, 3470.930581388358, 3631.4734363517405, 3705.3515634763808, 3878.495795546561, 29157.41685166285, 29832.70167298321, 29845.806167753264, 29942.85028574865, 30401.0, 2692.4615076984683, 3036.75705943524, 3129.8122112673313, 3150.8739650413954, 3173.5398367236853, 483697.0, 485390.0, 486619.0, 487953.12046879786, 498544.0, 59880.0, 60251.698741506014, 60313.69843150756, 60339.09491357633, 60390.0, 33479.330413391595, 34196.48705269423, 34321.0, 34738.0, 61821.381786182465, 12036.338001410006, 15607.141607211712, 15618.68762624741, 15642.061476311457, 15654.0, 11918.821217681741, 11992.460339284753, 12010.099242556844, 12014.918657320883, 12048.939755301168, 18205.54486137857, 18209.817901821076, 18213.90893045526, 18222.544436388933, 18231.908840455977, 6776.796696099125, 7095.751648692271, 7346.669399877019, 7546.547207167588, 7557.508761930457, 739.4306384084225, 751.6842925971105, 778.6924164954811, 812.5043723328765, 860.445012966633, 24871.751282486945, 26837.121401501707, 27868.581971270447, 28573.857130714212, 30121.548176777367, 975.8292298847815, 998.510729742421, 1015.2334987084704, 1040.7242080848582, 1040.9791804164026, 14998.475053373299, 15106.338302786684, 15137.470188543348, 15435.38258469671, 15528.611784705472, 587474.0, 664850.0, 675029.0, 675875.0, 677644.0, 55467.0, 55868.44131558632, 56030.719846400505, 56057.59856003551, 56085.7195714027, 1197.5569039455456, 1289.9226046437243, 1329.3751936589788, 1333.7465881482487, 1359.0147143321012, 27882.302942426602, 28361.574576380957, 28899.00958593576, 29473.263168420963, 29523.0, 48457.0, 48680.2697959538, 48768.2684759736, 48906.75546622244, 48930.75534622304, 562919.0, 566097.0, 566518.0, 567462.0, 567860.0, 25216.74783252144, 25553.872230638728, 25557.0, 25599.872000640622, 25704.0, 43718.907027324574, 44120.55879441164, 44387.55612443834, 44491.777541113384, 44712.0, 29384.0, 36228.456573151954, 36571.63428365682, 37490.43764343482, 37705.05737356588, 35380.0, 36338.0, 36492.0, 37647.623523765506, 37734.81132594319, 35469.64530354663, 36203.27593448169, 36443.817780910926, 36617.90146295616, 36622.450663240605, 31520.0, 32707.0, 33156.33687326288, 33216.50175247325, 33261.0, 24220.0, 24278.87860560686, 24338.513229734952, 25032.749672503043, 25054.749452505243], "value": 19022.571506268192, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.5150504677376, 318.64948556587757, 367.22881947909394, 375.5943580932593, 402.4948689394809, 14522.056066355679, 15231.154408666127, 15561.844381556168, 19657.410277691655, 19709.50726231845, 16104.919475402607, 19500.804991950077, 19559.608807823835, 19572.70640940387, 19649.26663933855, 5692.089265717475, 5949.970250148744, 5956.821295361146, 5964.850878728045, 5999.310079340888, 4118.814653340592, 4382.474103107632, 6267.686615669221, 6483.773067942623, 6617.834554136161, 6387.87224255517, 6516.0, 6605.07528945948, 6613.6693165341785, 6622.933770662304, 6573.079768832367, 6616.636085015322, 6619.404253617197, 6620.635865027446, 6622.53642245043, 5507.173923911405, 5614.073677843151, 5650.03949328611, 5661.631993920382, 5684.886302273972, 24300.513989720108, 24824.627630585557, 24989.5002099957, 25211.991520339165, 25329.873350633312, 2157.2988778647004, 2275.465265662568, 2641.630171775953, 3043.2087657209063, 3152.1646763607664, 14352.0, 15290.770638440432, 15582.766258506132, 15856.44502442409, 16015.35938562456, 1633.4038076102256, 1818.518092705421, 1828.5337239004102, 1856.637955598659, 1906.008875384806, 95897.0, 97718.51140744322, 99529.0, 99745.50127249317, 100033.0, 10492.527836247387, 10507.264491485676, 10625.362478251329, 10695.679129626124, 10864.619738309122, 13244.337783110806, 13245.602631921058, 13263.602091937257, 13289.20264784116, 13299.002574806927, 6577.901331480031, 8080.0303963523575, 8150.266476017068, 8203.261706446328, 8264.190175340293, 8103.918960810316, 8104.865318855365, 8122.959385203154, 8258.958705206436, 8269.586520674062, 5430.348358197041, 6295.433410993032, 6419.871602567922, 6422.935770642233, 6424.486041116793, 1590.6818636272792, 1776.3693888669595, 1824.2702918832308, 1829.1585870499453, 1832.358674463927, 830.7050996896136, 858.5964596639569, 927.8608208768738, 954.7899462118323, 986.4968865878453, 21132.577348452945, 21177.258795942067, 21246.0, 21254.46863828417, 21263.574728505653, 914.7484441778431, 926.3654396738256, 929.6560272699145, 945.7351941456403, 957.8275910336206, 10011.848637406645, 10538.262321637412, 10922.563097476012, 11397.943010284895, 11411.714707132222, 497366.0, 567277.0, 581226.0, 581717.0, 602223.0, 66447.66776166185, 67305.65388692198, 78628.0, 106945.46527267314, 111498.0, 808.2200676347236, 981.8232718110809, 1002.4436437776958, 1005.9849102263472, 1006.7030226083323, 14008.842559667515, 15819.05085694862, 19577.902110489358, 19631.214751409785, 19776.703349449483, 49386.0, 50808.74595626998, 51431.0, 52205.7389713049, 53198.73400632972, 68080.6595967017, 69655.0, 70485.64757176182, 82516.0, 86130.56934715286, 6361.968190159019, 7139.32176443237, 7653.846923061619, 7906.248906354117, 8239.599268124553, 10319.277650564389, 12374.566890158801, 12763.936180319039, 12865.871341286467, 12937.870621293667, 10560.260781745204, 10596.31123976939, 11060.944695276472, 11091.5563377464, 11204.88795112071, 10251.7437064074, 10804.513796879002, 11046.558137674725, 11049.944750276198, 11172.832407513732, 10239.283250172417, 10711.8928810714, 11151.052160566443, 11267.661970140909, 11436.542538298374, 7742.303192712683, 7912.525248485109, 7934.880976785237, 8067.757967260992, 8108.871027648531, 8041.155678653658, 10398.376097434179, 10678.359298442118, 11038.44807759625, 11126.777464450828], "value": 9382.61308793296, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.2000679636394, 1519.8632123108919, 1667.691477076741, 1792.3816283382246, 1825.178669598681, 8146.91853081469, 8570.314374850013, 8579.099194584573, 8580.828383432328, 8586.656533738658, 7461.3284804367595, 7764.495307804988, 7767.533947963127, 7864.449488535804, 7891.763247102596, 2080.1263469342875, 2119.1311562259475, 2215.7230346206725, 2297.8851057447146, 2299.586074506588, 1928.758905136858, 2325.3953971967326, 2327.069172331073, 2331.0442718485424, 2335.602947498929, 2242.5066485373272, 2302.3898666853297, 2305.2392710405525, 2310.607196776552, 2311.861288322706, 2271.091563374655, 2279.350385140235, 2296.6784650148825, 2300.493891343902, 2305.250793492122, 2288.7940085392393, 2294.7016887804643, 2312.5606134834497, 2319.8492098013744, 2320.6170981787986, 8350.498970061755, 8546.102659220755, 8550.315974722007, 8564.486130832107, 8572.314214862796, 5051.52010559, 5214.60890433219, 5218.60860435465, 5226.137687281594, 5227.085260079509, 3237.5953005874267, 3492.336456073338, 3549.9530535189906, 3565.3938830398893, 3583.229605634775, 1009.6970908727352, 1035.2494441529907, 1064.8455973883742, 1078.1374900079904, 1080.4921686807188, 10913.508892099875, 11001.339919604849, 11002.669919902415, 11033.779324413546, 11059.170562207786, 4478.753668548196, 4558.088382323548, 4749.905001899942, 4757.595604373598, 4763.785629646674, 9510.524473776422, 9515.09606587387, 9536.380135291183, 9540.3321767477, 9541.093596108358, 5237.5548078413, 5248.6588371755715, 5249.317588713519, 5250.1337279349245, 5253.238280449314, 4033.3143365627916, 4507.549245075466, 4700.976495117503, 4737.644676649265, 4840.056189043103, 3515.4199557072798, 3660.432632941898, 3661.5606127264364, 3689.0, 3790.8104594770152, 1248.0701877101435, 1255.9309237991997, 1256.0642321470564, 1270.7013851744832, 1275.9298238596966, 867.5141920524401, 874.1695389380114, 881.532787622561, 890.8619164029586, 929.7303781903172, 5529.612927095145, 5728.942710572841, 5745.913811292834, 5820.912686309709, 5847.181394604759, 877.7586163805005, 894.6823877523516, 895.5925054100499, 899.9280057595507, 912.8950170730318, 3781.86763463283, 3809.2571948470336, 3841.8463261469788, 3867.7292589518465, 3867.941980870289, 9852.211823054138, 10355.326903751233, 10384.532696028697, 10385.688429347132, 10386.584536618451, 10334.689959301082, 10342.534585943651, 10344.793104137874, 10357.016083472057, 10371.740706482398, 7467.327940485382, 7857.174996625272, 8001.3598912088055, 8010.399220058519, 8015.358771298283, 5638.802641907513, 5703.600747947604, 5778.797742079007, 5796.0, 5826.76692932278, 8657.264132548804, 9365.0, 9402.38884472507, 9494.28792840526, 9608.567614457506, 9544.522773861418, 9615.0, 9632.855507167258, 9694.0, 9785.972472890244, 5666.9716651416475, 6620.3710647488415, 7136.785896423115, 7269.527480713737, 7276.890846637199, 7802.492837965514, 7848.254415830487, 7885.1720569339395, 7972.6412311444965, 7993.320567751806, 6940.583564986117, 7133.714651414093, 7143.892841607484, 7259.891101633374, 7362.926370736224, 7046.718131274692, 7060.576365417885, 7138.250483699345, 7144.642767861482, 7255.274472552703, 6623.138991931018, 6655.966720166368, 6656.600603963778, 6668.566543174678, 6730.562513436611, 4764.595009424238, 4781.545753153445, 4828.275758636232, 4892.68197567157, 5017.523335283142, 4420.933685994777, 4891.5353041461, 4976.576990955665, 5012.0, 5112.36095488064], "value": 4432.09608155292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.47079962267355, 298.9088328059942, 306.25121577742414, 312.05758609000833, 312.9405412971535, 4199.643030342417, 4927.802887884481, 5130.050940575991, 5229.0, 5362.329708786402, 4168.958310416895, 5079.974600126994, 5082.644214904958, 5097.094656046055, 5115.565176959963, 3723.3484140275477, 3795.2978698940715, 3823.9292997960615, 4021.6380525752675, 4066.3493840985448, 3149.9370012599734, 3477.8261086945677, 3931.351327031051, 4009.939850902239, 4015.518137823465, 3437.6906078452935, 3928.3125453045745, 3954.62431069048, 3995.320795464778, 4033.3949907513816, 3091.5362695595727, 3834.4631751554803, 3887.5529314128953, 3927.3912543555793, 3947.50656167979, 2923.4445455363625, 3476.774009689362, 3491.8428670709877, 3494.1614012637037, 3510.3681337359267, 4393.760021579192, 4757.952420475785, 4969.353983982095, 5109.9744501277255, 5146.742662866879, 4493.258612328962, 4536.88657783558, 4539.931901021488, 4556.681032327739, 4569.611583015414, 4614.8154073837, 4749.026449577863, 4845.825983980499, 5355.357357117132, 5400.945990540084, 3203.2632494526156, 3610.368185567515, 3721.683656889141, 3827.808609569538, 3844.75009124406, 4531.410916580857, 5624.353199382042, 5636.66078577394, 5680.5182998406735, 5695.430456954355, 3283.2612662150823, 3907.4724912137067, 3907.941380879289, 3924.6860251179837, 3926.9018274543364, 3385.4921761735936, 3977.244323578511, 3985.8405663773124, 3989.9027767363627, 3998.220347032359, 3766.5103536540623, 4320.870373888725, 4511.977440112779, 4526.660500462479, 4552.294394368878, 4943.357363542788, 5292.497212764782, 5410.998965191452, 5418.864528386822, 5472.945270547243, 1169.6841852699724, 1213.0, 1243.8134279857913, 1264.589982169874, 1295.8704129587154, 784.3568274015366, 841.7752170591774, 898.389095415124, 898.396362492947, 899.4738078224312, 4574.359589657451, 4632.351470794091, 4781.641376896747, 4851.36932198819, 4860.756962151878, 4328.437303150633, 4774.063950670313, 5251.085647465693, 5328.307320048369, 5394.32570928634, 4200.05498762782, 4540.318952157203, 4794.976025119922, 5017.641708397047, 5192.948785229889, 2509.560826855293, 2601.8308809927294, 2608.356735256776, 2662.108193755114, 2801.9859900700367, 4391.231534481453, 4882.707037577757, 4921.8523444296015, 5587.916181257285, 5618.864831364055, 4638.420197475316, 5136.0, 5171.612129090333, 5433.375161856358, 5489.408071659254, 4778.641601879873, 5121.873187898731, 5298.211778578335, 5394.622376433769, 5541.889162216733, 4516.187086324493, 4981.701097934136, 5027.321311622884, 5090.796368145233, 5395.784168633368, 4577.862664120082, 4952.455229924777, 5269.235960785742, 5288.735563221747, 5320.308359913187, 5446.618736688394, 5526.585506086979, 5548.474169603392, 5554.361248456479, 5588.3573389060775, 3056.78602497823, 3114.0813460028894, 3379.847906844149, 3577.767445116059, 3601.495790589372, 4546.181687296318, 5038.168702164102, 5291.618771552739, 5315.182953034898, 5351.839444816662, 4612.838550650711, 4862.319275301531, 5169.741512924414, 5190.325257716473, 5209.53114219722, 4647.907041859076, 4798.5853015225375, 4808.519148085164, 4929.975350123226, 5202.921956170736, 4083.3670781028986, 4109.691698182992, 4979.800807967641, 5243.895122097613, 5246.396664383645, 4172.874813755592, 4914.8053765053, 5247.317848679647, 5473.770475419522, 5482.917756233739, 4371.125774845107, 4877.707617296756, 5349.893002140013, 5352.357717073976, 5364.8122315718765], "value": 3851.7269230459087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.712213065186, 696.2410972040475, 741.7366834773652, 793.3018943329869, 807.8263173417714, 13805.792913106312, 14800.037997530166, 15212.239388030583, 15216.619584510392, 15282.847171528281, 11193.44032798361, 11881.881181188186, 13447.327633618304, 13630.659233519167, 13762.174269543835, 821.3757544266341, 841.5623875584693, 841.7558907916697, 843.8860753798251, 844.9662013519452, 651.4430162211312, 672.7544446277099, 811.5779794506852, 812.4515951732586, 815.0993152566417, 746.9402447804163, 850.5577099908044, 883.2580632268892, 891.4651209274448, 892.6830975003877, 874.816288579399, 879.9428037177595, 882.250087425683, 883.0904168706211, 883.690708252113, 507.43927959604474, 647.5467172978933, 650.8600650860088, 651.6155468273694, 652.5986518291264, 12094.274343539415, 13319.60041198756, 13818.585442436743, 13874.0, 14205.857941420556, 13163.276019818906, 13213.0, 13246.061571389444, 13665.453381864714, 13788.862111378958, 11096.167787415896, 11131.666050018512, 11182.0, 11244.831327530093, 11570.01654859338, 3618.2220822523022, 3620.0, 3631.527901372831, 3662.9450558241647, 3765.6631895676915, 86944.56527717321, 87748.0, 89765.0, 90946.5452672739, 92048.53975730078, 10492.0, 10495.107915827088, 10524.421156836295, 10599.205059620559, 10754.838677419844, 20502.17991280332, 20516.179352826017, 20518.38444846657, 20524.38426847197, 20530.0, 7095.680694368766, 7475.663595138232, 7607.65765540552, 7630.0, 7630.008098947102, 4113.650339721097, 4189.162167566499, 4301.806418711166, 4420.646348292194, 4421.314696222091, 3251.6748325167296, 3345.130266130775, 3384.983075084609, 3388.9491657625153, 3391.5082313064468, 527.9577633789364, 615.4338009031702, 630.6157983226865, 638.5402510192747, 646.1374065622352, 587.1632923084587, 615.6767696959042, 623.2080280344084, 626.5833220908045, 644.680882962927, 7227.385672217815, 8216.342692584698, 8676.0, 8710.0, 9051.456912585134, 561.831450564829, 563.808305176242, 580.0342429854329, 640.8848603430091, 641.4419455074022, 3232.8383580820864, 4077.2660921033907, 4196.433481479961, 4204.789760511962, 4418.977905110518, 76306.23693763102, 81801.77297340544, 110104.0, 111237.0, 118482.0, 97397.0, 101354.49322753338, 102557.48721256346, 104178.0, 105012.0, 78300.0, 84331.0, 85406.14593854106, 88284.0, 91299.54350228206, 7699.692012319444, 9041.90958090437, 9207.815843683224, 9404.670836520689, 9492.430454172772, 46535.83660408517, 52902.677433064484, 53799.73100134474, 54763.7141771495, 56112.43887561072, 51579.22631160611, 69914.9512757299, 73706.63146684233, 79800.0, 80361.0, 11752.471138798604, 11799.52801887915, 12121.151519393557, 12240.143189976972, 12433.37833108359, 13531.323433828466, 13810.0, 13859.445622175, 13887.236202008986, 14549.709005819612, 12219.144659873724, 12349.382530873241, 12479.812802808146, 12552.811707824207, 12898.48406063747, 12532.310722910328, 12813.0, 12911.806322904977, 13262.204267743966, 13278.53525126616, 12408.0, 12411.317377544321, 12463.0, 12473.563425280072, 12551.121421500407, 10424.739381515219, 10504.781671747905, 10704.89295107039, 10964.945175274073, 11340.94329528347, 10205.59177632916, 10991.0, 10996.23026388145, 11031.282966607145, 11084.944575277072], "value": 7152.700424893042, "unit": "score"}], "name": "dromaeo_css", "value": 7034.84532759484, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 115.0, 149.0, 114.0, 112.0, 112.0, 113.0, 142.0, 111.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 186.0, 187.0, 182.0, 183.0, 183.0, 185.0, 181.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 58.0, 86.0, 61.0, 59.0, 60.0, 63.0, 72.0, 64.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 91.0, 70.0, 68.0, 70.0, 90.0, 67.0, 69.0, 92.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 89.0, 86.0, 88.0, 86.0, 90.0, 86.0, 89.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 93.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 87.0, 87.0, 88.0, 85.0, 85.0, 90.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 56.0, 56.0, 56.0, 54.0, 64.0, 82.0, 86.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 75.0, 74.0, 72.0, 70.0, 72.0, 71.0, 71.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 88.0, 89.0, 106.0, 105.0, 106.0, 90.0, 87.0, 90.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 139.0, 161.0, 137.0, 138.0, 129.0, 156.0, 147.0, 267.0, 187.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 199.0, 235.0, 193.0, 171.0, 173.0, 172.0, 174.0, 168.0, 173.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 79.0, 73.0, 59.0, 69.0, 57.0, 84.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1474.0999999999997, "alertThreshold": 2.0}]} 21:06:25 INFO - Return code: 0 21:06:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:06:25 INFO - # TBPL SUCCESS # 21:06:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:06:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:06:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:06:25 INFO - 2016-11-21 21:06:25.863 screenresolution[1652:9832] starting screenresolution argv=screenresolution get 21:06:25 INFO - 2016-11-21 21:06:25.866 screenresolution[1652:9832] Display 0: 1600x1200x32@60 21:06:25 INFO - 2016-11-21 21:06:25.872 screenresolution[1653:9836] starting screenresolution argv=screenresolution list 21:06:25 INFO - Available Modes on Display 0 21:06:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:06:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:06:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:06:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:06:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:06:26 INFO - Intel Iris: 21:06:26 INFO - Chipset Model: Intel Iris 21:06:26 INFO - Type: GPU 21:06:26 INFO - Bus: Built-In 21:06:26 INFO - VRAM (Dynamic, Max): 1536 MB 21:06:26 INFO - Vendor: Intel (0x8086) 21:06:26 INFO - Device ID: 0x0a2e 21:06:26 INFO - Revision ID: 0x0009 21:06:26 INFO - Displays: 21:06:26 INFO - Display: 21:06:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:06:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:06:26 INFO - Display Serial Number: 1600x1200 60 21:06:26 INFO - Main Display: Yes 21:06:26 INFO - Mirror: Off 21:06:26 INFO - Online: Yes 21:06:26 INFO - Rotation: Supported 21:06:26 INFO - Return code: 0 21:06:26 INFO - Running post-action listener: _resource_record_post_action 21:06:26 INFO - [mozharness: 2016-11-22 05:06:26.106930Z] Finished run-tests step (success) 21:06:26 INFO - Running post-run listener: _resource_record_post_run 21:06:26 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37520384; Write bytes: 695273472; Read time: 238; Write time: 1983 21:06:26 INFO - TinderboxPrint: CPU usage
53.8% 21:06:26 INFO - TinderboxPrint: I/O read bytes / time
37,520,384 / 238 21:06:26 INFO - TinderboxPrint: I/O write bytes / time
695,273,472 / 1,983 21:06:26 INFO - TinderboxPrint: CPU idle
2,248.2 (46.2%) 21:06:26 INFO - TinderboxPrint: CPU system
978.1 (20.1%) 21:06:26 INFO - TinderboxPrint: CPU user
1,635.4 (33.6%) 21:06:26 INFO - TinderboxPrint: Swap in / out
420,589,568 / 0 21:06:26 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 382462464; Write bytes: 377827328; Read time: 29265; Write time: 796 21:06:26 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 34427904; Write bytes: 307009536; Read time: 216; Write time: 1149 21:06:26 INFO - Running post-run listener: _upload_blobber_files 21:06:26 INFO - Blob upload gear active. 21:06:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:26 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 21:06:26 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:06:26 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:06:27 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:06:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:27 INFO - (blobuploader) - INFO - Done attempting. 21:06:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:06:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:29 INFO - (blobuploader) - INFO - Done attempting. 21:06:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:31 INFO - (blobuploader) - INFO - Done attempting. 21:06:31 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:31 INFO - Return code: 0 21:06:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f131986dd6486cb4a37b82decd2e2a438dfee0836a790cdeaafe850a084ec3bd442328cc8f3027eed88c5c49950584391fa7457f313a6521e8f5801f387995ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea3cf795f2180eb6d46a92c6b06d48d8f6a6cbb4964ed8af33be49170dd0465d76ddab270f6bf6338c1060c22d812bb96a02f1c55ee80d496a06f3e1d1f47e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/56a44328d3deffa2f255ace5a954d9c6636a768d633e1bacd7c44684c52bf7904a90d4792e8ac312e2de3b9ca2ff205a918cf3e79ceddc073a922759fdc30345"} 21:06:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:31 INFO - Contents: 21:06:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f131986dd6486cb4a37b82decd2e2a438dfee0836a790cdeaafe850a084ec3bd442328cc8f3027eed88c5c49950584391fa7457f313a6521e8f5801f387995ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea3cf795f2180eb6d46a92c6b06d48d8f6a6cbb4964ed8af33be49170dd0465d76ddab270f6bf6338c1060c22d812bb96a02f1c55ee80d496a06f3e1d1f47e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/56a44328d3deffa2f255ace5a954d9c6636a768d633e1bacd7c44684c52bf7904a90d4792e8ac312e2de3b9ca2ff205a918cf3e79ceddc073a922759fdc30345"} 21:06:31 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:31 INFO - Copying logs to upload dir... 21:06:31 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.273167 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-21 21:06:31.330053) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 21:06:31.339369) ========= 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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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/Graphics/sha512/f131986dd6486cb4a37b82decd2e2a438dfee0836a790cdeaafe850a084ec3bd442328cc8f3027eed88c5c49950584391fa7457f313a6521e8f5801f387995ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea3cf795f2180eb6d46a92c6b06d48d8f6a6cbb4964ed8af33be49170dd0465d76ddab270f6bf6338c1060c22d812bb96a02f1c55ee80d496a06f3e1d1f47e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/56a44328d3deffa2f255ace5a954d9c6636a768d633e1bacd7c44684c52bf7904a90d4792e8ac312e2de3b9ca2ff205a918cf3e79ceddc073a922759fdc30345"} build_url:https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010941 build_url: 'https://queue.taskcluster.net/v1/task/TNYWPlUQR_-hqy_ua4pKxQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f131986dd6486cb4a37b82decd2e2a438dfee0836a790cdeaafe850a084ec3bd442328cc8f3027eed88c5c49950584391fa7457f313a6521e8f5801f387995ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ea3cf795f2180eb6d46a92c6b06d48d8f6a6cbb4964ed8af33be49170dd0465d76ddab270f6bf6338c1060c22d812bb96a02f1c55ee80d496a06f3e1d1f47e5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/56a44328d3deffa2f255ace5a954d9c6636a768d633e1bacd7c44684c52bf7904a90d4792e8ac312e2de3b9ca2ff205a918cf3e79ceddc073a922759fdc30345"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 21:06:31.379310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 21:06:31.379658) ========= 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.yMNIPGbvFC/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.KBWcZb4oAb/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.005244 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 21:06:31.432619) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 21:06:31.436008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 21:06:31.436371) ========= ========= Total master_lag: 3.39 =========