builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0008 starttime: 1482255546.37 results: success (0) buildid: 20161220081453 builduid: 8319cb49ab724ec283a2e8ac2d07e7ba revision: 138d3e518727488f2c500a31f2f1431a2e41d023 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.372547) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.372982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.373255) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.399525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.399894) ========= 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.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-12-20 09:39: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% 143M=0s 2016-12-20 09:39:06 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.547136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.547445) ========= 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.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.028400 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:06.597133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 09:39:06.597641) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 138d3e518727488f2c500a31f2f1431a2e41d023 --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 138d3e518727488f2c500a31f2f1431a2e41d023 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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-12-20 09:39:06,687 truncating revision to first 12 chars 2016-12-20 09:39:06,687 Setting DEBUG logging. 2016-12-20 09:39:06,687 attempt 1/10 2016-12-20 09:39:06,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/138d3e518727?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 09:39:07,953 unpacking tar archive at: graphics-138d3e518727/testing/mozharness/ program finished with exit code 0 elapsedTime=1.525603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 09:39:08.147382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:08.147804) ========= script_repo_revision: 138d3e518727488f2c500a31f2f1431a2e41d023 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:08.148334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:08.148797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 09:39:08.168932) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-20 09:39:08.169377) ========= /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.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:08 INFO - MultiFileLogger online at 20161220 09:39:08 in /builds/slave/test 09:39:08 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 09:39:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:39:08 INFO - {'append_to_log': False, 09:39:08 INFO - 'base_work_dir': '/builds/slave/test', 09:39:08 INFO - 'blob_upload_branch': 'Graphics', 09:39:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:39:08 INFO - 'branch': 'Graphics', 09:39:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:39:08 INFO - 'config_files': ('talos/mac_config.py',), 09:39:08 INFO - 'default_actions': ('clobber', 09:39:08 INFO - 'read-buildbot-config', 09:39:08 INFO - 'download-and-extract', 09:39:08 INFO - 'populate-webroot', 09:39:08 INFO - 'create-virtualenv', 09:39:08 INFO - 'install', 09:39:08 INFO - 'run-tests'), 09:39:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:39:08 INFO - 'download_minidump_stackwalk': True, 09:39:08 INFO - 'download_symbols': 'ondemand', 09:39:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:39:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:39:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:39:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:39:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:39:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:39:08 INFO - 'installer_path': 'installer.exe', 09:39:08 INFO - 'log_level': 'info', 09:39:08 INFO - 'log_name': 'talos', 09:39:08 INFO - 'log_to_console': True, 09:39:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:39:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:39:08 INFO - 'opt_config_files': (), 09:39:08 INFO - 'pip_index': False, 09:39:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:08 INFO - 'cmd': ('bash', 09:39:08 INFO - '-c', 09:39:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:08 INFO - 'enabled': True, 09:39:08 INFO - 'halt_on_failure': False, 09:39:08 INFO - 'name': 'check_screen_resolution'},), 09:39:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:39:08 INFO - 'cmd': ('bash', 09:39:08 INFO - '-c', 09:39:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:39:08 INFO - 'enabled': True, 09:39:08 INFO - 'halt_on_failure': False, 09:39:08 INFO - 'name': 'check_screen_resolution'},), 09:39:08 INFO - 'run_cmd_checks_enabled': True, 09:39:08 INFO - 'sps_profile': False, 09:39:08 INFO - 'sps_profile_interval': 0, 09:39:08 INFO - 'suite': 'dromaeojs', 09:39:08 INFO - 'system_bits': '32', 09:39:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:39:08 INFO - 'title': 't-yosemite-r7-0008', 09:39:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:39:08 INFO - 'use_talos_json': True, 09:39:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:39:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:39:08 INFO - 'work_dir': 'build'} 09:39:08 INFO - [mozharness: 2016-12-20 17:39:08.373814Z] Running clobber step. 09:39:08 INFO - Running pre-action listener: _resource_record_pre_action 09:39:08 INFO - Running main action method: clobber 09:39:08 INFO - rmtree: /builds/slave/test/build 09:39:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:39:10 INFO - Running post-action listener: _resource_record_post_action 09:39:10 INFO - [mozharness: 2016-12-20 17:39:10.819538Z] Finished clobber step (success) 09:39:10 INFO - [mozharness: 2016-12-20 17:39:10.819652Z] Running read-buildbot-config step. 09:39:10 INFO - Running pre-action listener: _resource_record_pre_action 09:39:10 INFO - Running main action method: read_buildbot_config 09:39:10 INFO - Using buildbot properties: 09:39:10 INFO - { 09:39:10 INFO - "project": "", 09:39:10 INFO - "product": "firefox", 09:39:10 INFO - "script_repo_revision": "default", 09:39:10 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 09:39:10 INFO - "repository": "", 09:39:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 09:39:10 INFO - "buildid": "20161220081453", 09:39:10 INFO - "pgo_build": "False", 09:39:10 INFO - "basedir": "/builds/slave/test", 09:39:10 INFO - "buildnumber": 9, 09:39:10 INFO - "slavename": "t-yosemite-r7-0008", 09:39:10 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:39:10 INFO - "platform": "yosemite_r7", 09:39:10 INFO - "scheduler": "tests-graphics-macosx64-talos", 09:39:10 INFO - "branch": "graphics", 09:39:10 INFO - "repo_path": "projects/graphics", 09:39:10 INFO - "revision": "138d3e518727488f2c500a31f2f1431a2e41d023", 09:39:10 INFO - "stage_platform": "macosx64", 09:39:10 INFO - "builduid": "8319cb49ab724ec283a2e8ac2d07e7ba", 09:39:10 INFO - "slavebuilddir": "test" 09:39:10 INFO - } 09:39:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 09:39:10 INFO - Running post-action listener: _resource_record_post_action 09:39:10 INFO - [mozharness: 2016-12-20 17:39:10.822908Z] Finished read-buildbot-config step (success) 09:39:10 INFO - [mozharness: 2016-12-20 17:39:10.823018Z] Running download-and-extract step. 09:39:10 INFO - Running pre-action listener: _resource_record_pre_action 09:39:10 INFO - Running main action method: download_and_extract 09:39:10 INFO - mkdir: /builds/slave/test/build/tests 09:39:10 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')]} 09:39:10 INFO - trying https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 09:39:10 INFO - Downloading https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/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 09:39:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/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 09:39:11 INFO - Downloaded 1199 bytes. 09:39:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 09:39:11 INFO - Using the following test package requirements: 09:39:11 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:39:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 09:39:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 09:39:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'jsshell-mac.zip'], 09:39:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 09:39:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 09:39:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 09:39:11 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 09:39:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 09:39:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 09:39:11 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 09:39:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:39:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:39:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:39:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:39:12 INFO - Expected file size: 16276063 09:39:12 INFO - Obtained file size: 16276063 09:39:19 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 09:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 09:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 09:39:20 INFO - Expected file size: 16276063 09:39:20 INFO - Obtained file size: 16276063 09:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 09:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 09:39:27 INFO - Expected file size: 14409734 09:39:27 INFO - Obtained file size: 14409734 09:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:28 INFO - trying https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:39:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 09:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/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 09:39:30 INFO - Downloaded 69662454 bytes. 09:39:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:39:30 INFO - mkdir: /builds/slave/test/properties 09:39:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:39:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:39:30 INFO - Contents: 09:39:30 INFO - build_url:https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 09:39:30 INFO - Running post-action listener: _resource_record_post_action 09:39:30 INFO - Running post-action listener: set_extra_try_arguments 09:39:30 INFO - [mozharness: 2016-12-20 17:39:30.791539Z] Finished download-and-extract step (success) 09:39:30 INFO - [mozharness: 2016-12-20 17:39:30.791690Z] Running populate-webroot step. 09:39:30 INFO - Running pre-action listener: _resource_record_pre_action 09:39:30 INFO - Running main action method: populate_webroot 09:39:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:39:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:39:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:39:30 INFO - '--tppagecycles', 09:39:30 INFO - '7'], 09:39:30 INFO - 'tests': ['tsvgm']}}, 09:39:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:39:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:39:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:39:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:39:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:39:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['damp', 'tps']}, 09:39:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'tests': ['damp', 'tps']}, 09:39:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['dromaeo_dom']}, 09:39:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:39:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['basic_compositor_video']}, 09:39:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:39:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['a11yr', 09:39:30 INFO - 'ts_paint', 09:39:30 INFO - 'tpaint', 09:39:30 INFO - 'sessionrestore', 09:39:30 INFO - 'sessionrestore_no_auto_restore', 09:39:30 INFO - 'tabpaint']}, 09:39:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['tsvgx', 09:39:30 INFO - 'tsvgr_opacity', 09:39:30 INFO - 'tart', 09:39:30 INFO - 'tscrollx', 09:39:30 INFO - 'cart', 09:39:30 INFO - 'tsvg_static']}, 09:39:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:39:30 INFO - 'tsvgr_opacity', 09:39:30 INFO - 'tart', 09:39:30 INFO - 'tscrollx', 09:39:30 INFO - 'cart', 09:39:30 INFO - 'tsvg_static']}, 09:39:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'talos_options': ['--disable-e10s'], 09:39:30 INFO - 'tests': ['tp5o']}, 09:39:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:39:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'talos_options': ['--disable-e10s', 09:39:30 INFO - '--xperf_path', 09:39:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:30 INFO - 'tests': ['tp5n']}, 09:39:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:39:30 INFO - 'talos_options': ['--xperf_path', 09:39:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:39:30 INFO - 'tests': ['tp5n']}}, 09:39:30 INFO - 'talos.zip': {'path': '', 09:39:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:39:30 INFO - Running post-action listener: _resource_record_post_action 09:39:30 INFO - [mozharness: 2016-12-20 17:39:30.809806Z] Finished populate-webroot step (success) 09:39:30 INFO - [mozharness: 2016-12-20 17:39:30.809940Z] Running create-virtualenv step. 09:39:30 INFO - Running pre-action listener: _resource_record_pre_action 09:39:30 INFO - Running main action method: create_virtualenv 09:39:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:39:30 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 09:39:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:39:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:39:30 INFO - Using real prefix '/tools/python27' 09:39:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:39:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:39:34 INFO - Installing pip.................done. 09:39:34 INFO - Return code: 0 09:39:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:39:34 INFO - Reading from file tmpfile_stdout 09:39:34 INFO - Output received: 09:39:34 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) 09:39:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:34 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 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:34 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 09:39:34 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 09:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:34 INFO - 'HOME': '/Users/cltbld', 09:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:34 INFO - 'LOGNAME': 'cltbld', 09:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:34 INFO - 'MOZ_NO_REMOTE': '1', 09:39:34 INFO - 'NO_EM_RESTART': '1', 09:39:34 INFO - 'PAGER': '/bin/cat', 09:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:34 INFO - 'PWD': '/builds/slave/test', 09:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:34 INFO - 'SHELL': '/bin/bash', 09:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:34 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:34 INFO - 'USER': 'cltbld', 09:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:34 INFO - 'XPC_FLAGS': '0x0', 09:39:34 INFO - 'XPC_SERVICE_NAME': '0', 09:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:35 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 09:39:35 INFO - Cleaning up... 09:39:35 INFO - Return code: 0 09:39:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:35 INFO - 'HOME': '/Users/cltbld', 09:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:35 INFO - 'LOGNAME': 'cltbld', 09:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:35 INFO - 'MOZ_NO_REMOTE': '1', 09:39:35 INFO - 'NO_EM_RESTART': '1', 09:39:35 INFO - 'PAGER': '/bin/cat', 09:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:35 INFO - 'PWD': '/builds/slave/test', 09:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:35 INFO - 'SHELL': '/bin/bash', 09:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:35 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:35 INFO - 'USER': 'cltbld', 09:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:35 INFO - 'XPC_FLAGS': '0x0', 09:39:35 INFO - 'XPC_SERVICE_NAME': '0', 09:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:35 INFO - Downloading/unpacking psutil>=3.1.1 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:35 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 09:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:38 INFO - Installing collected packages: psutil 09:39:38 INFO - Running setup.py install for psutil 09:39:38 INFO - building 'psutil._psutil_osx' extension 09:39:38 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 09:39:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:39:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:39:39 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 09:39:39 INFO - building 'psutil._psutil_posix' extension 09:39:39 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 09:39:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:39:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:39:39 INFO - ^ 09:39:39 INFO - 1 warning generated. 09:39:39 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 09:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:39 INFO - Successfully installed psutil 09:39:39 INFO - Cleaning up... 09:39:40 INFO - Return code: 0 09:39:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:40 INFO - 'HOME': '/Users/cltbld', 09:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:40 INFO - 'LOGNAME': 'cltbld', 09:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:40 INFO - 'MOZ_NO_REMOTE': '1', 09:39:40 INFO - 'NO_EM_RESTART': '1', 09:39:40 INFO - 'PAGER': '/bin/cat', 09:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:40 INFO - 'PWD': '/builds/slave/test', 09:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:40 INFO - 'SHELL': '/bin/bash', 09:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:40 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:40 INFO - 'USER': 'cltbld', 09:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:40 INFO - 'XPC_FLAGS': '0x0', 09:39:40 INFO - 'XPC_SERVICE_NAME': '0', 09:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:42 INFO - Installing collected packages: mozsystemmonitor 09:39:42 INFO - Running setup.py install for mozsystemmonitor 09:39:43 INFO - Successfully installed mozsystemmonitor 09:39:43 INFO - Cleaning up... 09:39:43 INFO - Return code: 0 09:39:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:43 INFO - 'HOME': '/Users/cltbld', 09:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:43 INFO - 'LOGNAME': 'cltbld', 09:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:43 INFO - 'MOZ_NO_REMOTE': '1', 09:39:43 INFO - 'NO_EM_RESTART': '1', 09:39:43 INFO - 'PAGER': '/bin/cat', 09:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:43 INFO - 'PWD': '/builds/slave/test', 09:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:43 INFO - 'SHELL': '/bin/bash', 09:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:43 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:43 INFO - 'USER': 'cltbld', 09:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:43 INFO - 'XPC_FLAGS': '0x0', 09:39:43 INFO - 'XPC_SERVICE_NAME': '0', 09:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:43 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:46 INFO - warning: no files found matching '*.txt' 09:39:46 INFO - no previously-included directories found matching 'build' 09:39:46 INFO - no previously-included directories found matching 'dist' 09:39:46 INFO - no previously-included directories found matching '.git*' 09:39:46 INFO - Installing collected packages: jsonschema, functools32 09:39:46 INFO - Running setup.py install for functools32 09:39:46 INFO - warning: no files found matching '*.txt' 09:39:46 INFO - no previously-included directories found matching 'build' 09:39:46 INFO - no previously-included directories found matching 'dist' 09:39:46 INFO - no previously-included directories found matching '.git*' 09:39:46 INFO - Successfully installed jsonschema functools32 09:39:46 INFO - Cleaning up... 09:39:46 INFO - Return code: 0 09:39:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:46 INFO - 'HOME': '/Users/cltbld', 09:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:46 INFO - 'LOGNAME': 'cltbld', 09:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:46 INFO - 'MOZ_NO_REMOTE': '1', 09:39:46 INFO - 'NO_EM_RESTART': '1', 09:39:46 INFO - 'PAGER': '/bin/cat', 09:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:46 INFO - 'PWD': '/builds/slave/test', 09:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:46 INFO - 'SHELL': '/bin/bash', 09:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:46 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:46 INFO - 'USER': 'cltbld', 09:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:46 INFO - 'XPC_FLAGS': '0x0', 09:39:46 INFO - 'XPC_SERVICE_NAME': '0', 09:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:47 INFO - Cleaning up... 09:39:47 INFO - Return code: 0 09:39:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:47 INFO - 'HOME': '/Users/cltbld', 09:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:47 INFO - 'LOGNAME': 'cltbld', 09:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:47 INFO - 'MOZ_NO_REMOTE': '1', 09:39:47 INFO - 'NO_EM_RESTART': '1', 09:39:47 INFO - 'PAGER': '/bin/cat', 09:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:47 INFO - 'PWD': '/builds/slave/test', 09:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:47 INFO - 'SHELL': '/bin/bash', 09:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:47 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:47 INFO - 'USER': 'cltbld', 09:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:47 INFO - 'XPC_FLAGS': '0x0', 09:39:47 INFO - 'XPC_SERVICE_NAME': '0', 09:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:49 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 09:39:49 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 09:39:49 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 09:39:49 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 09:39:49 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 09:39:49 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 09:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:51 INFO - Downloading docopt-0.6.1.tar.gz 09:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:51 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:51 INFO - Running setup.py install for blobuploader 09:39:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:51 INFO - Running setup.py install for requests 09:39:52 INFO - Running setup.py install for docopt 09:39:52 INFO - Successfully installed blobuploader requests docopt 09:39:52 INFO - Cleaning up... 09:39:52 INFO - Return code: 0 09:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:52 INFO - 'HOME': '/Users/cltbld', 09:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:52 INFO - 'LOGNAME': 'cltbld', 09:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:52 INFO - 'MOZ_NO_REMOTE': '1', 09:39:52 INFO - 'NO_EM_RESTART': '1', 09:39:52 INFO - 'PAGER': '/bin/cat', 09:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:52 INFO - 'PWD': '/builds/slave/test', 09:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:52 INFO - 'SHELL': '/bin/bash', 09:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:52 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:52 INFO - 'USER': 'cltbld', 09:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:52 INFO - 'XPC_FLAGS': '0x0', 09:39:52 INFO - 'XPC_SERVICE_NAME': '0', 09:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qLamfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CP7D7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-4cSjb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Gt4b2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:52 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Q8ieZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZIrNwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-grg77V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-BlFPG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-PT5G3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-rxNkE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ko9PQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-uESWpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-__nqcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:53 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UOQl7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:54 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-yjvygl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:54 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WlN1um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:54 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-jfXsZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:54 INFO - Running setup.py install for manifestparser 09:39:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:54 INFO - Running setup.py install for mozcrash 09:39:54 INFO - Running setup.py install for mozdebug 09:39:54 INFO - Running setup.py install for mozdevice 09:39:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:54 INFO - Running setup.py install for mozfile 09:39:55 INFO - Running setup.py install for mozhttpd 09:39:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Running setup.py install for mozinfo 09:39:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Running setup.py install for mozInstall 09:39:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Running setup.py install for mozleak 09:39:55 INFO - Running setup.py install for mozlog 09:39:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Running setup.py install for moznetwork 09:39:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:55 INFO - Running setup.py install for mozprocess 09:39:56 INFO - Running setup.py install for mozprofile 09:39:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozrunner 09:39:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Running setup.py install for mozscreenshot 09:39:56 INFO - Running setup.py install for moztest 09:39:56 INFO - Running setup.py install for mozversion 09:39:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:56 INFO - Cleaning up... 09:39:56 INFO - Return code: 0 09:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:39:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:39:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:56 INFO - 'HOME': '/Users/cltbld', 09:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:56 INFO - 'LOGNAME': 'cltbld', 09:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:56 INFO - 'MOZ_NO_REMOTE': '1', 09:39:56 INFO - 'NO_EM_RESTART': '1', 09:39:56 INFO - 'PAGER': '/bin/cat', 09:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:56 INFO - 'PWD': '/builds/slave/test', 09:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:56 INFO - 'SHELL': '/bin/bash', 09:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:39:56 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:56 INFO - 'USER': 'cltbld', 09:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:56 INFO - 'XPC_FLAGS': '0x0', 09:39:56 INFO - 'XPC_SERVICE_NAME': '0', 09:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-i8wTFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wcsN0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:57 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)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-4IydYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CHVyn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:57 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)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wSC9Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-2ZTCvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-0wpBpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:57 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-sNXJIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:58 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)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-WZY7z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-11V9v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:58 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)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-v5cyE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-5bad1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-cTvlEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-DpguKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:58 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)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-cyzJ3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-z7osLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:58 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-_MQ9uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:40:01 INFO - Downloading blessings-1.6.tar.gz 09:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:01 INFO - Installing collected packages: blessings 09:40:01 INFO - Running setup.py install for blessings 09:40:01 INFO - Successfully installed blessings 09:40:01 INFO - Cleaning up... 09:40:02 INFO - Return code: 0 09:40:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:02 INFO - Reading from file tmpfile_stdout 09:40:02 INFO - Current package versions: 09:40:02 INFO - blessings == 1.6 09:40:02 INFO - blobuploader == 1.2.4 09:40:02 INFO - docopt == 0.6.1 09:40:02 INFO - functools32 == 3.2.3-2 09:40:02 INFO - jsonschema == 2.5.1 09:40:02 INFO - manifestparser == 1.1 09:40:02 INFO - mozInstall == 1.12 09:40:02 INFO - mozcrash == 1.0 09:40:02 INFO - mozdebug == 0.1 09:40:02 INFO - mozdevice == 0.49 09:40:02 INFO - mozfile == 1.2 09:40:02 INFO - mozhttpd == 0.7 09:40:02 INFO - mozinfo == 0.9 09:40:02 INFO - mozleak == 0.1 09:40:02 INFO - mozlog == 3.4 09:40:02 INFO - moznetwork == 0.27 09:40:02 INFO - mozprocess == 0.23 09:40:02 INFO - mozprofile == 0.28 09:40:02 INFO - mozrunner == 6.13 09:40:02 INFO - mozscreenshot == 0.1 09:40:02 INFO - mozsystemmonitor == 0.3 09:40:02 INFO - moztest == 0.7 09:40:02 INFO - mozversion == 1.4 09:40:02 INFO - psutil == 3.1.1 09:40:02 INFO - requests == 1.2.3 09:40:02 INFO - wsgiref == 0.1.2 09:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:02 INFO - 'HOME': '/Users/cltbld', 09:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:02 INFO - 'LOGNAME': 'cltbld', 09:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:02 INFO - 'MOZ_NO_REMOTE': '1', 09:40:02 INFO - 'NO_EM_RESTART': '1', 09:40:02 INFO - 'PAGER': '/bin/cat', 09:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:02 INFO - 'PWD': '/builds/slave/test', 09:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:02 INFO - 'SHELL': '/bin/bash', 09:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:40:02 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:02 INFO - 'USER': 'cltbld', 09:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:02 INFO - 'XPC_FLAGS': '0x0', 09:40:02 INFO - 'XPC_SERVICE_NAME': '0', 09:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 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)) 09:40:03 INFO - Cleaning up... 09:40:03 INFO - Return code: 0 09:40:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:03 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 0x104dfab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104dfd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1dbdca5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, '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.JyV7iFXK3z/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.fH78IMXkKH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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 09:40:03 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 09:40:03 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 09:40:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:40:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:03 INFO - 'HOME': '/Users/cltbld', 09:40:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:03 INFO - 'LOGNAME': 'cltbld', 09:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:03 INFO - 'MOZ_NO_REMOTE': '1', 09:40:03 INFO - 'NO_EM_RESTART': '1', 09:40:03 INFO - 'PAGER': '/bin/cat', 09:40:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:03 INFO - 'PWD': '/builds/slave/test', 09:40:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:03 INFO - 'SHELL': '/bin/bash', 09:40:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:40:03 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:40:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:03 INFO - 'USER': 'cltbld', 09:40:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:03 INFO - 'XPC_FLAGS': '0x0', 09:40:03 INFO - 'XPC_SERVICE_NAME': '0', 09:40:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:04 INFO - Cleaning up... 09:40:04 INFO - Return code: 0 09:40:04 INFO - Running post-action listener: _resource_record_post_action 09:40:04 INFO - Running post-action listener: _start_resource_monitoring 09:40:04 INFO - Starting resource monitoring. 09:40:04 INFO - [mozharness: 2016-12-20 17:40:04.220965Z] Finished create-virtualenv step (success) 09:40:04 INFO - [mozharness: 2016-12-20 17:40:04.221918Z] Running install step. 09:40:04 INFO - Running pre-action listener: _resource_record_pre_action 09:40:04 INFO - Running main action method: install 09:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:04 INFO - Reading from file tmpfile_stdout 09:40:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:04 INFO - Reading from file tmpfile_stdout 09:40:04 INFO - Output received: 09:40:04 INFO - Usage: mozinstall [options] installer 09:40:04 INFO - Options: 09:40:04 INFO - -h, --help show this help message and exit 09:40:04 INFO - -d DEST, --destination=DEST 09:40:04 INFO - Directory to install application into. [default: 09:40:04 INFO - "/builds/slave/test"] 09:40:04 INFO - --app=APP Application being installed. [default: firefox] 09:40:04 INFO - mkdir: /builds/slave/test/build/application 09:40:04 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'] 09:40:04 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 09:40:26 INFO - Reading from file tmpfile_stdout 09:40:26 INFO - Output received: 09:40:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:40:26 INFO - Running post-action listener: _resource_record_post_action 09:40:26 INFO - [mozharness: 2016-12-20 17:40:26.131432Z] Finished install step (success) 09:40:26 INFO - [mozharness: 2016-12-20 17:40:26.131533Z] Running run-tests step. 09:40:26 INFO - Running pre-action listener: _resource_record_pre_action 09:40:26 INFO - Running main action method: run_tests 09:40:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:40:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:40:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:40:26 INFO - 2016-12-20 09:40:26.145 screenresolution[1626:7450] starting screenresolution argv=screenresolution get 09:40:26 INFO - 2016-12-20 09:40:26.148 screenresolution[1626:7450] Display 0: 1600x1200x32@60 09:40:26 INFO - 2016-12-20 09:40:26.154 screenresolution[1627:7452] starting screenresolution argv=screenresolution list 09:40:26 INFO - Available Modes on Display 0 09:40:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:40:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:40:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:40:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:40:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:40:26 INFO - Intel Iris: 09:40:26 INFO - Chipset Model: Intel Iris 09:40:26 INFO - Type: GPU 09:40:26 INFO - Bus: Built-In 09:40:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:40:26 INFO - Vendor: Intel (0x8086) 09:40:26 INFO - Device ID: 0x0a2e 09:40:26 INFO - Revision ID: 0x0009 09:40:26 INFO - Displays: 09:40:26 INFO - Display: 09:40:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:40:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:40:26 INFO - Display Serial Number: 1600x1200 60 09:40:26 INFO - Main Display: Yes 09:40:26 INFO - Mirror: Off 09:40:26 INFO - Online: Yes 09:40:26 INFO - Rotation: Supported 09:40:26 INFO - Return code: 0 09:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:26 INFO - Python 2.7.3 09:40:26 INFO - Return code: 0 09:40:26 INFO - grabbing minidump binary from tooltool 09:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:26 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 0x104bd8d30>, '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 0x104affdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104bcdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:26 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 09:40:26 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 09:40:26 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 09:40:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:26 INFO - Return code: 0 09:40:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:40:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:40:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:26 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/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--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 09:40:26 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/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --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 09:40:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JyV7iFXK3z/Render', 09:40:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:40:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:40:26 INFO - 'HOME': '/Users/cltbld', 09:40:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:40:26 INFO - 'LOGNAME': 'cltbld', 09:40:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:26 INFO - 'MOZ_NO_REMOTE': '1', 09:40:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:26 INFO - 'NO_EM_RESTART': '1', 09:40:26 INFO - 'PAGER': '/bin/cat', 09:40:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:26 INFO - 'PWD': '/builds/slave/test', 09:40:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:40:26 INFO - 'SHELL': '/bin/bash', 09:40:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fH78IMXkKH/Listeners', 09:40:26 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 09:40:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:40:26 INFO - 'USER': 'cltbld', 09:40:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:40:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:26 INFO - 'XPC_FLAGS': '0x0', 09:40:26 INFO - 'XPC_SERVICE_NAME': '0', 09:40:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:40:26 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/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--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 09:40:26 INFO - mozversion application_buildid: 20161220081453 09:40:26 INFO - mozversion application_changeset: 138d3e518727488f2c500a31f2f1431a2e41d023 09:40:26 INFO - mozversion application_display_name: Nightly 09:40:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:26 INFO - mozversion application_name: Firefox 09:40:26 INFO - mozversion application_remotingname: firefox 09:40:26 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:40:26 INFO - mozversion application_vendor: Mozilla 09:40:26 INFO - mozversion application_version: 53.0a1 09:40:26 INFO - mozversion platform_buildid: 20161220081453 09:40:26 INFO - mozversion platform_changeset: 138d3e518727488f2c500a31f2f1431a2e41d023 09:40:26 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:40:26 INFO - mozversion platform_version: 53.0a1 09:40:26 INFO - using testdate: 1482255626 09:40:26 INFO - actual date: 1482255626 09:40:26 INFO - starting webserver on 'localhost:49243' 09:40:26 INFO - SUITE-START | Running 2 tests 09:40:26 INFO - TEST-START | dromaeo_css 09:40:26 INFO - operating with platform_type : mac_ 09:40:26 INFO - Initialising browser for dromaeo_css test... 09:40:26 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpvnKHdX/profile http://localhost:49243/getInfo.html) 09:40:29 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 09:40:29 INFO - PROCESS | 1637 | colorDepth:24 09:40:29 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 09:40:29 INFO - PROCESS | 1637 | __metrics 09:40:29 INFO - PROCESS | 1637 | 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" 09:40:29 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:30 INFO - TEST-INFO | 1637: exit 0 09:40:30 INFO - Browser initialized. 09:40:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:40:30 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpvnKHdX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:42 INFO - PROCESS | 1639 | RSS: Main: 237064192 09:40:42 INFO - PROCESS | 1639 | 09:41:34 INFO - PROCESS | 1639 | 1482255694270 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] 09:43:46 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 09:43:48 INFO - PROCESS | 1639 | RSS: Main: 367046656 09:43:48 INFO - PROCESS | 1639 | 09:46:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 09:46:52 INFO - PROCESS | 1639 | RSS: Main: 373207040 09:46:52 INFO - PROCESS | 1639 | 09:49:54 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 09:49:55 INFO - PROCESS | 1639 | RSS: Main: 342081536 09:49:55 INFO - PROCESS | 1639 | 09:52:57 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:52:58 INFO - PROCESS | 1639 | RSS: Main: 346648576 09:52:58 INFO - PROCESS | 1639 | 09:56:01 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:56:02 INFO - PROCESS | 1639 | RSS: Main: 337805312 09:56:02 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:59:05 INFO - PROCESS | 1639 | RSS: Main: 422965248 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | __start_tp_report 09:59:05 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 09:59:05 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 09:59:05 INFO - PROCESS | 1639 | |i|pagename|runs| 09:59:05 INFO - PROCESS | 1639 | |0;dojo.html;3028.636563612366;3345.9665403345957;3353.782004169728;3357.1103657530743;3398.980305908227;5520.66875987441;5591.329040515144;5664.886702265957;5687.715614219288;5697.430256974295;3967.623075807801;5644.435556444353;5656.91514627281;5708.543316534678;5715.914261286073;5146.305248791421;5165.173572228444;5200.609954253446;5225.973870130644;5231.267622532849;5204.271402003723;5304.734763261821;5312.840614781563;5314.468553144693;5363.651362661414;5147.716875571842;5203.843884683428;5267.657602255841;5287.947120528803;5307.124324486455;5204.609654275907;5212.973935130338;5214.556762675177;5220.895582088375;5222.947770522323;5067.619928505377;5126.846194614168;5146.922796158061;5150.562202212816;5154.07226699194;5598.972005139948;5653.547716182696;5665.49010589049;5678.630888992202;5692;6229.3770622937345;6234.127222188898;6235.719392627343;6246.750129994794;6251.531135164881;6270.216222972129;6281.560290779647;6285.717142728588;6292.968535157295;6295.937040629581;5654.6324488908085;5702.7433765480655;5710.486056254874;5769.826905192767;5780.277465316835;6286.811395658137;6326.557141000086;6341.239051313872;6357.332480089616;6367.108604795332;6160.8767824643255;6163;6177.4749146323065;6184.319724830265;6188.81433556994;6268.968655156787;6271.310155882849;6271.811845644638;6272.18461599989;6273.435390814758;6003.459688628044;6082.787102451482;6086.726097325631;6164.845878852975;6199.3490683478485;6129.511613758974;6147.508199344042;6228.128062071313;6269.529785266032;6273.215848018997;4880.999395123991;4940.357753492095;4941.45643979162;4942.975285123552;4964.627652926045;4401.295792673157;4412.360207769855;4415.116976604692;4420.115976804587;4441.422615060022;4958.735522441754;5581.274434323512;5638.436156384329;5646.632968857011;5707.800226992035;6170.197874276315;6190.969045154746;6213.130161777355;6213.937860621336;6218.782342617987;5771.538276937835;5775.711214439261;5777.8555536111935;5781.566382521243;5819.53443724501;5370.2750128732905;5376.274202982626;5401.459854014567;5414.648047876875;5438.401775804658;6246.562740608114;6281.7173227203975;6300.495960323255;6311.873762524632;6336.493080553637;6235.095911092957;6308.33762454954;6326.746930122744;6328.715207815567;6345.238571371465;6305.96847015762;6337.524685648503;6347.428731414195;6354.078658594571;6382.744690212339;6028.397160284112;6129.325774164928;6224.688765561795;6227.782027629011;6238.282597501164;6163.291221509584;6226.688665566794;6229.563930525001;6232.5948813328805;6294.937050629618;6084.300305464928;6089.086637004485;6089.877783758912;6094.847628809315;6127.295361033538;5842.152887831326;6040.033594624839;6055.636661800306;6094.786682466092;6106.3283038866575;5811.506021988178;5877.676727780014;5879.559033072622;5918.112283157561;5921.970390148022;6018.638881667114;6023.728932197974;6095.786647467317;6116.6096904373135;6144.508439324753;5877.177195192762;5905.734241959036;5913.881722365614;5919.4968427684125;5929.792457263975 09:59:05 INFO - PROCESS | 1639 | |1;ext.html;426.2859709985774;440.5110327536434;470.5106689043395;481.80005297801415;499.46058257082353;38246.235075298515;40307.39538906915;40479.59520404799;42153;42399;41855;41981;42016.369754453706;42057;42124.578754212445;8400.789980250482;9300.255979521622;9525;9529.904700952971;9542.236621070333;8434.746957591282;11111.555537778479;11380.203385762958;11381.26021808584;11538.365389903553;11287.097032237401;11349.09207263417;11349.773004539904;11373.772524549504;11405.885941140607;8450.74647760562;8642.913570864273;11246.212765106446;11317.943410282936;11336.433178341133;10898.237123401364;11251.324920504796;11256.15578831591;11423.143264255214;11427.028702560292;39195.412068818994;39617.80191099026;39651.00872478182;39709.80145099256;39749;3368.1747971747077;3380.7126394256516;3389.9656220417664;3457.6369481204615;3694.4273637586216;28754.42491150186;30063.098107056823;30320.696793032228;30332.938347157964;30345;2984.7164519370626;3202.8558714857886;3226.548283240348;3278.1968417737567;3332.1169889979174;505522;506609;510430;511948.44025780004;517177;54915.72542137264;57473.42526574681;57844;57985.71007144937;58039.41960580424;56519.869602607716;56637;56678.43321566814;56742;56824.579385515695;15289.923550382176;15530.068195908056;15555.533333999998;15586.220688965734;15643.139627320379;10951.123910087173;11209.495572699248;11969.281843089268;12128.575499857463;12191.87808121925;15015.549533514011;15227.619309517351;15404.306806193748;15415.691686166214;15421.151836649093;6352.968235158794;7060.682269297894;7120.614594110927;7209.495335326476;7299.5255308404785;824.3116997307316;929.5491686532026;976.5947131940165;1020.3520764314713;1079.5088234853124;22120.557588848133;27668;29051.41897162045;30060.54909176364;30183.69816301853;886.3441053620403;1064.4571268653042;1070.753726642861;1086.2721976275914;1112.2214449885112;14056.929715351358;14973.850261497246;15019.624509387135;15266.007709498846;15435.919485635897;629497;635100;636050;637173.6282637115;638037;57377.42622573804;57692;57711.42288577145;57752.422475775544;58735.825283494945;1212.7392610588765;1258.1381753498883;1302.2772361339548;1302.5636411802152;1406.9437222510985;28480.287992800346;29831.955881544043;30007;30614.84692576523;31436;51215.2317715242;51976.48023519868;51995.700107497614;52112.95774084421;52135.739321303154;580870;587683;587732;588626;591143;37281.04887481877;37342.06644833901;37677.81161094177;37880.43179352257;37888;37926.24147517089;39899.800500997306;43493;45455;47247.055058899314;31179.220519487193;36930.81534592417;37047.25905481929;37136.81431592825;38253.2349353017;35956.64043359533;35962.74130405423;36743;37132.44301335428;37225.88322350334;36407.45388819223;36497;36937.26125477422;37316.25367492689;37382.62617373792;31105.688943111185;32006.19984500313;33451.83274083614;33663;33732;23700.170494032627;24430.565393940054;24528.87735561311;24932.376690582154;25014.98659876007 09:59:05 INFO - PROCESS | 1639 | |2;jquery.html;333.0880744526418;379.86324923027706;389.13805919887454;398.1757761433833;407.5496576283207;13606.795898061524;19124.33064842731;19288.132034058483;19525.12136953837;19775.703364449546;18837.62324753504;19546;19891.90594517301;20420.285290014854;20451.97740112992;5141.15170996785;5338.466153384669;5342.866428339284;5343.679379237258;5718.942810571883;7407.518511296776;7609.923900761005;7612.619369031554;7617.238276172394;7657.4639775215755;6704.128463299764;7238.420926325882;7265.7456989005395;7567.62161891906;7614.657340419667;7187.353138217533;7571.31858132768;7577.3180413762475;7625.466217364787;7633.313001829834;7281.417486601059;7407.6666550005375;7421.146568144679;7425.8514829703645;7443.032405787267;25450.36374090644;27648;27882.721172788217;27894.16317510478;28132.156035318974;2572.704139023999;2599.3371690219064;2850.3586692994118;3177.4757165067736;3197.984010079958;15277.923610381988;15450.690986180214;16229.052513698432;16531.33874645025;17156.485305440856;1861.8045105264023;1925.5089952062274;2024.3926821953355;2045.9693104603443;2064.133064113061;81804.59097704533;101213;104233.99999999924;131316.34341828324;136427.31786341005;19408.223671053;19873.60252794936;20256.291029813885;20710.378688639365;20795.37613871556;27383;34247;34359.484607730905;34366.65633343685;34378.140546486036;8785.692500762443;10184.236182286359;10343.689689309333;10435.68692939213;10566.366018038942;8525.147485251426;8550.888384510099;8553.101924297984;8672.739817805475;8676.175763302475;7802.921970780333;7846.882296765553;9424.198943089914;9570.665026724031;9618.807623847484;3707.35121353762;3726.124360775216;3727.7204209684382;3741.494898188764;3821.7133714971487;837.7989282572139;894.3024440936081;911.6490151291667;917.6100157433065;979.1139019187647;16514.58713532171;16758.74861877073;18864.905675471808;19367.48222731064;20109.698354524695;824.5712229640674;882.4043770455046;903.9864402033975;904.1636486250193;979.8383266761048;9464.858027129598;10645.574177032986;10679.305845120043;10739.624113156158;10743;473769;488502;490661;498384;503251.48374257894;84484;110316;114489.28266076016;120817;121145.39427302807;947.3794664494767;976.6142373762466;994.5777538120412;994.627014869424;995.8100070415784;17990.910045449687;18668.973206473773;18755.874647521192;18850.434486965412;18949.33677321287;45403.77298113488;46450.76774616105;49496.25755613597;49568.75215623899;50258.748706256236;69623;70904.64547677229;71021.28978710147;71309.64345178241;72145.6392718033;7888.48724832884;7925.722599708983;7944.960275198587;7997.840043198987;8142.47073940192;10633.415162166155;11919.284842909454;12003.759924801281;12611.621651350475;12631.557895473614;8495.830083398421;10564.683059508227;11000.394978276272;11054.281471704635;11103.500342484445;10425.374477531372;10510.527026283682;10629.20280978945;10846.566137354417;11106.055985241344;8740.825183496167;10848.457577120955;10925.945370273097;10964.835527467254;11147.72130696739;7802.141764406025;8034.357251419756;8034.437589368688;8052.355811535181;8055.83888322242;8045.718399855977;10626.468676565986;10747.140228781522;10902.836457452986;10999.285046471954 09:59:05 INFO - PROCESS | 1639 | |3;mootools.html;1516.97724534132;1525.0773282164294;1755.2276998120826;1883.2184643373;1918.4724200844767;8160.4695694779875;8454.87317690235;8472;8562.91437085629;8629.91370086299;7555.206703296157;7764.456488045839;7789.571573563452;8053.073896501904;8428.873566896485;2279.418748219206;2338.3920180752957;2340.473393486469;2340.8361414700976;2345.331580499558;1978.6636271833752;2329.1615018593293;2358.5047140100514;2360.1621424394266;2374.881255937205;2315.5716192504356;2318.5015221727326;2342.3324352559525;2345.331580499558;2351.130081869702;2275.9089636414606;2307.3193407944696;2313.733920599119;2314.4908120213527;2320.3734991552355;2290.3014580552926;2312.5606134834497;2337.3922780077132;2341;2345.683332750074;8342.666293348258;8537.402381833273;8537.487750734976;8561.315094792402;8597.828043439158;5030.471800460936;5197.194434862602;5204.193350030751;5218.060749065166;5219.817306394258;3225.1775797171804;3337.749668774827;3472.0625431133703;3473.11435583927;3484.1289677580603;877.5743764274322;931.8741969834122;935.3873213045466;964.1997142371814;1014.9441780702058;10969.83545246822;11014.339139651567;11023.118150547936;11024.007839294422;11088.889111108867;4524.389207457017;4569.680122391467;4655.604273636779;4666.719996800135;4747.786349614275;8713.564321783886;8859.51272679996;8871.201591856634;8880.600372983232;8884.244839188741;5112.105381558213;5158.045761534128;5166.638335316492;5169.560587350042;5170.896582068338;4620.422447194101;4734.076855013308;4804.73573953429;4840.515948405131;4864.221724524059;3462.082548124749;3495.9126021849656;3525.383057964846;3553.822308884597;3575.2313252650806;1131.8811524789944;1137.2380505061628;1138.6697857621198;1149.1611123879616;1149.597640825721;827.210014436212;844.7212419901418;896.6771962093641;915.8305713443034;962.7256231973854;5467.535259502907;5558.693706978937;5747.597668163272;5930.673812940329;5935.52515798735;835.2482765510968;900.9684661036963;924.3437159616612;933.4632586262926;939.5677988125539;3811.447340135665;3842.9039274018373;3855.1133239354544;3909.550401703784;3943.6056394360335;9901.653442129491;10156.898431015596;10252.282340236112;10277.9486102569;10295.74260643475;9822.361546499455;9836.950815245878;10161.847572286273;10171.237157213238;10198.592056317813;7484.1393239777035;7823.491473054233;7882.290593846581;7883.526988380716;8035.196480351918;5748.568857335633;5770.538356931519;5772.105323674838;5828.621139626081;5913.723216561569;9006.099390061203;9006.639734410812;9463.763405914908;9466.148046675833;9575.569099390683;8834.29325653959;9496.810063798823;9508.239340852853;9644.9035509644;9722.562484688064;6684.331566843472;6918;7071.964640176766;7264.309890560388;7269.527480713737;7654.387648987956;7923;8041.276285134366;8082.676692932452;8139.10469848328;7216.7113315466795;7218.097737782778;7255.709771609077;7298.781036568911;7301.452391070585;7055.753048643272;7059.435245180476;7086.220515743367;7152.821179470555;7222.6388680566815;6580.21037475506;6662.6335551545135;6663.866722665616;6772.729090836311;6786.21958474762;4774.594159496342;4843.39457567804;4900.583450406612;4936.950630493649;5074.847754567369;4343.826246950213;4806.279058141167;4856.78144483492;4972.925406118983;5016.347874776256 09:59:05 INFO - PROCESS | 1639 | |4;prototype.html;355.6408027891829;364.17514330042457;368.46204541369605;379.8841353387216;380.3477036881747;4681.250999840026;4742.909130899895;5158.744036170156;5201.817936372227;5423.186522021699;4357.738535687861;4411.360352748849;4835.8791030224265;5172.19830926207;5226.189940559219;3854.9807250963704;4091.1204091120476;4149.917001659965;4154.854580089683;4187.371894215877;3786;3830.873865004935;4159.500859896817;4200.537940826506;4205.7897105144775;3273.3616944695796;3328.9500657490157;3611;3993.6405723485027;4143.839724877039;3429.2798512312443;4077.921169517025;4104.117614712821;4142.047329114305;4143.4199212110325;3476;3632;3647.562292524914;3674.595794462607;3681.208540163878;4364.629006534448;4559.544045595447;5117.616178786606;5119.846404607868;5130.7947682093045;4654.418197725285;4724.622030237572;4733.242681170997;4753.4771175171045;4763.737994410306;5383.865403364908;5518.586106042063;5532.5573954083575;5670.546356291528;5671.9716401418145;3664.727868721383;3987.98006009971;4028.536718277406;4042.939355909664;4075.5924407559305;4749.1926372516755;5153.587712982952;5845.357010728816;5899.882002359929;5911.408859114097;3674.9081272967856;3674.9342690619956;3701.6483434074257;3751.531058617673;3862.613738626171;3510.7015903648476;3858.951428371555;3888.1640447303967;3903.8633647822758;3915.9021024474614;4343.370211319341;4376.102898905717;4432.578905004019;4492.090861383964;4571.565701258375;4922.852314430573;5314.335708036496;5544.889102218014;5558.527525160407;5562.803997140553;1086.7450041164616;1118.552578968419;1184.5202692909386;1235.604606525921;1255.4036832504487;752.6537792615349;805.9476134051268;809.7651681012558;849.587949844325;871.1897934920585;4689.7655117244;4873.147199240118;4957.454679985199;5045.697258164522;5073.568746656576;4809.062232864628;4954.504549545089;5360.3299587551555;5481.808136715275;5549.3906767037915;4378.496472905593;5116.181410974226;5387.24578559002;5406.810501689701;5412.404635490093;2716.483868065101;2728.6316347292864;2743.6281859070464;2803.897077192106;2878.6833448320667;4953.455119936804;5130.9230361544605;5421.756020979065;5443.5100840923715;5772.422757724194;5010.849674509771;5048.8232911848645;5170.844874653766;5617.550595952314;5633.492985631231;4999.500049994971;5232.555232805178;5718.4567466091485;5761.020626493422;5797.898399304118;5004.974975125101;5215.973920130375;5524.364698059614;5567.220589117445;5707.771689132388;4686.671932964659;5094.770735316845;5305.151175811851;5532.585056120887;5623.493885550321;5390.811321603725;5820.796272130455;5863.254011069262;6065.302490213506;6090.482309003607;3700.1119731263766;3824.3116239077235;3849.883533775174;3866.2267546491375;3889.533256009297;4837.080954618611;5203.401608815035;5364.731763411892;5754.482096611325;5777.367067109534;4655.23188673865;5601.915971260516;5665.5750818689585;5688.40271771458;5727.369989301257;5275.287836142072;5425.7174409481695;5618.9604923089355;5691.800786972436;5739.814403006371;4265.594768496988;5231.921521177109;5281.049411105884;5354.170103633943;5498.945010550004;5526;5581.49766521015;5617.915731263953;5628.690422026828;5667.40492248308;4812.205986012269;4860.416749990024;5488.941646882419;5598.188262701967;5607.8878422432135 09:59:05 INFO - PROCESS | 1639 | |5;yui.html;712.4229374206891;738.7525179065013;745.7278093495872;776.9156448897877;800.4716886854677;15095.698086038286;15676.84323156768;15708.293126809278;15713.371465141408;15715.607109822246;14262.786058209134;14451.92774036131;14458;14474;14531.854681453182;698.8602279544086;726.1649103530955;731.0605871455181;731.0788406607672;851.2508992086986;877.9385443018991;880.9735707928772;885.5970533407317;887.3921363865741;890.1899271662788;961.870147530085;963.7301555564418;964.7009427077593;966.6085235479607;967.666155176463;949.3734135470626;951.2009911674193;953.4041224234853;953.9713808585753;954.88063992001;548.6872482684871;568.5877738639495;675.2032601530192;708.8369674974784;715.6564848872571;14741;15167.924160379127;15178.620534486616;15222.086674799548;15285.847141528553;13699.260147970446;13721.176729396268;13765.036447448683;13903.443862245498;13908.37412316438;11263.774724505463;12353.197042192318;12650.873491265154;12712.682182945407;12903.483860645563;4027.154297597508;4081.4081958115908;4251.043515209084;4299.419578356913;4311.137772445492;97201.51399242958;97626;98315.52526712105;99472.50263748635;99814;10322.451632255223;10481.318714283547;10727.409992450333;10933.453327333602;11340.489677964511;21657.91710414473;21870.45323866916;21870.45323866916;21878.343649690534;21885.562288754136;7607.809804754926;7617.733379331697;7633.465657403928;7695.384369250447;7761.5994567278985;4161.51422075069;4208.8316467340965;4274.337477690963;4292.978535107367;4432.113577284556;3218.082846388768;3294.6870047345465;3370.7808992415416;3406.1654894550993;3414.7951122932704;578.1587789765881;579.9043157878987;581.2995340614549;582.2285471749948;584.8976429124971;522.7595306159134;574.5292052346008;596.7642781101528;607.8601921557978;617.4566381584267;7226.313500217471;8384.83230335402;8688.6524539019;8742.300615950835;8766.868496972551;514.0977584339535;582.7090022594829;604.4106995679177;618.832915112917;646.5086534233922;3835.9616403835603;3974.721769476109;4043.6158564936286;4044.2113787811095;4150.750954942713;104606;107061.46469267603;107770;108764.91235087547;110559;89914;91398.54300728453;91917.62123568152;92879;95254;54357.728211359485;76390;76962.61518692371;78964.81552776713;81129.18870811453;7827.804304892423;7855.921440785519;7923.920760792318;7954.801129971565;8187.83624327522;35726.642733572335;41310.79344603258;49855.750721246164;52536;54103.72948135234;60351;72748;73869.89195161969;75205.74382768526;78829;9253.583588738658;11142.164337674869;11157.832632510357;11165.050970667584;11720.296782193096;11648.650540483799;11851.288922664668;11867.287962722265;12218.816717749418;12342.506299747909;11833.230839995373;12180.269183848997;12186.086043546948;12448;12449.128561001005;12114.454849531969;13348.399322030726;13857.722845543234;14169.10580456653;14238.644033899236;12936.870631293566;13043.934780326037;13408.530701425403;13556.59330220095;13966.650833729238;10295.330803497749;10731.673181313818;10934.305182696377;11422.428878555873;11584.652460426201;11043.226974112056;11283.66149015531;11410.543578256777;11555;11608.535658573563 09:59:05 INFO - PROCESS | 1639 | __end_tp_report 09:59:05 INFO - PROCESS | 1639 | __start_cc_report 09:59:05 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,2024 09:59:05 INFO - PROCESS | 1639 | __end_cc_report 09:59:05 INFO - PROCESS | 1639 | __startTimestamp1482256745896__endTimestamp 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | ------- Summary: start ------- 09:59:05 INFO - PROCESS | 1639 | Number of tests: 6 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5725.60 Median:5918.11 stddev:663.88 (11.2%) stddev-sans-first:631.30 09:59:05 INFO - PROCESS | 1639 | Values: 3028.6 3346.0 3353.8 3357.1 3399.0 5520.7 5591.3 5664.9 5687.7 5697.4 3967.6 5644.4 5656.9 5708.5 5715.9 5146.3 5165.2 5200.6 5226.0 5231.3 5204.3 5304.7 5312.8 5314.5 5363.7 5147.7 5203.8 5267.7 5287.9 5307.1 5204.6 5213.0 5214.6 5220.9 5222.9 5067.6 5126.8 5146.9 5150.6 5154.1 5599.0 5653.5 5665.5 5678.6 5692.0 6229.4 6234.1 6235.7 6246.8 6251.5 6270.2 6281.6 6285.7 6293.0 6295.9 5654.6 5702.7 5710.5 5769.8 5780.3 6286.8 6326.6 6341.2 6357.3 6367.1 6160.9 6163.0 6177.5 6184.3 6188.8 6269.0 6271.3 6271.8 6272.2 6273.4 6003.5 6082.8 6086.7 6164.8 6199.3 6129.5 6147.5 6228.1 6269.5 6273.2 4881.0 4940.4 4941.5 4943.0 4964.6 4401.3 4412.4 4415.1 4420.1 4441.4 4958.7 5581.3 5638.4 5646.6 5707.8 6170.2 6191.0 6213.1 6213.9 6218.8 5771.5 5775.7 5777.9 5781.6 5819.5 5370.3 5376.3 5401.5 5414.6 5438.4 6246.6 6281.7 6300.5 6311.9 6336.5 6235.1 6308.3 6326.7 6328.7 6345.2 6306.0 6337.5 6347.4 6354.1 6382.7 6028.4 6129.3 6224.7 6227.8 6238.3 6163.3 6226.7 6229.6 6232.6 6294.9 6084.3 6089.1 6089.9 6094.8 6127.3 5842.2 6040.0 6055.6 6094.8 6106.3 5811.5 5877.7 5879.6 5918.1 5922.0 6018.6 6023.7 6095.8 6116.6 6144.5 5877.2 5905.7 5913.9 5919.5 5929.8 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:70601.13 Median:20370.84 stddev:154976.44 (760.8%) stddev-sans-first:155321.63 09:59:05 INFO - PROCESS | 1639 | Values: 426.3 440.5 470.5 481.8 499.5 38246.2 40307.4 40479.6 42153.0 42399.0 41855.0 41981.0 42016.4 42057.0 42124.6 8400.8 9300.3 9525.0 9529.9 9542.2 8434.7 11111.6 11380.2 11381.3 11538.4 11287.1 11349.1 11349.8 11373.8 11405.9 8450.7 8642.9 11246.2 11317.9 11336.4 10898.2 11251.3 11256.2 11423.1 11427.0 39195.4 39617.8 39651.0 39709.8 39749.0 3368.2 3380.7 3390.0 3457.6 3694.4 28754.4 30063.1 30320.7 30332.9 30345.0 2984.7 3202.9 3226.5 3278.2 3332.1 505522.0 506609.0 510430.0 511948.4 517177.0 54915.7 57473.4 57844.0 57985.7 58039.4 56519.9 56637.0 56678.4 56742.0 56824.6 15289.9 15530.1 15555.5 15586.2 15643.1 10951.1 11209.5 11969.3 12128.6 12191.9 15015.5 15227.6 15404.3 15415.7 15421.2 6353.0 7060.7 7120.6 7209.5 7299.5 824.3 929.5 976.6 1020.4 1079.5 22120.6 27668.0 29051.4 30060.5 30183.7 886.3 1064.5 1070.8 1086.3 1112.2 14056.9 14973.9 15019.6 15266.0 15435.9 629497.0 635100.0 636050.0 637173.6 638037.0 57377.4 57692.0 57711.4 57752.4 58735.8 1212.7 1258.1 1302.3 1302.6 1406.9 28480.3 29832.0 30007.0 30614.8 31436.0 51215.2 51976.5 51995.7 52113.0 52135.7 580870.0 587683.0 587732.0 588626.0 591143.0 37281.0 37342.1 37677.8 37880.4 37888.0 37926.2 39899.8 43493.0 45455.0 47247.1 31179.2 36930.8 37047.3 37136.8 38253.2 35956.6 35962.7 36743.0 37132.4 37225.9 36407.5 36497.0 36937.3 37316.3 37382.6 31105.7 32006.2 33451.8 33663.0 33732.0 23700.2 24430.6 24528.9 24932.4 25015.0 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:32164.28 Median:3726.92 stddev:82147.49 (2204.2%) stddev-sans-first:82343.17 09:59:05 INFO - PROCESS | 1639 | Values: 333.1 379.9 389.1 398.2 407.5 13606.8 19124.3 19288.1 19525.1 19775.7 18837.6 19546.0 19891.9 20420.3 20452.0 5141.2 5338.5 5342.9 5343.7 5718.9 7407.5 7609.9 7612.6 7617.2 7657.5 6704.1 7238.4 7265.7 7567.6 7614.7 7187.4 7571.3 7577.3 7625.5 7633.3 7281.4 7407.7 7421.1 7425.9 7443.0 25450.4 27648.0 27882.7 27894.2 28132.2 2572.7 2599.3 2850.4 3177.5 3198.0 15277.9 15450.7 16229.1 16531.3 17156.5 1861.8 1925.5 2024.4 2046.0 2064.1 81804.6 101213.0 104234.0 131316.3 136427.3 19408.2 19873.6 20256.3 20710.4 20795.4 27383.0 34247.0 34359.5 34366.7 34378.1 8785.7 10184.2 10343.7 10435.7 10566.4 8525.1 8550.9 8553.1 8672.7 8676.2 7802.9 7846.9 9424.2 9570.7 9618.8 3707.4 3726.1 3727.7 3741.5 3821.7 837.8 894.3 911.6 917.6 979.1 16514.6 16758.7 18864.9 19367.5 20109.7 824.6 882.4 904.0 904.2 979.8 9464.9 10645.6 10679.3 10739.6 10743.0 473769.0 488502.0 490661.0 498384.0 503251.5 84484.0 110316.0 114489.3 120817.0 121145.4 947.4 976.6 994.6 994.6 995.8 17990.9 18669.0 18755.9 18850.4 18949.3 45403.8 46450.8 49496.3 49568.8 50258.7 69623.0 70904.6 71021.3 71309.6 72145.6 7888.5 7925.7 7945.0 7997.8 8142.5 10633.4 11919.3 12003.8 12611.6 12631.6 8495.8 10564.7 11000.4 11054.3 11103.5 10425.4 10510.5 10629.2 10846.6 11106.1 8740.8 10848.5 10925.9 10964.8 11147.7 7802.1 8034.4 8034.4 8052.4 8055.8 8045.7 10626.5 10747.1 10902.8 10999.3 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5459.99 Median:5211.13 stddev:2989.77 (57.4%) stddev-sans-first:2983.47 09:59:05 INFO - PROCESS | 1639 | Values: 1517.0 1525.1 1755.2 1883.2 1918.5 8160.5 8454.9 8472.0 8562.9 8629.9 7555.2 7764.5 7789.6 8053.1 8428.9 2279.4 2338.4 2340.5 2340.8 2345.3 1978.7 2329.2 2358.5 2360.2 2374.9 2315.6 2318.5 2342.3 2345.3 2351.1 2275.9 2307.3 2313.7 2314.5 2320.4 2290.3 2312.6 2337.4 2341.0 2345.7 8342.7 8537.4 8537.5 8561.3 8597.8 5030.5 5197.2 5204.2 5218.1 5219.8 3225.2 3337.7 3472.1 3473.1 3484.1 877.6 931.9 935.4 964.2 1014.9 10969.8 11014.3 11023.1 11024.0 11088.9 4524.4 4569.7 4655.6 4666.7 4747.8 8713.6 8859.5 8871.2 8880.6 8884.2 5112.1 5158.0 5166.6 5169.6 5170.9 4620.4 4734.1 4804.7 4840.5 4864.2 3462.1 3495.9 3525.4 3553.8 3575.2 1131.9 1137.2 1138.7 1149.2 1149.6 827.2 844.7 896.7 915.8 962.7 5467.5 5558.7 5747.6 5930.7 5935.5 835.2 901.0 924.3 933.5 939.6 3811.4 3842.9 3855.1 3909.6 3943.6 9901.7 10156.9 10252.3 10277.9 10295.7 9822.4 9837.0 10161.8 10171.2 10198.6 7484.1 7823.5 7882.3 7883.5 8035.2 5748.6 5770.5 5772.1 5828.6 5913.7 9006.1 9006.6 9463.8 9466.1 9575.6 8834.3 9496.8 9508.2 9644.9 9722.6 6684.3 6918.0 7072.0 7264.3 7269.5 7654.4 7923.0 8041.3 8082.7 8139.1 7216.7 7218.1 7255.7 7298.8 7301.5 7055.8 7059.4 7086.2 7152.8 7222.6 6580.2 6662.6 6663.9 6772.7 6786.2 4774.6 4843.4 4900.6 4937.0 5074.8 4343.8 4806.3 4856.8 4972.9 5016.3 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4459.35 Median:4955.98 stddev:1358.27 (27.4%) stddev-sans-first:1326.70 09:59:05 INFO - PROCESS | 1639 | Values: 355.6 364.2 368.5 379.9 380.3 4681.3 4742.9 5158.7 5201.8 5423.2 4357.7 4411.4 4835.9 5172.2 5226.2 3855.0 4091.1 4149.9 4154.9 4187.4 3786.0 3830.9 4159.5 4200.5 4205.8 3273.4 3329.0 3611.0 3993.6 4143.8 3429.3 4077.9 4104.1 4142.0 4143.4 3476.0 3632.0 3647.6 3674.6 3681.2 4364.6 4559.5 5117.6 5119.8 5130.8 4654.4 4724.6 4733.2 4753.5 4763.7 5383.9 5518.6 5532.6 5670.5 5672.0 3664.7 3988.0 4028.5 4042.9 4075.6 4749.2 5153.6 5845.4 5899.9 5911.4 3674.9 3674.9 3701.6 3751.5 3862.6 3510.7 3859.0 3888.2 3903.9 3915.9 4343.4 4376.1 4432.6 4492.1 4571.6 4922.9 5314.3 5544.9 5558.5 5562.8 1086.7 1118.6 1184.5 1235.6 1255.4 752.7 805.9 809.8 849.6 871.2 4689.8 4873.1 4957.5 5045.7 5073.6 4809.1 4954.5 5360.3 5481.8 5549.4 4378.5 5116.2 5387.2 5406.8 5412.4 2716.5 2728.6 2743.6 2803.9 2878.7 4953.5 5130.9 5421.8 5443.5 5772.4 5010.8 5048.8 5170.8 5617.6 5633.5 4999.5 5232.6 5718.5 5761.0 5797.9 5005.0 5216.0 5524.4 5567.2 5707.8 4686.7 5094.8 5305.2 5532.6 5623.5 5390.8 5820.8 5863.3 6065.3 6090.5 3700.1 3824.3 3849.9 3866.2 3889.5 4837.1 5203.4 5364.7 5754.5 5777.4 4655.2 5601.9 5665.6 5688.4 5727.4 5275.3 5425.7 5619.0 5691.8 5739.8 4265.6 5231.9 5281.0 5354.2 5498.9 5526.0 5581.5 5617.9 5628.7 5667.4 4812.2 4860.4 5488.9 5598.2 5607.9 09:59:05 INFO - PROCESS | 1639 | 09:59:05 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20160.57 Median:4262.69 stddev:29470.65 (691.4%) stddev-sans-first:29517.15 09:59:05 INFO - PROCESS | 1639 | Values: 712.4 738.8 745.7 776.9 800.5 15095.7 15676.8 15708.3 15713.4 15715.6 14262.8 14451.9 14458.0 14474.0 14531.9 698.9 726.2 731.1 731.1 851.3 877.9 881.0 885.6 887.4 890.2 961.9 963.7 964.7 966.6 967.7 949.4 951.2 953.4 954.0 954.9 548.7 568.6 675.2 708.8 715.7 14741.0 15167.9 15178.6 15222.1 15285.8 13699.3 13721.2 13765.0 13903.4 13908.4 11263.8 12353.2 12650.9 12712.7 12903.5 4027.2 4081.4 4251.0 4299.4 4311.1 97201.5 97626.0 98315.5 99472.5 99814.0 10322.5 10481.3 10727.4 10933.5 11340.5 21657.9 21870.5 21870.5 21878.3 21885.6 7607.8 7617.7 7633.5 7695.4 7761.6 4161.5 4208.8 4274.3 4293.0 4432.1 3218.1 3294.7 3370.8 3406.2 3414.8 578.2 579.9 581.3 582.2 584.9 522.8 574.5 596.8 607.9 617.5 7226.3 8384.8 8688.7 8742.3 8766.9 514.1 582.7 604.4 618.8 646.5 3836.0 3974.7 4043.6 4044.2 4150.8 104606.0 107061.5 107770.0 108764.9 110559.0 89914.0 91398.5 91917.6 92879.0 95254.0 54357.7 76390.0 76962.6 78964.8 81129.2 7827.8 7855.9 7923.9 7954.8 8187.8 35726.6 41310.8 49855.8 52536.0 54103.7 60351.0 72748.0 73869.9 75205.7 78829.0 9253.6 11142.2 11157.8 11165.1 11720.3 11648.7 11851.3 11867.3 12218.8 12342.5 11833.2 12180.3 12186.1 12448.0 12449.1 12114.5 13348.4 13857.7 14169.1 14238.6 12936.9 13043.9 13408.5 13556.6 13966.7 10295.3 10731.7 10934.3 11422.4 11584.7 11043.2 11283.7 11410.5 11555.0 11608.5 09:59:05 INFO - PROCESS | 1639 | -------- Summary: end -------- 09:59:05 INFO - PROCESS | 1639 | 09:59:06 INFO - TEST-INFO | 1639: exit 0 09:59:06 INFO - TEST-OK | dromaeo_css | took 1119774ms 09:59:06 INFO - TEST-START | kraken 09:59:06 INFO - operating with platform_type : mac_ 09:59:06 INFO - Initialising browser for kraken test... 09:59:06 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp2xJV1D/profile http://localhost:49243/getInfo.html) 09:59:08 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:59:08 INFO - PROCESS | 1649 | colorDepth:24 09:59:08 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:59:08 INFO - PROCESS | 1649 | __metrics 09:59:08 INFO - PROCESS | 1649 | 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" 09:59:08 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:09 INFO - TEST-INFO | 1649: exit 0 09:59:09 INFO - Browser initialized. 09:59:09 INFO - Running cycle 1/1 for kraken test... 09:59:09 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp2xJV1D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:21 INFO - PROCESS | 1650 | RSS: Main: 238174208 09:59:21 INFO - PROCESS | 1650 | 09:59:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:25 INFO - PROCESS | 1650 | RSS: Main: 289615872 09:59:25 INFO - PROCESS | 1650 | 09:59:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:59:28 INFO - PROCESS | 1650 | RSS: Main: 290996224 09:59:28 INFO - PROCESS | 1650 | 09:59:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:59:32 INFO - PROCESS | 1650 | RSS: Main: 382115840 09:59:32 INFO - PROCESS | 1650 | 09:59:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:59:35 INFO - PROCESS | 1650 | RSS: Main: 287363072 09:59:35 INFO - PROCESS | 1650 | 09:59:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:37 INFO - PROCESS | 1650 | RSS: Main: 289763328 09:59:37 INFO - PROCESS | 1650 | 09:59:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:41 INFO - PROCESS | 1650 | RSS: Main: 332582912 09:59:41 INFO - PROCESS | 1650 | 09:59:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:45 INFO - PROCESS | 1650 | RSS: Main: 333942784 09:59:45 INFO - PROCESS | 1650 | 09:59:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:59:48 INFO - PROCESS | 1650 | RSS: Main: 331653120 09:59:48 INFO - PROCESS | 1650 | 09:59:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:50 INFO - PROCESS | 1650 | RSS: Main: 305123328 09:59:50 INFO - PROCESS | 1650 | 09:59:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:53 INFO - PROCESS | 1650 | RSS: Main: 309972992 09:59:53 INFO - PROCESS | 1650 | 09:59:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:56 INFO - PROCESS | 1650 | RSS: Main: 310784000 09:59:56 INFO - PROCESS | 1650 | 09:59:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:00 INFO - PROCESS | 1650 | RSS: Main: 321634304 10:00:00 INFO - PROCESS | 1650 | 10:00:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:03 INFO - PROCESS | 1650 | RSS: Main: 320634880 10:00:03 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:00:05 INFO - PROCESS | 1650 | RSS: Main: 365010944 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | __start_tp_report 10:00:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 10:00:05 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 10:00:05 INFO - PROCESS | 1650 | |i|pagename|runs| 10:00:05 INFO - PROCESS | 1650 | |0;ai-astar;114;116;114;113;113;113;120;123;113;113 10:00:05 INFO - PROCESS | 1650 | |1;audio-beat-detection;146;111;110;176;116;113;110;110;131;111 10:00:05 INFO - PROCESS | 1650 | |2;audio-dft;184;184;183;184;183;184;184;185;182;181 10:00:05 INFO - PROCESS | 1650 | |3;audio-fft;79;59;58;86;64;82;87;84;74;58 10:00:05 INFO - PROCESS | 1650 | |4;audio-oscillator;90;69;89;70;68;69;85;68;68;84 10:00:05 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;107;109;108;109;108;110;107;110;107;108 10:00:05 INFO - PROCESS | 1650 | |6;imaging-darkroom;94;95;131;161;95;96;95;95;94;96 10:00:05 INFO - PROCESS | 1650 | |7;imaging-desaturate;93;88;71;79;131;139;115;87;86;87 10:00:05 INFO - PROCESS | 1650 | |8;json-parse-financial;56;53;54;53;55;54;54;55;55;54 10:00:05 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;70;70;81;74;72;70;70;70;69;72 10:00:05 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;88;88;87;88;88;87;87;85;91;88 10:00:05 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;143;152;133;138;141;139;140;141;231;149 10:00:05 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;180;176;170;171;173;169;169;169;172;173 10:00:05 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;67;66;66;68;69 10:00:05 INFO - PROCESS | 1650 | __end_tp_report 10:00:05 INFO - PROCESS | 1650 | __start_cc_report 10:00:05 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1964 10:00:05 INFO - PROCESS | 1650 | __end_cc_report 10:00:05 INFO - PROCESS | 1650 | __startTimestamp1482256805581__endTimestamp 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | ------- Summary: start ------- 10:00:05 INFO - PROCESS | 1650 | Number of tests: 14 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:115.20 Median:114.00 stddev:3.52 (3.1%) stddev-sans-first:3.71 10:00:05 INFO - PROCESS | 1650 | Values: 114.0 116.0 114.0 113.0 113.0 113.0 120.0 123.0 113.0 113.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:123.40 Median:114.50 stddev:21.97 (19.2%) stddev-sans-first:21.73 10:00:05 INFO - PROCESS | 1650 | Values: 146.0 111.0 110.0 176.0 116.0 113.0 110.0 110.0 131.0 111.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.17 (0.6%) stddev-sans-first:1.22 10:00:05 INFO - PROCESS | 1650 | Values: 184.0 184.0 183.0 184.0 183.0 184.0 184.0 185.0 182.0 181.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:73.10 Median:80.50 stddev:12.16 (15.1%) stddev-sans-first:12.71 10:00:05 INFO - PROCESS | 1650 | Values: 79.0 59.0 58.0 86.0 64.0 82.0 87.0 84.0 74.0 58.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:9.64 (12.5%) stddev-sans-first:8.79 10:00:05 INFO - PROCESS | 1650 | Values: 90.0 69.0 89.0 70.0 68.0 69.0 85.0 68.0 68.0 84.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:108.30 Median:108.50 stddev:1.16 (1.1%) stddev-sans-first:1.13 10:00:05 INFO - PROCESS | 1650 | Values: 107.0 109.0 108.0 109.0 108.0 110.0 107.0 110.0 107.0 108.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:95.00 stddev:22.65 (23.8%) stddev-sans-first:23.65 10:00:05 INFO - PROCESS | 1650 | Values: 94.0 95.0 131.0 161.0 95.0 96.0 95.0 95.0 94.0 96.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:86.50 stddev:22.75 (26.3%) stddev-sans-first:24.07 10:00:05 INFO - PROCESS | 1650 | Values: 93.0 88.0 71.0 79.0 131.0 139.0 115.0 87.0 86.0 87.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:0.78 10:00:05 INFO - PROCESS | 1650 | Values: 56.0 53.0 54.0 53.0 55.0 54.0 54.0 55.0 55.0 54.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.00 stddev:3.55 (5.0%) stddev-sans-first:3.71 10:00:05 INFO - PROCESS | 1650 | Values: 70.0 70.0 81.0 74.0 72.0 70.0 70.0 70.0 69.0 72.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 10:00:05 INFO - PROCESS | 1650 | Values: 88.0 88.0 87.0 88.0 88.0 87.0 87.0 85.0 91.0 88.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:142.00 stddev:28.72 (20.2%) stddev-sans-first:30.33 10:00:05 INFO - PROCESS | 1650 | Values: 143.0 152.0 133.0 138.0 141.0 139.0 140.0 141.0 231.0 149.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.50 stddev:3.55 (2.1%) stddev-sans-first:2.40 10:00:05 INFO - PROCESS | 1650 | Values: 180.0 176.0 170.0 171.0 173.0 169.0 169.0 169.0 172.0 173.0 10:00:05 INFO - PROCESS | 1650 | 10:00:05 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 10:00:05 INFO - PROCESS | 1650 | Values: 67.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 68.0 69.0 10:00:05 INFO - PROCESS | 1650 | -------- Summary: end -------- 10:00:05 INFO - PROCESS | 1650 | 10:00:06 INFO - TEST-INFO | 1650: exit 0 10:00:06 INFO - TEST-OK | kraken | took 59973ms 10:00:06 INFO - SUITE-END | took 1179s 10:00:06 INFO - Completed test suite (00:19:39) 10:00:06 INFO - javascript benchmark 10:00:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.636563612366, 3345.9665403345957, 3353.782004169728, 3357.1103657530743, 3398.980305908227, 5520.66875987441, 5591.329040515144, 5664.886702265957, 5687.715614219288, 5697.430256974295, 3967.623075807801, 5644.435556444353, 5656.91514627281, 5708.543316534678, 5715.914261286073, 5146.305248791421, 5165.173572228444, 5200.609954253446, 5225.973870130644, 5231.267622532849, 5204.271402003723, 5304.734763261821, 5312.840614781563, 5314.468553144693, 5363.651362661414, 5147.716875571842, 5203.843884683428, 5267.657602255841, 5287.947120528803, 5307.124324486455, 5204.609654275907, 5212.973935130338, 5214.556762675177, 5220.895582088375, 5222.947770522323, 5067.619928505377, 5126.846194614168, 5146.922796158061, 5150.562202212816, 5154.07226699194, 5598.972005139948, 5653.547716182696, 5665.49010589049, 5678.630888992202, 5692.0, 6229.3770622937345, 6234.127222188898, 6235.719392627343, 6246.750129994794, 6251.531135164881, 6270.216222972129, 6281.560290779647, 6285.717142728588, 6292.968535157295, 6295.937040629581, 5654.6324488908085, 5702.7433765480655, 5710.486056254874, 5769.826905192767, 5780.277465316835, 6286.811395658137, 6326.557141000086, 6341.239051313872, 6357.332480089616, 6367.108604795332, 6160.8767824643255, 6163.0, 6177.4749146323065, 6184.319724830265, 6188.81433556994, 6268.968655156787, 6271.310155882849, 6271.811845644638, 6272.18461599989, 6273.435390814758, 6003.459688628044, 6082.787102451482, 6086.726097325631, 6164.845878852975, 6199.3490683478485, 6129.511613758974, 6147.508199344042, 6228.128062071313, 6269.529785266032, 6273.215848018997, 4880.999395123991, 4940.357753492095, 4941.45643979162, 4942.975285123552, 4964.627652926045, 4401.295792673157, 4412.360207769855, 4415.116976604692, 4420.115976804587, 4441.422615060022, 4958.735522441754, 5581.274434323512, 5638.436156384329, 5646.632968857011, 5707.800226992035, 6170.197874276315, 6190.969045154746, 6213.130161777355, 6213.937860621336, 6218.782342617987, 5771.538276937835, 5775.711214439261, 5777.8555536111935, 5781.566382521243, 5819.53443724501, 5370.2750128732905, 5376.274202982626, 5401.459854014567, 5414.648047876875, 5438.401775804658, 6246.562740608114, 6281.7173227203975, 6300.495960323255, 6311.873762524632, 6336.493080553637, 6235.095911092957, 6308.33762454954, 6326.746930122744, 6328.715207815567, 6345.238571371465, 6305.96847015762, 6337.524685648503, 6347.428731414195, 6354.078658594571, 6382.744690212339, 6028.397160284112, 6129.325774164928, 6224.688765561795, 6227.782027629011, 6238.282597501164, 6163.291221509584, 6226.688665566794, 6229.563930525001, 6232.5948813328805, 6294.937050629618, 6084.300305464928, 6089.086637004485, 6089.877783758912, 6094.847628809315, 6127.295361033538, 5842.152887831326, 6040.033594624839, 6055.636661800306, 6094.786682466092, 6106.3283038866575, 5811.506021988178, 5877.676727780014, 5879.559033072622, 5918.112283157561, 5921.970390148022, 6018.638881667114, 6023.728932197974, 6095.786647467317, 6116.6096904373135, 6144.508439324753, 5877.177195192762, 5905.734241959036, 5913.881722365614, 5919.4968427684125, 5929.792457263975], "value": 5681.917147353076, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.2859709985774, 440.5110327536434, 470.5106689043395, 481.80005297801415, 499.46058257082353, 38246.235075298515, 40307.39538906915, 40479.59520404799, 42153.0, 42399.0, 41855.0, 41981.0, 42016.369754453706, 42057.0, 42124.578754212445, 8400.789980250482, 9300.255979521622, 9525.0, 9529.904700952971, 9542.236621070333, 8434.746957591282, 11111.555537778479, 11380.203385762958, 11381.26021808584, 11538.365389903553, 11287.097032237401, 11349.09207263417, 11349.773004539904, 11373.772524549504, 11405.885941140607, 8450.74647760562, 8642.913570864273, 11246.212765106446, 11317.943410282936, 11336.433178341133, 10898.237123401364, 11251.324920504796, 11256.15578831591, 11423.143264255214, 11427.028702560292, 39195.412068818994, 39617.80191099026, 39651.00872478182, 39709.80145099256, 39749.0, 3368.1747971747077, 3380.7126394256516, 3389.9656220417664, 3457.6369481204615, 3694.4273637586216, 28754.42491150186, 30063.098107056823, 30320.696793032228, 30332.938347157964, 30345.0, 2984.7164519370626, 3202.8558714857886, 3226.548283240348, 3278.1968417737567, 3332.1169889979174, 505522.0, 506609.0, 510430.0, 511948.44025780004, 517177.0, 54915.72542137264, 57473.42526574681, 57844.0, 57985.71007144937, 58039.41960580424, 56519.869602607716, 56637.0, 56678.43321566814, 56742.0, 56824.579385515695, 15289.923550382176, 15530.068195908056, 15555.533333999998, 15586.220688965734, 15643.139627320379, 10951.123910087173, 11209.495572699248, 11969.281843089268, 12128.575499857463, 12191.87808121925, 15015.549533514011, 15227.619309517351, 15404.306806193748, 15415.691686166214, 15421.151836649093, 6352.968235158794, 7060.682269297894, 7120.614594110927, 7209.495335326476, 7299.5255308404785, 824.3116997307316, 929.5491686532026, 976.5947131940165, 1020.3520764314713, 1079.5088234853124, 22120.557588848133, 27668.0, 29051.41897162045, 30060.54909176364, 30183.69816301853, 886.3441053620403, 1064.4571268653042, 1070.753726642861, 1086.2721976275914, 1112.2214449885112, 14056.929715351358, 14973.850261497246, 15019.624509387135, 15266.007709498846, 15435.919485635897, 629497.0, 635100.0, 636050.0, 637173.6282637115, 638037.0, 57377.42622573804, 57692.0, 57711.42288577145, 57752.422475775544, 58735.825283494945, 1212.7392610588765, 1258.1381753498883, 1302.2772361339548, 1302.5636411802152, 1406.9437222510985, 28480.287992800346, 29831.955881544043, 30007.0, 30614.84692576523, 31436.0, 51215.2317715242, 51976.48023519868, 51995.700107497614, 52112.95774084421, 52135.739321303154, 580870.0, 587683.0, 587732.0, 588626.0, 591143.0, 37281.04887481877, 37342.06644833901, 37677.81161094177, 37880.43179352257, 37888.0, 37926.24147517089, 39899.800500997306, 43493.0, 45455.0, 47247.055058899314, 31179.220519487193, 36930.81534592417, 37047.25905481929, 37136.81431592825, 38253.2349353017, 35956.64043359533, 35962.74130405423, 36743.0, 37132.44301335428, 37225.88322350334, 36407.45388819223, 36497.0, 36937.26125477422, 37316.25367492689, 37382.62617373792, 31105.688943111185, 32006.19984500313, 33451.83274083614, 33663.0, 33732.0, 23700.170494032627, 24430.565393940054, 24528.87735561311, 24932.376690582154, 25014.98659876007], "value": 19831.951378560156, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.0880744526418, 379.86324923027706, 389.13805919887454, 398.1757761433833, 407.5496576283207, 13606.795898061524, 19124.33064842731, 19288.132034058483, 19525.12136953837, 19775.703364449546, 18837.62324753504, 19546.0, 19891.90594517301, 20420.285290014854, 20451.97740112992, 5141.15170996785, 5338.466153384669, 5342.866428339284, 5343.679379237258, 5718.942810571883, 7407.518511296776, 7609.923900761005, 7612.619369031554, 7617.238276172394, 7657.4639775215755, 6704.128463299764, 7238.420926325882, 7265.7456989005395, 7567.62161891906, 7614.657340419667, 7187.353138217533, 7571.31858132768, 7577.3180413762475, 7625.466217364787, 7633.313001829834, 7281.417486601059, 7407.6666550005375, 7421.146568144679, 7425.8514829703645, 7443.032405787267, 25450.36374090644, 27648.0, 27882.721172788217, 27894.16317510478, 28132.156035318974, 2572.704139023999, 2599.3371690219064, 2850.3586692994118, 3177.4757165067736, 3197.984010079958, 15277.923610381988, 15450.690986180214, 16229.052513698432, 16531.33874645025, 17156.485305440856, 1861.8045105264023, 1925.5089952062274, 2024.3926821953355, 2045.9693104603443, 2064.133064113061, 81804.59097704533, 101213.0, 104233.99999999924, 131316.34341828324, 136427.31786341005, 19408.223671053, 19873.60252794936, 20256.291029813885, 20710.378688639365, 20795.37613871556, 27383.0, 34247.0, 34359.484607730905, 34366.65633343685, 34378.140546486036, 8785.692500762443, 10184.236182286359, 10343.689689309333, 10435.68692939213, 10566.366018038942, 8525.147485251426, 8550.888384510099, 8553.101924297984, 8672.739817805475, 8676.175763302475, 7802.921970780333, 7846.882296765553, 9424.198943089914, 9570.665026724031, 9618.807623847484, 3707.35121353762, 3726.124360775216, 3727.7204209684382, 3741.494898188764, 3821.7133714971487, 837.7989282572139, 894.3024440936081, 911.6490151291667, 917.6100157433065, 979.1139019187647, 16514.58713532171, 16758.74861877073, 18864.905675471808, 19367.48222731064, 20109.698354524695, 824.5712229640674, 882.4043770455046, 903.9864402033975, 904.1636486250193, 979.8383266761048, 9464.858027129598, 10645.574177032986, 10679.305845120043, 10739.624113156158, 10743.0, 473769.0, 488502.0, 490661.0, 498384.0, 503251.48374257894, 84484.0, 110316.0, 114489.28266076016, 120817.0, 121145.39427302807, 947.3794664494767, 976.6142373762466, 994.5777538120412, 994.627014869424, 995.8100070415784, 17990.910045449687, 18668.973206473773, 18755.874647521192, 18850.434486965412, 18949.33677321287, 45403.77298113488, 46450.76774616105, 49496.25755613597, 49568.75215623899, 50258.748706256236, 69623.0, 70904.64547677229, 71021.28978710147, 71309.64345178241, 72145.6392718033, 7888.48724832884, 7925.722599708983, 7944.960275198587, 7997.840043198987, 8142.47073940192, 10633.415162166155, 11919.284842909454, 12003.759924801281, 12611.621651350475, 12631.557895473614, 8495.830083398421, 10564.683059508227, 11000.394978276272, 11054.281471704635, 11103.500342484445, 10425.374477531372, 10510.527026283682, 10629.20280978945, 10846.566137354417, 11106.055985241344, 8740.825183496167, 10848.457577120955, 10925.945370273097, 10964.835527467254, 11147.72130696739, 7802.141764406025, 8034.357251419756, 8034.437589368688, 8052.355811535181, 8055.83888322242, 8045.718399855977, 10626.468676565986, 10747.140228781522, 10902.836457452986, 10999.285046471954], "value": 10510.383352069566, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.97724534132, 1525.0773282164294, 1755.2276998120826, 1883.2184643373, 1918.4724200844767, 8160.4695694779875, 8454.87317690235, 8472.0, 8562.91437085629, 8629.91370086299, 7555.206703296157, 7764.456488045839, 7789.571573563452, 8053.073896501904, 8428.873566896485, 2279.418748219206, 2338.3920180752957, 2340.473393486469, 2340.8361414700976, 2345.331580499558, 1978.6636271833752, 2329.1615018593293, 2358.5047140100514, 2360.1621424394266, 2374.881255937205, 2315.5716192504356, 2318.5015221727326, 2342.3324352559525, 2345.331580499558, 2351.130081869702, 2275.9089636414606, 2307.3193407944696, 2313.733920599119, 2314.4908120213527, 2320.3734991552355, 2290.3014580552926, 2312.5606134834497, 2337.3922780077132, 2341.0, 2345.683332750074, 8342.666293348258, 8537.402381833273, 8537.487750734976, 8561.315094792402, 8597.828043439158, 5030.471800460936, 5197.194434862602, 5204.193350030751, 5218.060749065166, 5219.817306394258, 3225.1775797171804, 3337.749668774827, 3472.0625431133703, 3473.11435583927, 3484.1289677580603, 877.5743764274322, 931.8741969834122, 935.3873213045466, 964.1997142371814, 1014.9441780702058, 10969.83545246822, 11014.339139651567, 11023.118150547936, 11024.007839294422, 11088.889111108867, 4524.389207457017, 4569.680122391467, 4655.604273636779, 4666.719996800135, 4747.786349614275, 8713.564321783886, 8859.51272679996, 8871.201591856634, 8880.600372983232, 8884.244839188741, 5112.105381558213, 5158.045761534128, 5166.638335316492, 5169.560587350042, 5170.896582068338, 4620.422447194101, 4734.076855013308, 4804.73573953429, 4840.515948405131, 4864.221724524059, 3462.082548124749, 3495.9126021849656, 3525.383057964846, 3553.822308884597, 3575.2313252650806, 1131.8811524789944, 1137.2380505061628, 1138.6697857621198, 1149.1611123879616, 1149.597640825721, 827.210014436212, 844.7212419901418, 896.6771962093641, 915.8305713443034, 962.7256231973854, 5467.535259502907, 5558.693706978937, 5747.597668163272, 5930.673812940329, 5935.52515798735, 835.2482765510968, 900.9684661036963, 924.3437159616612, 933.4632586262926, 939.5677988125539, 3811.447340135665, 3842.9039274018373, 3855.1133239354544, 3909.550401703784, 3943.6056394360335, 9901.653442129491, 10156.898431015596, 10252.282340236112, 10277.9486102569, 10295.74260643475, 9822.361546499455, 9836.950815245878, 10161.847572286273, 10171.237157213238, 10198.592056317813, 7484.1393239777035, 7823.491473054233, 7882.290593846581, 7883.526988380716, 8035.196480351918, 5748.568857335633, 5770.538356931519, 5772.105323674838, 5828.621139626081, 5913.723216561569, 9006.099390061203, 9006.639734410812, 9463.763405914908, 9466.148046675833, 9575.569099390683, 8834.29325653959, 9496.810063798823, 9508.239340852853, 9644.9035509644, 9722.562484688064, 6684.331566843472, 6918.0, 7071.964640176766, 7264.309890560388, 7269.527480713737, 7654.387648987956, 7923.0, 8041.276285134366, 8082.676692932452, 8139.10469848328, 7216.7113315466795, 7218.097737782778, 7255.709771609077, 7298.781036568911, 7301.452391070585, 7055.753048643272, 7059.435245180476, 7086.220515743367, 7152.821179470555, 7222.6388680566815, 6580.21037475506, 6662.6335551545135, 6663.866722665616, 6772.729090836311, 6786.21958474762, 4774.594159496342, 4843.39457567804, 4900.583450406612, 4936.950630493649, 5074.847754567369, 4343.826246950213, 4806.279058141167, 4856.78144483492, 4972.925406118983, 5016.347874776256], "value": 4412.4141573638335, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.6408027891829, 364.17514330042457, 368.46204541369605, 379.8841353387216, 380.3477036881747, 4681.250999840026, 4742.909130899895, 5158.744036170156, 5201.817936372227, 5423.186522021699, 4357.738535687861, 4411.360352748849, 4835.8791030224265, 5172.19830926207, 5226.189940559219, 3854.9807250963704, 4091.1204091120476, 4149.917001659965, 4154.854580089683, 4187.371894215877, 3786.0, 3830.873865004935, 4159.500859896817, 4200.537940826506, 4205.7897105144775, 3273.3616944695796, 3328.9500657490157, 3611.0, 3993.6405723485027, 4143.839724877039, 3429.2798512312443, 4077.921169517025, 4104.117614712821, 4142.047329114305, 4143.4199212110325, 3476.0, 3632.0, 3647.562292524914, 3674.595794462607, 3681.208540163878, 4364.629006534448, 4559.544045595447, 5117.616178786606, 5119.846404607868, 5130.7947682093045, 4654.418197725285, 4724.622030237572, 4733.242681170997, 4753.4771175171045, 4763.737994410306, 5383.865403364908, 5518.586106042063, 5532.5573954083575, 5670.546356291528, 5671.9716401418145, 3664.727868721383, 3987.98006009971, 4028.536718277406, 4042.939355909664, 4075.5924407559305, 4749.1926372516755, 5153.587712982952, 5845.357010728816, 5899.882002359929, 5911.408859114097, 3674.9081272967856, 3674.9342690619956, 3701.6483434074257, 3751.531058617673, 3862.613738626171, 3510.7015903648476, 3858.951428371555, 3888.1640447303967, 3903.8633647822758, 3915.9021024474614, 4343.370211319341, 4376.102898905717, 4432.578905004019, 4492.090861383964, 4571.565701258375, 4922.852314430573, 5314.335708036496, 5544.889102218014, 5558.527525160407, 5562.803997140553, 1086.7450041164616, 1118.552578968419, 1184.5202692909386, 1235.604606525921, 1255.4036832504487, 752.6537792615349, 805.9476134051268, 809.7651681012558, 849.587949844325, 871.1897934920585, 4689.7655117244, 4873.147199240118, 4957.454679985199, 5045.697258164522, 5073.568746656576, 4809.062232864628, 4954.504549545089, 5360.3299587551555, 5481.808136715275, 5549.3906767037915, 4378.496472905593, 5116.181410974226, 5387.24578559002, 5406.810501689701, 5412.404635490093, 2716.483868065101, 2728.6316347292864, 2743.6281859070464, 2803.897077192106, 2878.6833448320667, 4953.455119936804, 5130.9230361544605, 5421.756020979065, 5443.5100840923715, 5772.422757724194, 5010.849674509771, 5048.8232911848645, 5170.844874653766, 5617.550595952314, 5633.492985631231, 4999.500049994971, 5232.555232805178, 5718.4567466091485, 5761.020626493422, 5797.898399304118, 5004.974975125101, 5215.973920130375, 5524.364698059614, 5567.220589117445, 5707.771689132388, 4686.671932964659, 5094.770735316845, 5305.151175811851, 5532.585056120887, 5623.493885550321, 5390.811321603725, 5820.796272130455, 5863.254011069262, 6065.302490213506, 6090.482309003607, 3700.1119731263766, 3824.3116239077235, 3849.883533775174, 3866.2267546491375, 3889.533256009297, 4837.080954618611, 5203.401608815035, 5364.731763411892, 5754.482096611325, 5777.367067109534, 4655.23188673865, 5601.915971260516, 5665.5750818689585, 5688.40271771458, 5727.369989301257, 5275.287836142072, 5425.7174409481695, 5618.9604923089355, 5691.800786972436, 5739.814403006371, 4265.594768496988, 5231.921521177109, 5281.049411105884, 5354.170103633943, 5498.945010550004, 5526.0, 5581.49766521015, 5617.915731263953, 5628.690422026828, 5667.40492248308, 4812.205986012269, 4860.416749990024, 5488.941646882419, 5598.188262701967, 5607.8878422432135], "value": 4034.393802946143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.4229374206891, 738.7525179065013, 745.7278093495872, 776.9156448897877, 800.4716886854677, 15095.698086038286, 15676.84323156768, 15708.293126809278, 15713.371465141408, 15715.607109822246, 14262.786058209134, 14451.92774036131, 14458.0, 14474.0, 14531.854681453182, 698.8602279544086, 726.1649103530955, 731.0605871455181, 731.0788406607672, 851.2508992086986, 877.9385443018991, 880.9735707928772, 885.5970533407317, 887.3921363865741, 890.1899271662788, 961.870147530085, 963.7301555564418, 964.7009427077593, 966.6085235479607, 967.666155176463, 949.3734135470626, 951.2009911674193, 953.4041224234853, 953.9713808585753, 954.88063992001, 548.6872482684871, 568.5877738639495, 675.2032601530192, 708.8369674974784, 715.6564848872571, 14741.0, 15167.924160379127, 15178.620534486616, 15222.086674799548, 15285.847141528553, 13699.260147970446, 13721.176729396268, 13765.036447448683, 13903.443862245498, 13908.37412316438, 11263.774724505463, 12353.197042192318, 12650.873491265154, 12712.682182945407, 12903.483860645563, 4027.154297597508, 4081.4081958115908, 4251.043515209084, 4299.419578356913, 4311.137772445492, 97201.51399242958, 97626.0, 98315.52526712105, 99472.50263748635, 99814.0, 10322.451632255223, 10481.318714283547, 10727.409992450333, 10933.453327333602, 11340.489677964511, 21657.91710414473, 21870.45323866916, 21870.45323866916, 21878.343649690534, 21885.562288754136, 7607.809804754926, 7617.733379331697, 7633.465657403928, 7695.384369250447, 7761.5994567278985, 4161.51422075069, 4208.8316467340965, 4274.337477690963, 4292.978535107367, 4432.113577284556, 3218.082846388768, 3294.6870047345465, 3370.7808992415416, 3406.1654894550993, 3414.7951122932704, 578.1587789765881, 579.9043157878987, 581.2995340614549, 582.2285471749948, 584.8976429124971, 522.7595306159134, 574.5292052346008, 596.7642781101528, 607.8601921557978, 617.4566381584267, 7226.313500217471, 8384.83230335402, 8688.6524539019, 8742.300615950835, 8766.868496972551, 514.0977584339535, 582.7090022594829, 604.4106995679177, 618.832915112917, 646.5086534233922, 3835.9616403835603, 3974.721769476109, 4043.6158564936286, 4044.2113787811095, 4150.750954942713, 104606.0, 107061.46469267603, 107770.0, 108764.91235087547, 110559.0, 89914.0, 91398.54300728453, 91917.62123568152, 92879.0, 95254.0, 54357.728211359485, 76390.0, 76962.61518692371, 78964.81552776713, 81129.18870811453, 7827.804304892423, 7855.921440785519, 7923.920760792318, 7954.801129971565, 8187.83624327522, 35726.642733572335, 41310.79344603258, 49855.750721246164, 52536.0, 54103.72948135234, 60351.0, 72748.0, 73869.89195161969, 75205.74382768526, 78829.0, 9253.583588738658, 11142.164337674869, 11157.832632510357, 11165.050970667584, 11720.296782193096, 11648.650540483799, 11851.288922664668, 11867.287962722265, 12218.816717749418, 12342.506299747909, 11833.230839995373, 12180.269183848997, 12186.086043546948, 12448.0, 12449.128561001005, 12114.454849531969, 13348.399322030726, 13857.722845543234, 14169.10580456653, 14238.644033899236, 12936.870631293566, 13043.934780326037, 13408.530701425403, 13556.59330220095, 13966.650833729238, 10295.330803497749, 10731.673181313818, 10934.305182696377, 11422.428878555873, 11584.652460426201, 11043.226974112056, 11283.66149015531, 11410.543578256777, 11555.0, 11608.535658573563], "value": 7237.305501272411, "unit": "score"}], "name": "dromaeo_css", "value": 7310.155322248242, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 113.0, 113.0, 113.0, 120.0, 123.0, 113.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 110.0, 176.0, 116.0, 113.0, 110.0, 110.0, 131.0, 111.0], "value": 123.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 184.0, 183.0, 184.0, 184.0, 185.0, 182.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 86.0, 64.0, 82.0, 87.0, 84.0, 74.0, 58.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 89.0, 70.0, 68.0, 69.0, 85.0, 68.0, 68.0, 84.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 108.0, 109.0, 108.0, 110.0, 107.0, 110.0, 107.0, 108.0], "value": 108.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 131.0, 161.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 71.0, 79.0, 131.0, 139.0, 115.0, 87.0, 86.0, 87.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 55.0, 54.0, 54.0, 55.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 81.0, 74.0, 72.0, 70.0, 70.0, 70.0, 69.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 88.0, 88.0, 87.0, 87.0, 85.0, 91.0, 88.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 152.0, 133.0, 138.0, 141.0, 139.0, 140.0, 141.0, 231.0, 149.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 170.0, 171.0, 173.0, 169.0, 169.0, 169.0, 172.0, 173.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 69.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1486.0, "alertThreshold": 2.0}]} 10:00:06 INFO - Return code: 0 10:00:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:00:06 INFO - # TBPL SUCCESS # 10:00:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:06 INFO - 2016-12-20 10:00:06.878 screenresolution[1654:9844] starting screenresolution argv=screenresolution get 10:00:06 INFO - 2016-12-20 10:00:06.881 screenresolution[1654:9844] Display 0: 1600x1200x32@60 10:00:06 INFO - 2016-12-20 10:00:06.887 screenresolution[1655:9847] starting screenresolution argv=screenresolution list 10:00:06 INFO - Available Modes on Display 0 10:00:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:07 INFO - Intel Iris: 10:00:07 INFO - Chipset Model: Intel Iris 10:00:07 INFO - Type: GPU 10:00:07 INFO - Bus: Built-In 10:00:07 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:07 INFO - Vendor: Intel (0x8086) 10:00:07 INFO - Device ID: 0x0a2e 10:00:07 INFO - Revision ID: 0x0009 10:00:07 INFO - Displays: 10:00:07 INFO - Display: 10:00:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:07 INFO - Display Serial Number: 1600x1200 60 10:00:07 INFO - Main Display: Yes 10:00:07 INFO - Mirror: Off 10:00:07 INFO - Online: Yes 10:00:07 INFO - Rotation: Supported 10:00:07 INFO - Return code: 0 10:00:07 INFO - Running post-action listener: _resource_record_post_action 10:00:07 INFO - [mozharness: 2016-12-20 18:00:07.127298Z] Finished run-tests step (success) 10:00:07 INFO - Running post-run listener: _resource_record_post_run 10:00:07 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38556672; Write bytes: 554360320; Read time: 378; Write time: 1681 10:00:07 INFO - TinderboxPrint: CPU usage
53.8% 10:00:07 INFO - TinderboxPrint: I/O read bytes / time
38,556,672 / 378 10:00:07 INFO - TinderboxPrint: I/O write bytes / time
554,360,320 / 1,681 10:00:07 INFO - TinderboxPrint: CPU idle
2,224.3 (46.2%) 10:00:07 INFO - TinderboxPrint: CPU system
962.1 (20.0%) 10:00:07 INFO - TinderboxPrint: CPU user
1,623.3 (33.8%) 10:00:07 INFO - TinderboxPrint: Swap in / out
288,800,768 / 0 10:00:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 229087744; Write bytes: 221372416; Read time: 16405; Write time: 392 10:00:07 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37635072; Write bytes: 299341312; Read time: 364; Write time: 1141 10:00:07 INFO - Running post-run listener: _upload_blobber_files 10:00:07 INFO - Blob upload gear active. 10:00:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:07 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 10:00:07 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'] 10:00:07 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 10:00:08 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:00:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:00:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:09 INFO - (blobuploader) - INFO - Done attempting. 10:00:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:00:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:10 INFO - (blobuploader) - INFO - Done attempting. 10:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:00:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:10 INFO - (blobuploader) - INFO - Done attempting. 10:00:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:00:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:13 INFO - (blobuploader) - INFO - Done attempting. 10:00:13 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:13 INFO - Return code: 0 10:00:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/48ea693037811621689f1199ec67ee97511d80e014617ca3f320c931e80314fe94799adfadc490632b266297fb92ef599b2ab97d0c8e84de1ae737924a11489b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce84544a02da7d572f680483db0e52eb4b8c42c4b9ffe570dba1d9e7ab02ad0cd7974859560b8e755063c15a119964bb4ba9c0978af163266d60926db0c5a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4ed33159a9776cb20c762f39c5758f7135370e3d5c75c59522a6ac1355331305c1f3a03b275621dfa489efcff567aeab1b55bb43f82df84d7391033f29a0c4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21d5627023c7c680a06b8c64f92f02a6a1decc1eb0129e65935c5e14374093d323c88ce0a61561782719ededb3582ff1f723eaba757c87cb18b970c8d5d0574d"} 10:00:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:13 INFO - Contents: 10:00:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/48ea693037811621689f1199ec67ee97511d80e014617ca3f320c931e80314fe94799adfadc490632b266297fb92ef599b2ab97d0c8e84de1ae737924a11489b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce84544a02da7d572f680483db0e52eb4b8c42c4b9ffe570dba1d9e7ab02ad0cd7974859560b8e755063c15a119964bb4ba9c0978af163266d60926db0c5a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4ed33159a9776cb20c762f39c5758f7135370e3d5c75c59522a6ac1355331305c1f3a03b275621dfa489efcff567aeab1b55bb43f82df84d7391033f29a0c4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21d5627023c7c680a06b8c64f92f02a6a1decc1eb0129e65935c5e14374093d323c88ce0a61561782719ededb3582ff1f723eaba757c87cb18b970c8d5d0574d"} 10:00:13 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:13 INFO - Copying logs to upload dir... 10:00:13 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.213758 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-20 10:00:13.419452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 10:00:13.422969) ========= 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.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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/48ea693037811621689f1199ec67ee97511d80e014617ca3f320c931e80314fe94799adfadc490632b266297fb92ef599b2ab97d0c8e84de1ae737924a11489b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce84544a02da7d572f680483db0e52eb4b8c42c4b9ffe570dba1d9e7ab02ad0cd7974859560b8e755063c15a119964bb4ba9c0978af163266d60926db0c5a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4ed33159a9776cb20c762f39c5758f7135370e3d5c75c59522a6ac1355331305c1f3a03b275621dfa489efcff567aeab1b55bb43f82df84d7391033f29a0c4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21d5627023c7c680a06b8c64f92f02a6a1decc1eb0129e65935c5e14374093d323c88ce0a61561782719ededb3582ff1f723eaba757c87cb18b970c8d5d0574d"} build_url:https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/ByTSa4MLRRynoHQ2p6XIEA/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/48ea693037811621689f1199ec67ee97511d80e014617ca3f320c931e80314fe94799adfadc490632b266297fb92ef599b2ab97d0c8e84de1ae737924a11489b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ce84544a02da7d572f680483db0e52eb4b8c42c4b9ffe570dba1d9e7ab02ad0cd7974859560b8e755063c15a119964bb4ba9c0978af163266d60926db0c5a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4ed33159a9776cb20c762f39c5758f7135370e3d5c75c59522a6ac1355331305c1f3a03b275621dfa489efcff567aeab1b55bb43f82df84d7391033f29a0c4dd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/21d5627023c7c680a06b8c64f92f02a6a1decc1eb0129e65935c5e14374093d323c88ce0a61561782719ededb3582ff1f723eaba757c87cb18b970c8d5d0574d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 10:00:13.457093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 10:00:13.457413) ========= 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.JyV7iFXK3z/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.fH78IMXkKH/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/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.005040 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 10:00:13.506293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 10:00:13.506627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 10:00:13.506952) ========= ========= Total master_lag: 0.17 =========