builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0359 starttime: 1484212676.8 results: success (0) buildid: 20170112001116 builduid: b51d27ac6c9e4fafa0bfb607634af6f6 revision: 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:56.802448) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:56.802914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:56.803197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:57.054328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:57.054918) ========= 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.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 --2017-01-12 01:17:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-12 01:17:57 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.219718 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:57.302426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:57.302773) ========= 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.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.025195 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:57.351302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 01:17:57.353705) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 --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 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 2017-01-12 01:17:57,450 truncating revision to first 12 chars 2017-01-12 01:17:57,451 Setting DEBUG logging. 2017-01-12 01:17:57,451 attempt 1/10 2017-01-12 01:17:57,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/11b1c9cffb0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 01:17:59,263 unpacking tar archive at: graphics-11b1c9cffb0a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.094635 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 01:17:59.474576) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:59.474882) ========= script_repo_revision: 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:59.475260) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:59.475540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 01:17:59.494471) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 01:17:59.494816) ========= /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.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:17:59 INFO - MultiFileLogger online at 20170112 01:17:59 in /builds/slave/test 01:17:59 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 01:17:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:17:59 INFO - {'append_to_log': False, 01:17:59 INFO - 'base_work_dir': '/builds/slave/test', 01:17:59 INFO - 'blob_upload_branch': 'Graphics', 01:17:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:17:59 INFO - 'branch': 'Graphics', 01:17:59 INFO - 'buildbot_json_path': 'buildprops.json', 01:17:59 INFO - 'config_files': ('talos/mac_config.py',), 01:17:59 INFO - 'default_actions': ('clobber', 01:17:59 INFO - 'read-buildbot-config', 01:17:59 INFO - 'download-and-extract', 01:17:59 INFO - 'populate-webroot', 01:17:59 INFO - 'create-virtualenv', 01:17:59 INFO - 'install', 01:17:59 INFO - 'run-tests'), 01:17:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:17:59 INFO - 'download_minidump_stackwalk': True, 01:17:59 INFO - 'download_symbols': 'ondemand', 01:17:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:17:59 INFO - 'tooltool.py': '/tools/tooltool.py', 01:17:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:17:59 INFO - '/tools/misc-python/virtualenv.py')}, 01:17:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:17:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:17:59 INFO - 'installer_path': 'installer.exe', 01:17:59 INFO - 'log_level': 'info', 01:17:59 INFO - 'log_name': 'talos', 01:17:59 INFO - 'log_to_console': True, 01:17:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:17:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:17:59 INFO - 'opt_config_files': (), 01:17:59 INFO - 'pip_index': False, 01:17:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:17:59 INFO - 'cmd': ('bash', 01:17:59 INFO - '-c', 01:17:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:17:59 INFO - 'enabled': True, 01:17:59 INFO - 'halt_on_failure': False, 01:17:59 INFO - 'name': 'check_screen_resolution'},), 01:17:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:17:59 INFO - 'cmd': ('bash', 01:17:59 INFO - '-c', 01:17:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:17:59 INFO - 'enabled': True, 01:17:59 INFO - 'halt_on_failure': False, 01:17:59 INFO - 'name': 'check_screen_resolution'},), 01:17:59 INFO - 'run_cmd_checks_enabled': True, 01:17:59 INFO - 'sps_profile': False, 01:17:59 INFO - 'sps_profile_interval': 0, 01:17:59 INFO - 'suite': 'dromaeojs', 01:17:59 INFO - 'system_bits': '32', 01:17:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:17:59 INFO - 'title': 't-yosemite-r7-0359', 01:17:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:17:59 INFO - 'use_talos_json': True, 01:17:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:17:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:17:59 INFO - 'work_dir': 'build'} 01:17:59 INFO - [mozharness: 2017-01-12 09:17:59.695230Z] Running clobber step. 01:17:59 INFO - Running pre-action listener: _resource_record_pre_action 01:17:59 INFO - Running main action method: clobber 01:17:59 INFO - rmtree: /builds/slave/test/build 01:17:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:18:02 INFO - Running post-action listener: _resource_record_post_action 01:18:02 INFO - [mozharness: 2017-01-12 09:18:02.076299Z] Finished clobber step (success) 01:18:02 INFO - [mozharness: 2017-01-12 09:18:02.076399Z] Running read-buildbot-config step. 01:18:02 INFO - Running pre-action listener: _resource_record_pre_action 01:18:02 INFO - Running main action method: read_buildbot_config 01:18:02 INFO - Using buildbot properties: 01:18:02 INFO - { 01:18:02 INFO - "project": "", 01:18:02 INFO - "product": "firefox", 01:18:02 INFO - "script_repo_revision": "default", 01:18:02 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 01:18:02 INFO - "repository": "", 01:18:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 01:18:02 INFO - "buildid": "20170112001116", 01:18:02 INFO - "pgo_build": "False", 01:18:02 INFO - "basedir": "/builds/slave/test", 01:18:02 INFO - "buildnumber": 7, 01:18:02 INFO - "slavename": "t-yosemite-r7-0359", 01:18:02 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:18:02 INFO - "platform": "yosemite_r7", 01:18:02 INFO - "scheduler": "tests-graphics-macosx64-talos", 01:18:02 INFO - "branch": "graphics", 01:18:02 INFO - "repo_path": "projects/graphics", 01:18:02 INFO - "revision": "11b1c9cffb0ac0b13c35e96f92238ddee06370f8", 01:18:02 INFO - "stage_platform": "macosx64", 01:18:02 INFO - "builduid": "b51d27ac6c9e4fafa0bfb607634af6f6", 01:18:02 INFO - "slavebuilddir": "test" 01:18:02 INFO - } 01:18:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 01:18:02 INFO - Running post-action listener: _resource_record_post_action 01:18:02 INFO - [mozharness: 2017-01-12 09:18:02.079764Z] Finished read-buildbot-config step (success) 01:18:02 INFO - [mozharness: 2017-01-12 09:18:02.079901Z] Running download-and-extract step. 01:18:02 INFO - Running pre-action listener: _resource_record_pre_action 01:18:02 INFO - Running main action method: download_and_extract 01:18:02 INFO - mkdir: /builds/slave/test/build/tests 01:18: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')]} 01:18:02 INFO - trying https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 01:18:02 INFO - Downloading https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/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 01:18:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/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 01:18:03 INFO - Downloaded 1199 bytes. 01:18:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 01:18:03 INFO - Using the following test package requirements: 01:18:03 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 01:18:03 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 01:18:03 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 01:18:03 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'jsshell-mac.zip'], 01:18:03 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 01:18:03 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 01:18:03 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 01:18:03 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 01:18:03 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 01:18:03 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 01:18:03 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 01:18:03 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:18:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 01:18:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:18:03 INFO - Fetch https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 01:18:03 INFO - Expected file size: 16311328 01:18:03 INFO - Obtained file size: 16311328 01:18:10 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 01:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 01:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:18:10 INFO - Fetch https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 01:18:11 INFO - Expected file size: 16311328 01:18:11 INFO - Obtained file size: 16311328 01:18:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 01:18:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:18:17 INFO - Fetch https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 01:18:19 INFO - Expected file size: 14403529 01:18:19 INFO - Obtained file size: 14403529 01:18:19 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')]} 01:18:19 INFO - trying https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 01:18:19 INFO - Downloading https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 01:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/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 01:18:21 INFO - Downloaded 69921646 bytes. 01:18:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 01:18:21 INFO - mkdir: /builds/slave/test/properties 01:18:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:18:21 INFO - Writing to file /builds/slave/test/properties/build_url 01:18:21 INFO - Contents: 01:18:21 INFO - build_url:https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 01:18:21 INFO - Running post-action listener: _resource_record_post_action 01:18:21 INFO - Running post-action listener: set_extra_try_arguments 01:18:21 INFO - [mozharness: 2017-01-12 09:18:21.998322Z] Finished download-and-extract step (success) 01:18:21 INFO - [mozharness: 2017-01-12 09:18:21.998477Z] Running populate-webroot step. 01:18:21 INFO - Running pre-action listener: _resource_record_pre_action 01:18:21 INFO - Running main action method: populate_webroot 01:18:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:18:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:18:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:18:22 INFO - '--tppagecycles', 01:18:22 INFO - '7'], 01:18:22 INFO - 'tests': ['tsvgm']}}, 01:18:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:18:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:18:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:18:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:18:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:18:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['damp', 'tps']}, 01:18:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'tests': ['damp', 'tps']}, 01:18:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['dromaeo_dom']}, 01:18:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:18:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['basic_compositor_video']}, 01:18:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:18:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'other-e10s': {'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['a11yr', 01:18:22 INFO - 'ts_paint', 01:18:22 INFO - 'tpaint', 01:18:22 INFO - 'sessionrestore', 01:18:22 INFO - 'sessionrestore_no_auto_restore', 01:18:22 INFO - 'tabpaint']}, 01:18:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['tsvgx', 01:18:22 INFO - 'tsvgr_opacity', 01:18:22 INFO - 'tart', 01:18:22 INFO - 'tscrollx', 01:18:22 INFO - 'cart', 01:18:22 INFO - 'tsvg_static']}, 01:18:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:18:22 INFO - 'tsvgr_opacity', 01:18:22 INFO - 'tart', 01:18:22 INFO - 'tscrollx', 01:18:22 INFO - 'cart', 01:18:22 INFO - 'tsvg_static']}, 01:18:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'talos_options': ['--disable-e10s'], 01:18:22 INFO - 'tests': ['tp5o']}, 01:18:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:18:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'talos_options': ['--disable-e10s', 01:18:22 INFO - '--xperf_path', 01:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:22 INFO - 'tests': ['tp5n']}, 01:18:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:18:22 INFO - 'talos_options': ['--xperf_path', 01:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:18:22 INFO - 'tests': ['tp5n']}}, 01:18:22 INFO - 'talos.zip': {'path': '', 01:18:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:18:22 INFO - Running post-action listener: _resource_record_post_action 01:18:22 INFO - [mozharness: 2017-01-12 09:18:22.016628Z] Finished populate-webroot step (success) 01:18:22 INFO - [mozharness: 2017-01-12 09:18:22.016719Z] Running create-virtualenv step. 01:18:22 INFO - Running pre-action listener: _resource_record_pre_action 01:18:22 INFO - Running main action method: create_virtualenv 01:18:22 INFO - Creating virtualenv /builds/slave/test/build/venv 01:18:22 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 01:18:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:18:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:18:22 INFO - Using real prefix '/tools/python27' 01:18:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:18:22 INFO - Installing distribute.............................................................................................................................................................................................done. 01:18:25 INFO - Installing pip.................done. 01:18:25 INFO - Return code: 0 01:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:18:26 INFO - Reading from file tmpfile_stdout 01:18:26 INFO - Output received: 01:18:26 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) 01:18:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:18: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')]} 01:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18: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')]} 01:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:26 INFO - 'HOME': '/Users/cltbld', 01:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:26 INFO - 'LOGNAME': 'cltbld', 01:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:26 INFO - 'MOZ_NO_REMOTE': '1', 01:18:26 INFO - 'NO_EM_RESTART': '1', 01:18:26 INFO - 'PAGER': '/bin/cat', 01:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:26 INFO - 'PWD': '/builds/slave/test', 01:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:26 INFO - 'SHELL': '/bin/bash', 01:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:26 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:26 INFO - 'USER': 'cltbld', 01:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:26 INFO - 'XPC_FLAGS': '0x0', 01:18:26 INFO - 'XPC_SERVICE_NAME': '0', 01:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:26 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 01:18:26 INFO - Cleaning up... 01:18:26 INFO - Return code: 0 01:18:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:18: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')]} 01:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18: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')]} 01:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:26 INFO - 'HOME': '/Users/cltbld', 01:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:26 INFO - 'LOGNAME': 'cltbld', 01:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:26 INFO - 'MOZ_NO_REMOTE': '1', 01:18:26 INFO - 'NO_EM_RESTART': '1', 01:18:26 INFO - 'PAGER': '/bin/cat', 01:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:26 INFO - 'PWD': '/builds/slave/test', 01:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:26 INFO - 'SHELL': '/bin/bash', 01:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:26 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:26 INFO - 'USER': 'cltbld', 01:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:26 INFO - 'XPC_FLAGS': '0x0', 01:18:26 INFO - 'XPC_SERVICE_NAME': '0', 01:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:26 INFO - Downloading/unpacking psutil>=3.1.1 01:18:26 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 01:18:26 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 01:18:26 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 01:18:26 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 01:18:26 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 01:18:26 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 01:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:18:30 INFO - Installing collected packages: psutil 01:18:30 INFO - Running setup.py install for psutil 01:18:30 INFO - building 'psutil._psutil_osx' extension 01:18:30 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 01:18:31 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 01:18:31 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 01:18:31 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 01:18:31 INFO - building 'psutil._psutil_posix' extension 01:18:31 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 01:18:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:18:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:18:31 INFO - ^ 01:18:31 INFO - 1 warning generated. 01:18:31 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 01:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:18:31 INFO - Successfully installed psutil 01:18:31 INFO - Cleaning up... 01:18:31 INFO - Return code: 0 01:18:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:31 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:31 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 01:18:31 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 01:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:31 INFO - 'HOME': '/Users/cltbld', 01:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:31 INFO - 'LOGNAME': 'cltbld', 01:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:31 INFO - 'MOZ_NO_REMOTE': '1', 01:18:31 INFO - 'NO_EM_RESTART': '1', 01:18:31 INFO - 'PAGER': '/bin/cat', 01:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:31 INFO - 'PWD': '/builds/slave/test', 01:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:31 INFO - 'SHELL': '/bin/bash', 01:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:31 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:31 INFO - 'USER': 'cltbld', 01:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:31 INFO - 'XPC_FLAGS': '0x0', 01:18:31 INFO - 'XPC_SERVICE_NAME': '0', 01:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:18:32 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 01:18:32 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 01:18:32 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 01:18:32 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 01:18:32 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 01:18:32 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 01:18:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:18:34 INFO - Installing collected packages: mozsystemmonitor 01:18:34 INFO - Running setup.py install for mozsystemmonitor 01:18:34 INFO - Successfully installed mozsystemmonitor 01:18:34 INFO - Cleaning up... 01:18:35 INFO - Return code: 0 01:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:18: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')]} 01:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18: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')]} 01:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18: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', '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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:18: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 jsonschema==2.5.1 01:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:35 INFO - 'HOME': '/Users/cltbld', 01:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:35 INFO - 'LOGNAME': 'cltbld', 01:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:35 INFO - 'MOZ_NO_REMOTE': '1', 01:18:35 INFO - 'NO_EM_RESTART': '1', 01:18:35 INFO - 'PAGER': '/bin/cat', 01:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:35 INFO - 'PWD': '/builds/slave/test', 01:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:35 INFO - 'SHELL': '/bin/bash', 01:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:35 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:35 INFO - 'USER': 'cltbld', 01:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:35 INFO - 'XPC_FLAGS': '0x0', 01:18:35 INFO - 'XPC_SERVICE_NAME': '0', 01:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:35 INFO - Downloading/unpacking jsonschema==2.5.1 01:18: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 01:18: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 01:18: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 01:18: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 01:18: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 01:18: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 01:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:18:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:18:37 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 01:18:37 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 01:18:37 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 01:18:37 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 01:18:37 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 01:18:37 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 01:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 01:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:18:38 INFO - warning: no files found matching '*.txt' 01:18:38 INFO - no previously-included directories found matching 'build' 01:18:38 INFO - no previously-included directories found matching 'dist' 01:18:38 INFO - no previously-included directories found matching '.git*' 01:18:38 INFO - Installing collected packages: jsonschema, functools32 01:18:38 INFO - Running setup.py install for functools32 01:18:38 INFO - warning: no files found matching '*.txt' 01:18:38 INFO - no previously-included directories found matching 'build' 01:18:38 INFO - no previously-included directories found matching 'dist' 01:18:38 INFO - no previously-included directories found matching '.git*' 01:18:38 INFO - Successfully installed jsonschema functools32 01:18:38 INFO - Cleaning up... 01:18:38 INFO - Return code: 0 01:18:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:18:38 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')]} 01:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:38 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')]} 01:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:38 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:38 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 01:18:38 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 01:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:38 INFO - 'HOME': '/Users/cltbld', 01:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:38 INFO - 'LOGNAME': 'cltbld', 01:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:38 INFO - 'MOZ_NO_REMOTE': '1', 01:18:38 INFO - 'NO_EM_RESTART': '1', 01:18:38 INFO - 'PAGER': '/bin/cat', 01:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:38 INFO - 'PWD': '/builds/slave/test', 01:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:38 INFO - 'SHELL': '/bin/bash', 01:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:38 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:38 INFO - 'USER': 'cltbld', 01:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:38 INFO - 'XPC_FLAGS': '0x0', 01:18:38 INFO - 'XPC_SERVICE_NAME': '0', 01:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:18:38 INFO - Cleaning up... 01:18:38 INFO - Return code: 0 01:18:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:18:38 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')]} 01:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:38 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')]} 01:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:38 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:38 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 01:18:38 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 01:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:38 INFO - 'HOME': '/Users/cltbld', 01:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:38 INFO - 'LOGNAME': 'cltbld', 01:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:38 INFO - 'MOZ_NO_REMOTE': '1', 01:18:38 INFO - 'NO_EM_RESTART': '1', 01:18:38 INFO - 'PAGER': '/bin/cat', 01:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:38 INFO - 'PWD': '/builds/slave/test', 01:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:38 INFO - 'SHELL': '/bin/bash', 01:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:38 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:38 INFO - 'USER': 'cltbld', 01:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:38 INFO - 'XPC_FLAGS': '0x0', 01:18:38 INFO - 'XPC_SERVICE_NAME': '0', 01:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:39 INFO - Downloading/unpacking blobuploader==1.2.4 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:39 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 01:18:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:18:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:18:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:18:43 INFO - Downloading docopt-0.6.1.tar.gz 01:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:18:43 INFO - Installing collected packages: blobuploader, requests, docopt 01:18:43 INFO - Running setup.py install for blobuploader 01:18:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:18:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:18:43 INFO - Running setup.py install for requests 01:18:43 INFO - Running setup.py install for docopt 01:18:44 INFO - Successfully installed blobuploader requests docopt 01:18:44 INFO - Cleaning up... 01:18:44 INFO - Return code: 0 01:18:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:44 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:44 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 01:18:44 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 01:18:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:44 INFO - 'HOME': '/Users/cltbld', 01:18:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:44 INFO - 'LOGNAME': 'cltbld', 01:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:44 INFO - 'MOZ_NO_REMOTE': '1', 01:18:44 INFO - 'NO_EM_RESTART': '1', 01:18:44 INFO - 'PAGER': '/bin/cat', 01:18:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:44 INFO - 'PWD': '/builds/slave/test', 01:18:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:44 INFO - 'SHELL': '/bin/bash', 01:18:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:44 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:44 INFO - 'USER': 'cltbld', 01:18:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:44 INFO - 'XPC_FLAGS': '0x0', 01:18:44 INFO - 'XPC_SERVICE_NAME': '0', 01:18:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-74xNuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-dLSM25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-V9el6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-I3UUPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-pMCR0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ZRBOW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:18:44 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-k0xgpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-6EdTyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-bjpdli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-V8vhTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-f9Hxqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-3Z36hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-B9Udat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-_zdBe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-qoAss7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:18:45 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-HlHeYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:18:46 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-W8Ed4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:18:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:18:46 INFO - Running setup.py install for manifestparser 01:18:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Running setup.py install for mozcrash 01:18:46 INFO - Running setup.py install for mozdebug 01:18:46 INFO - Running setup.py install for mozdevice 01:18:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:18:46 INFO - Running setup.py install for mozfile 01:18:46 INFO - Running setup.py install for mozhttpd 01:18:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Running setup.py install for mozinfo 01:18:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Running setup.py install for mozInstall 01:18:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Running setup.py install for mozleak 01:18:47 INFO - Running setup.py install for mozlog 01:18:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Running setup.py install for moznetwork 01:18:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:18:47 INFO - Running setup.py install for mozprocess 01:18:47 INFO - Running setup.py install for mozprofile 01:18:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:18:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:18:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:18:48 INFO - Running setup.py install for mozrunner 01:18:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:18:48 INFO - Running setup.py install for mozscreenshot 01:18:48 INFO - Running setup.py install for moztest 01:18:48 INFO - Running setup.py install for mozversion 01:18:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:18:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:18:48 INFO - Cleaning up... 01:18:48 INFO - Return code: 0 01:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:48 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:48 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 01:18:48 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 01:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:48 INFO - 'HOME': '/Users/cltbld', 01:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:48 INFO - 'LOGNAME': 'cltbld', 01:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:48 INFO - 'MOZ_NO_REMOTE': '1', 01:18:48 INFO - 'NO_EM_RESTART': '1', 01:18:48 INFO - 'PAGER': '/bin/cat', 01:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:48 INFO - 'PWD': '/builds/slave/test', 01:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:48 INFO - 'SHELL': '/bin/bash', 01:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:48 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:48 INFO - 'USER': 'cltbld', 01:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:48 INFO - 'XPC_FLAGS': '0x0', 01:18:48 INFO - 'XPC_SERVICE_NAME': '0', 01:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-63u0pD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-8GKdFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-NZssZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-V3Vd6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ijhSOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-K0PbFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-C3mgjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-641gVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-E86XwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:18:49 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)) 01:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:18:49 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-fEepGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:18:50 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-ibskRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:18:50 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-54e4Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-E1m6Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:18:50 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-0Ynxtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:18:50 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-nkxNU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:18:50 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-niNMGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:18:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 01:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:18:50 INFO - Running setup.py (path:/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/pip-o7Xh6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 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)) 01:18:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:18: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 01:18: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 01:18: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 01:18: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 01:18: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 01:18: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 01:18:53 INFO - Downloading blessings-1.6.tar.gz 01:18:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:18:53 INFO - Installing collected packages: blessings 01:18:53 INFO - Running setup.py install for blessings 01:18:53 INFO - Successfully installed blessings 01:18:53 INFO - Cleaning up... 01:18:53 INFO - Return code: 0 01:18:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:18:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:18:54 INFO - Reading from file tmpfile_stdout 01:18:54 INFO - Current package versions: 01:18:54 INFO - blessings == 1.6 01:18:54 INFO - blobuploader == 1.2.4 01:18:54 INFO - docopt == 0.6.1 01:18:54 INFO - functools32 == 3.2.3-2 01:18:54 INFO - jsonschema == 2.5.1 01:18:54 INFO - manifestparser == 1.1 01:18:54 INFO - mozInstall == 1.12 01:18:54 INFO - mozcrash == 1.0 01:18:54 INFO - mozdebug == 0.1 01:18:54 INFO - mozdevice == 0.49 01:18:54 INFO - mozfile == 1.2 01:18:54 INFO - mozhttpd == 0.7 01:18:54 INFO - mozinfo == 0.9 01:18:54 INFO - mozleak == 0.1 01:18:54 INFO - mozlog == 3.4 01:18:54 INFO - moznetwork == 0.27 01:18:54 INFO - mozprocess == 0.24 01:18:54 INFO - mozprofile == 0.28 01:18:54 INFO - mozrunner == 6.13 01:18:54 INFO - mozscreenshot == 0.1 01:18:54 INFO - mozsystemmonitor == 0.3 01:18:54 INFO - moztest == 0.8 01:18:54 INFO - mozversion == 1.4 01:18:54 INFO - psutil == 3.1.1 01:18:54 INFO - requests == 1.2.3 01:18:54 INFO - wsgiref == 0.1.2 01:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:54 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 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:54 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 01:18:54 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 01:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:54 INFO - 'HOME': '/Users/cltbld', 01:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:54 INFO - 'LOGNAME': 'cltbld', 01:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:54 INFO - 'MOZ_NO_REMOTE': '1', 01:18:54 INFO - 'NO_EM_RESTART': '1', 01:18:54 INFO - 'PAGER': '/bin/cat', 01:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:54 INFO - 'PWD': '/builds/slave/test', 01:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:54 INFO - 'SHELL': '/bin/bash', 01:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:54 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:54 INFO - 'USER': 'cltbld', 01:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:54 INFO - 'XPC_FLAGS': '0x0', 01:18:54 INFO - 'XPC_SERVICE_NAME': '0', 01:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 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)) 01:18:54 INFO - Cleaning up... 01:18:54 INFO - Return code: 0 01:18:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:18:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac5a595b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, '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.V9DPtd6I85/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.6rUbfR8kDw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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 01:18:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:18:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:18:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:18:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:18:54 INFO - 'HOME': '/Users/cltbld', 01:18:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:18:54 INFO - 'LOGNAME': 'cltbld', 01:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:18:54 INFO - 'MOZ_NO_REMOTE': '1', 01:18:54 INFO - 'NO_EM_RESTART': '1', 01:18:54 INFO - 'PAGER': '/bin/cat', 01:18:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:18:54 INFO - 'PWD': '/builds/slave/test', 01:18:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:18:54 INFO - 'SHELL': '/bin/bash', 01:18:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:18:54 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:18:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:18:54 INFO - 'USER': 'cltbld', 01:18:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:18:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:18:54 INFO - 'XPC_FLAGS': '0x0', 01:18:54 INFO - 'XPC_SERVICE_NAME': '0', 01:18:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:18:54 INFO - Cleaning up... 01:18:54 INFO - Return code: 0 01:18:54 INFO - Running post-action listener: _resource_record_post_action 01:18:54 INFO - Running post-action listener: _start_resource_monitoring 01:18:54 INFO - Starting resource monitoring. 01:18:54 INFO - [mozharness: 2017-01-12 09:18:54.677354Z] Finished create-virtualenv step (success) 01:18:54 INFO - [mozharness: 2017-01-12 09:18:54.678322Z] Running install step. 01:18:54 INFO - Running pre-action listener: _resource_record_pre_action 01:18:54 INFO - Running main action method: install 01:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:18:54 INFO - Reading from file tmpfile_stdout 01:18:54 INFO - Detecting whether we're running mozinstall >=1.0... 01:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:18:55 INFO - Reading from file tmpfile_stdout 01:18:55 INFO - Output received: 01:18:55 INFO - Usage: mozinstall [options] installer 01:18:55 INFO - Options: 01:18:55 INFO - -h, --help show this help message and exit 01:18:55 INFO - -d DEST, --destination=DEST 01:18:55 INFO - Directory to install application into. [default: 01:18:55 INFO - "/builds/slave/test"] 01:18:55 INFO - --app=APP Application being installed. [default: firefox] 01:18:55 INFO - mkdir: /builds/slave/test/build/application 01:18:55 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'] 01:18:55 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 01:19:16 INFO - Reading from file tmpfile_stdout 01:19:16 INFO - Output received: 01:19:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:19:16 INFO - Running post-action listener: _resource_record_post_action 01:19:16 INFO - [mozharness: 2017-01-12 09:19:16.785400Z] Finished install step (success) 01:19:16 INFO - [mozharness: 2017-01-12 09:19:16.785575Z] Running run-tests step. 01:19:16 INFO - Running pre-action listener: _resource_record_pre_action 01:19:16 INFO - Running main action method: run_tests 01:19:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:19:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:19:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:19:16 INFO - 2017-01-12 01:19:16.800 screenresolution[1627:8592] starting screenresolution argv=screenresolution get 01:19:16 INFO - 2017-01-12 01:19:16.802 screenresolution[1627:8592] Display 0: 1600x1200x32@60 01:19:16 INFO - 2017-01-12 01:19:16.808 screenresolution[1628:8595] starting screenresolution argv=screenresolution list 01:19:16 INFO - Available Modes on Display 0 01:19:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:19:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:19:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:19:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:19:17 INFO - Intel Iris: 01:19:17 INFO - Chipset Model: Intel Iris 01:19:17 INFO - Type: GPU 01:19:17 INFO - Bus: Built-In 01:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 01:19:17 INFO - Vendor: Intel (0x8086) 01:19:17 INFO - Device ID: 0x0a2e 01:19:17 INFO - Revision ID: 0x0009 01:19:17 INFO - Displays: 01:19:17 INFO - Display: 01:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:19:17 INFO - Display Serial Number: 1600x1200 60 01:19:17 INFO - Main Display: Yes 01:19:17 INFO - Mirror: Off 01:19:17 INFO - Online: Yes 01:19:17 INFO - Rotation: Supported 01:19:17 INFO - Return code: 0 01:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:17 INFO - Python 2.7.3 01:19:17 INFO - Return code: 0 01:19:17 INFO - grabbing minidump binary from tooltool 01:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:19:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053e4d30>, '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 0x10530bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053d9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:19:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:19:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:19:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:19:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:17 INFO - Return code: 0 01:19:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:17 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/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 01:19:17 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/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0359 --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 01:19:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V9DPtd6I85/Render', 01:19:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:19:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:19:17 INFO - 'HOME': '/Users/cltbld', 01:19:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:19:17 INFO - 'LOGNAME': 'cltbld', 01:19:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:17 INFO - 'MOZ_NO_REMOTE': '1', 01:19:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:17 INFO - 'NO_EM_RESTART': '1', 01:19:17 INFO - 'PAGER': '/bin/cat', 01:19:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:17 INFO - 'PWD': '/builds/slave/test', 01:19:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:19:17 INFO - 'SHELL': '/bin/bash', 01:19:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6rUbfR8kDw/Listeners', 01:19:17 INFO - 'TMPDIR': '/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/', 01:19:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:19:17 INFO - 'USER': 'cltbld', 01:19:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:19:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:17 INFO - 'XPC_FLAGS': '0x0', 01:19:17 INFO - 'XPC_SERVICE_NAME': '0', 01:19:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:19:17 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/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0359', '--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 01:19:17 INFO - mozversion application_buildid: 20170112001116 01:19:17 INFO - mozversion application_changeset: 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 01:19:17 INFO - mozversion application_display_name: Nightly 01:19:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:17 INFO - mozversion application_name: Firefox 01:19:17 INFO - mozversion application_remotingname: firefox 01:19:17 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 01:19:17 INFO - mozversion application_vendor: Mozilla 01:19:17 INFO - mozversion application_version: 53.0a1 01:19:17 INFO - mozversion platform_buildid: 20170112001116 01:19:17 INFO - mozversion platform_changeset: 11b1c9cffb0ac0b13c35e96f92238ddee06370f8 01:19:17 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 01:19:17 INFO - mozversion platform_version: 53.0a1 01:19:17 INFO - using testdate: 1484212757 01:19:17 INFO - actual date: 1484212757 01:19:17 INFO - starting webserver on 'localhost:49241' 01:19:17 INFO - SUITE-START | Running 2 tests 01:19:17 INFO - TEST-START | dromaeo_css 01:19:17 INFO - operating with platform_type : mac_ 01:19:17 INFO - Initialising browser for dromaeo_css test... 01:19:17 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp1SsGHT/profile http://localhost:49241/getInfo.html) 01:19:20 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 01:19:20 INFO - PROCESS | 1638 | colorDepth:24 01:19:20 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 01:19:20 INFO - PROCESS | 1638 | __metrics 01:19:20 INFO - PROCESS | 1638 | 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" 01:19:20 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:19:21 INFO - TEST-INFO | 1638: exit 0 01:19:21 INFO - Browser initialized. 01:19:21 INFO - Running cycle 1/1 for dromaeo_css test... 01:19:21 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmp1SsGHT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:19:33 INFO - PROCESS | 1642 | RSS: Main: 234868736 01:19:33 INFO - PROCESS | 1642 | 01:22:37 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 01:22:38 INFO - PROCESS | 1642 | RSS: Main: 339148800 01:22:38 INFO - PROCESS | 1642 | 01:24:21 INFO - PROCESS | 1642 | ************************* 01:24:21 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 01:24:21 INFO - PROCESS | 1642 | 01:24:21 INFO - PROCESS | 1642 | Full message: ReferenceError: fetch is not defined 01:24:21 INFO - PROCESS | 1642 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 01:24:21 INFO - PROCESS | 1642 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 01:24:21 INFO - PROCESS | 1642 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 01:24:21 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 01:24:21 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 01:24:21 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 01:24:21 INFO - PROCESS | 1642 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 01:24:21 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 01:24:21 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 01:24:21 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 01:24:21 INFO - PROCESS | 1642 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 01:24:21 INFO - PROCESS | 1642 | 01:24:21 INFO - PROCESS | 1642 | ************************* 01:25:41 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 01:25:42 INFO - PROCESS | 1642 | RSS: Main: 364204032 01:25:42 INFO - PROCESS | 1642 | 01:28:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 01:28:45 INFO - PROCESS | 1642 | RSS: Main: 344739840 01:28:45 INFO - PROCESS | 1642 | 01:31:47 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 01:31:48 INFO - PROCESS | 1642 | RSS: Main: 344027136 01:31:48 INFO - PROCESS | 1642 | 01:34:51 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 01:34:52 INFO - PROCESS | 1642 | RSS: Main: 333266944 01:34:52 INFO - PROCESS | 1642 | 01:37:55 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 01:37:56 INFO - PROCESS | 1642 | RSS: Main: 434319360 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | __start_tp_report 01:37:56 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 01:37:56 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 01:37:56 INFO - PROCESS | 1642 | |i|pagename|runs| 01:37:56 INFO - PROCESS | 1642 | |0;dojo.html;3323.0861513083905;3326.218338690407;3326.683965023322;3343.9498407523874;3378.1554611347165;4555;5463;5558.86102847429;5587.580931430139;5604.019296623095;5549.833504994846;5585.720713964306;5586.581006424514;5666.5183459406;5674.347450043247;5079.060373830835;5115.130427827278;5129.6409251352425;5164.328637277149;5194.065068287726;5076.974615126919;5143.639945203838;5216.973915130419;5218.947810521884;5236.31927849379;5179;5185.740712964355;5202.0376230397305;5210.687358758487;5214.957008598258;5058.747062646853;5086.593072554187;5110.948890511085;5120;5125.743712814345;5095.949040509621;5139.691618502902;5145.3568303962;5151.459096794858;5177.249298851683;5545.473180047889;5596.27248457702;5610.354809196954;5633.352164501053;5634.295713035871;5046.62150338726;6042.6978651067275;6104.114903338991;6156.56904016719;6181.752729890799;6102.011330178901;6116.092308610896;6165.167702360169;6185.938140618626;6186.319504854462;5732.742026608813;5739.626924249994;5781.335146458127;5793.275840519935;5800.506956908668;6098.939010609926;6214.098955651405;6227.439530442282;6227.782027629011;6229.999999999909;5918.704064796829;6084.939150608526;6092;6100.72546735398;6102;6101.156499726972;6127.754889804447;6139.124180917401;6144.4945988232275;6153.84615384619;6001.219841420675;6042.274927008787;6059.21230240066;6095.207623008981;6109.175261339751;6136.56222693796;6148.6925653717135;6189.071639254058;6196.256449226032;6208.875822483525;4917.582005529499;4918.1884988977135;4919.139150648693;4921.876953076202;4955.72743499111;4330.17726631939;4340.414044104069;4351.499577548622;4368.366586844953;4425.822967081345;4841.733704646208;5676.120201368794;5763.423657634287;5773.6824474654295;5787.2476578045425;6182.752689892444;6192.721327540272;6197.690115494297;6207.689615519206;6215;5706.258186435737;5727.341355744059;5728.398518155617;5728.51307638847;5738.282714660668;5238.030964271622;5334.8933021340135;5336.653117547425;5341.599380046434;5344.732763361816;6222.253329600387;6234.875302494015;6242.968785156045;6254.249490061222;6262.436380725757;6212.0371342441995;6213.03697926822;6222.346653601307;6227.283862355887;6242.219722534684;6107.175531303395;6145.955187618027;6146.969265153645;6228.750849965951;6239.812805615838;6044.879102417839;6125.662799505599;6129.908988904127;6132.998044146438;6137.7447333336595;6192.133101365903;6194.318624951342;6210.596311239755;6216.2540495140875;6216.595921265103;5886.117082437669;5937.020391635332;6011.234831977339;6054.727537260922;6065.363136870565;5978.073398623221;5996.370381110095;6034.336223015377;6053.485453736482;6067.423594758491;5874.530037596896;5876.1773351731645;5885.73514191871;5886.05823068307;5892.2929248488745;5871.500922421471;5917.260342457193;5924.111383292368;5929.080992446177;6001.549883758823;5802.738876750641;5871.354151043467;5915.822525324247;5919.378465261258;5930.347661757117 01:37:56 INFO - PROCESS | 1642 | |1;ext.html;446.95530446955286;465.88653119045506;467.4951052862908;471.91505529004775;509.80627361602586;31437.685623143763;40157.99210039497;42624.57375426245;42656.14687706244;42672.35991460131;43484.91287717801;43863;43898.78050609751;43908.90227744308;43933.56066439335;9251.768705782342;9461.574229159703;9469.526523673789;9473.242140628767;9476.19452346548;8368.246857782799;8592.484450932932;11160.386178760165;11408.885911140866;11435.256708313933;11255.155863310243;11276.943615281913;11334;11357.716057098556;11364.31814091153;8438.198371154793;11321.773564528705;11397.48711307985;11398.373089480076;11398.772024559505;8461.450005749606;8923.509206993613;11093.33439993603;11116.833247501294;11296.887031129749;41203.381949270784;41597.79201103975;41627.37558936619;41702.791486042675;41726;4033.415154802537;4061.4517040199785;4068.0643452005907;4097.282975479279;4210.7473551587;25286;29655.73786883441;30845.228869278224;31113.533297000562;31252;3133.7649676274373;3168.8574014169417;3252.0569034979826;3313.022658315803;3314.8839790607453;478465.6076719629;478809;480659;480748;483232;62374;62531;63078.369216308165;63821;64384;66734;67022.99465508021;68069;68448;68675;15791.21043947798;16240.918795405947;16268.023918564924;16282.83717162837;16284.43004494837;11215.327080375204;11490.13823963206;11931.880681193077;12003;12400.56598019065;16781.496555103367;17096.91451542759;18263.908680456512;18716.157772900253;19150.80849191518;6536.836579085466;7494.063242094739;7568.205338439385;7594.886076708854;7732.497387669783;869.4261787220404;873.3886279604176;875.9781005474787;879.1164879296266;914.4604683236922;30020.84989575082;30058.24854378658;30390.69609303923;30450;30963.0711078668;1048.4076496779296;1059.86751656043;1080.2816127275273;1094.441834664311;1128.5260190719916;13160.934195329153;13971.441142354395;15257.465988690343;15773.68452630941;16240.51278461648;610634;615357;618294;621768.8911555413;622041;45078;55144;55483.445165547826;55526.72236638872;55794;1393.853645367242;1432.0763107795622;1448.7175000874938;1451.4557041109795;1453.4767483706069;27535.173944781687;28244.15267541977;29082.56376154317;29345.007610425946;29593.556096659;47867.76066119786;48146;48172;48325;48389;540216.2989185029;543343;544733;545187;546388;22517.43706407353;25025.124120655688;25387;25488.107916223584;25530.978760849357;35520.82239588785;40570.59429405668;42485.362719558616;43847.56152438435;45032.87417814581;30574.694253058075;34297.48553771646;35959.64040359563;36862.078448039014;37419.6258037427;35595.82202088973;36164.09589760172;36896.26207475782;37102.70140545068;38748.41877371898;33367.165820853705;33506.497402538494;35453.645463545035;35945;37103.6289637111;24951;31167;31332.216694582818;32272.677273226967;32795.83602081974;23604;23690.28929132129;23832.761672383054;23937.922793473987;24018.87990560036 01:37:56 INFO - PROCESS | 1642 | |2;jquery.html;368.1110119062461;392.71331927692785;393.341153567774;400.35742633073914;422.41917363625015;14558.344874480646;15008.324625391842;20689.68965465519;21968.90155492223;22204.8897555122;21048.684269735968;21589.028493717782;21777.455563610918;22186.112555497763;22437;4820.927686084711;5807.680577568242;6031.095335699636;6053.757849686007;6077.939220607782;5938.88122237555;5978.192943952576;6049.5462840287155;6052.394760523935;6077;5683.602147849652;5834;5998.97000514999;6011.75952961881;6013.248343957005;5898.557608179382;5952;5960.0761881908375;5971.223740913653;5971.611845230046;5079.568236699885;5082.263071854597;5219.42586315505;5235.319408476912;5268.236105764643;21517.246896358552;25954.22137335883;25964.09125680592;25983.480330393286;26000.34999125018;2470.7776300132896;2638.7493188147287;2647.377866201441;2649.5628221343454;2697.7302269772867;10370.118709780621;10640;10661.253712240146;14784.556463306119;16064.196790160446;1809.746635471035;1827.1960337451478;1852.351676913083;1863.1243315641627;1944.3292064237814;133122;135751.10364515355;135983;137020;139916;10411.958804119527;11565.074794016627;11766.88233117675;11775.646730598095;12002.63992080239;12511;14877.553673389815;15648.217589120499;15648.608784780245;16248;7817.765467035998;7984.640691168911;8740.300775937909;8759.255463285564;8907.688230911886;7162.534435261691;8267.214614611603;8491.872621910676;8665.696700615448;8665.913340866511;4068.7386910057976;4671.299305104261;4752.904941901212;4761.190597598416;4857.271409288635;1957.2268953763185;1996.5407956170163;2011.9899400502904;2013.2752209204675;2014.3554062699795;931.6552875436132;986.4278718343344;1016.3343010328247;1016.9796604067877;1051.1800795379615;20987.8950605246;21430.464238394165;21503.354899353046;21646.238166417537;21757.67363489549;912.5118061836886;1023.5956797065118;1027.1372047480152;1072.3351522056375;1083.8211695070383;10653.414062226497;10733.034026937614;11386.829197562043;11447.25592836463;11464.94267528657;334312;672913;692715;732778;745801;137384;139312;141854.2907285457;151961;158218;934.2806039349526;973.9318247722591;1008.4050410257836;1016.1972042086817;1034.281174583657;13807.654808629864;14459.770919471963;18707.158177881756;19257.42227733114;19510.8048919509;36937.81531092327;42039.36940945827;53145.734271329944;55351.06271280486;59511.10733338917;88093;88507;90999;91064.5446772762;91186.63220051571;7285.198628151005;7420.925790742023;7605.201453847267;7924.20757924203;8598.140185981352;9436.197923176607;13091.607251782461;13341.866581334063;13941.372638231102;13979.09135906163;10286.279960402999;11479.885201147881;11577.421128943688;11901.047916166513;11953.641390758292;11333.546658133582;11472.311661300015;11713.355765432641;11732.41337933117;12006.63980080599;10452.94773526158;10491.213159012952;10929.344239345664;11014.284071535325;11471.4264286787;7531.096268447822;7650.387968962581;7680.577568233801;7764.262395072459;7919.960400197962;8515.616797244014;10825.945870270598;11434.313941163557;11513.827292590786;11723.720841892818 01:37:56 INFO - PROCESS | 1642 | |3;mootools.html;1322.9669258268536;1353.4383230959152;1454.3818876977282;1482.4589025005876;1495.4167874528932;7470.103587569492;7856.332211762;8136.349092072634;8346.16538346165;8365.707200247993;8273.627686754095;8366.581670916461;8371.372147088961;8377.455465394745;8380.916190838105;2057.218257062314;2269.9773002270013;2298.333483289844;2317.9072837086496;2319;2125.2774056820676;2258.503129311549;2324.0936034946385;2333.8949747261413;2339.4034521197154;2264.784845439689;2296.2996286132725;2301.148575027234;2301.666258392532;2301.8158547316175;2248.347979086063;2252.8648281103106;2280.2589158523465;2281.920132795344;2282.2126366403563;2226.6660000999977;2272.9318120456246;2299.9425014374606;2305.4005958450757;2307.653851922208;7220.386267167297;8353.95823020881;8425;8440.155984401572;8447.662093516252;4978.77595508203;5133.666311689728;5133.897322053575;5142.331496905415;5145.562627176694;3000.9496676163385;3280;3453.723702103826;3462.9134271643156;3479.9652003480146;1121.966341009771;1233.2477188914754;1233.5374234662002;1270.333075135552;1287.6652070461653;10630.362178269328;10745.623903163352;10749.731256718645;10761.192910531663;10786.029257366796;4361.6074553290355;4584.7936842842155;4618.284165954283;4761.4524329701835;4769.42766867978;9299.39553929006;9426;9478.95260523693;9512.953575106732;9514.04859514043;5102.540771330524;5184.637075404761;5197.480251974772;5198.766055527511;5203.7918483261;4605.263157894788;4705.411823522059;4761.738104404221;4765.475797662254;4817.253325734517;3725.4970578972034;3762.793046382475;3829.100161462054;3869.903252418712;3925.646691797752;1225.07506832341;1225.6946352134948;1230.4831970572382;1239.69007748063;1242.6272118364454;870.4690139015196;903.7153296711515;908.7909780750332;940.9781611759666;945.2674177512346;5122.282880396748;5622.228997865741;5851.824445266649;5855.092460668603;6015.819525414157;946.8059047895165;956.4452617481844;1006.0442579549457;1013.381837079381;1055.7044027672264;3621.4386770050683;3783.2055268393947;3809.6190380961684;3886.7473614214987;3890.7665540067687;9749.122578967927;9910.80178396428;10033;10035.34770239932;10056.64801731936;9303.302252331103;9971.601135954481;9981.051800078982;9985.900140998643;10005.649802256887;7544.245575442522;7840;7841.568713720686;7846.215378462222;7857.253560911704;5754.712264386848;5778.711064446845;5801.332846722681;5958.880822383615;6088.178095956989;9271.629134834531;9276.907230927603;9288.11762882525;9291.535423228946;9300.813983720423;8410.915890841257;9171.862422063808;9216.907830921873;9403.200727938201;9479.620815167316;5948.524118070457;7250.456215783943;7260.673269702982;7334.816629584303;7343.155537113087;7901.328387087162;7993.8401231976195;8017.759467215993;8064.637091331021;8074.273315401642;7060.258672839484;7125.501214915113;7135.714571417293;7154.141503019463;7167.641617918979;7006;7009.983552384773;7090.4682148840075;7181.892271615826;7211.6033618151505;6255.615677974541;6395.744170233139;6395.840103997437;6396.6481843497195;6421.261554921057;4764.332993380999;4871.756412179448;4882.536159064884;4912.803487860446;5060.620453466078;3838.654521093115;4945.282933974481;5048.444671086104;5050.570701490415;5175.249588809676 01:37:56 INFO - PROCESS | 1642 | |4;prototype.html;358.16368778901267;360.1841828258992;370.1855916982637;377.57899941565165;378.98863034108984;5410.837674869756;5476.315460567429;5485.0949593317055;5496.972515137424;5507.5593952483805;4331.30699088146;4440.37834703141;5035.791410061586;5245.816396426126;5405.18922161676;3544.4860495228177;3788.4696142540065;4120.567340429257;4185.979070104645;4211.642010429102;3505.3690335739557;3784.993953204806;4137.813798379065;4138.7997480730555;4190.171634146938;3821.235752849427;3991.3015222335976;4119.794010299488;4145.336746120622;4168.958310416887;3379.307242015381;4018.2164477926817;4057.857974970862;4060.3706425504092;4081.2859448466734;3092.6443459002276;3351.6648335166533;3481.704055155315;3493.567637268733;3503.544539209912;5148.691078535262;5160.354955630546;5182.119039763249;5183.481651834786;5224.216367544861;4360.106178233455;4599.5400459953735;4633.745144017078;4637.373954516131;4658.9068218635775;4855.538723821267;5335.7865685372535;5486.725663716838;5525.309336332958;5641.746121424546;3818.6754125899056;3827.5215598050245;3839.616038396166;3883.8058097095313;3883.9611603884164;5494.395616482184;5567.610267281292;5909.911351329733;5958.642481451084;5995.970020149958;3396.4735466002808;3881.825317860703;3917.9617401388655;3918.333883239799;3928.2143571285856;3403.0981789825714;3815.7138214634015;3951.841926322915;3960.940585891214;3969.801509924492;4051.6150965658217;4209.2633789086785;4236.644273832406;4601.677882548256;4662.580367766849;5697.379205565487;5702.6293290935955;5705.885882282414;5723.395854886016;5728.48443640066;1073.5974009746344;1115.3252282369212;1211.6970757310673;1244.234795600699;1293.9870601294056;816.2327412232482;822.6997146041651;843.3927572148043;855.4867079752099;856.5631527920681;4394.1764167870615;4683.765811709401;4891.021795640886;4892.678976676278;4912.287718280901;4474.127545128734;4562.58936695699;4630.277117340362;5036.859334782703;5539.446055394428;4270.1603433716855;4409.824926053237;4499.302608095751;4983;5003.824866129741;2425.902963881425;2505.937351566189;2796.944061118807;2893.5821447491;2910.461564610554;4758.881027974328;5264.15773476242;5358.732063396815;5519.613627046068;5654.964212883358;4600.907981840344;4834.307992202701;4933.753312334369;5286.60350473716;5473.589480788957;4744.833930812405;4872.317875497433;5286.54175808251;5756.366799652119;5781.4218578141845;4606;4831.347768051268;5122.8975420492125;5307.310049693515;5492.450754924475;4394.626456751212;4609.847538115471;4716.481187069488;5327.547158491571;5475.151351540518;4855.5387238212315;5286.427240437071;5643.811246645632;5702.942970570241;5744.885102298014;3047.9847600761855;3398.5021009557463;3668.559772827278;3678.779273243614;3680.7975561344383;5026.592554084862;5081;5433.212184233185;5456.45435456467;5512.614117011771;4444.355568442623;4826.444958829639;5333.679979201261;5366.865828354323;5372.737406709342;4392.802323895497;4636.863968327782;5112.565431938327;5142.948570514247;5292.973535132453;4302.9354559681005;4876.829310974099;5116.341815601862;5163.230841485662;5215.687058776485;4936.901261974812;5045.6720313180995;5072.213806859942;5227.7714737036;5283.365996080495;4777.945483442153;4785.665003449725;4967.863818558055;4972.900541989212;5337.146056630921 01:37:56 INFO - PROCESS | 1642 | |5;yui.html;730.3864753606969;763.503722580323;776.7009701265015;825.0841565861895;825.9504429734217;14594.48919287825;15499.147546884917;15499.922500387496;15514.612134696637;15529;12249.387530623455;14335.856641433582;14490;14509.637259068528;14517.854821451783;683.6342556732162;839.7858546070773;865.3423398217337;867.6963062927956;870.9172628600304;867.8090820019618;867.8481265778495;871.263782104121;872.2716531696042;873.1225118755674;928.336239588694;930.2046750028729;931.8322701913653;931.9347645664806;934.2666007184362;724.080417869303;745.8843879198732;751.1399447632485;924.0620769918538;925.7222833150062;559.7593034994951;559.8180591307841;666.0309250041179;681.3595220492771;687.88993760998;15184.772228416583;15212.847871521253;15249.542513724606;15253.923730381388;15269.847301526954;13734.793978090336;13789.724205515833;13847;13895.930520347434;13944.999999999898;10649.680509584647;12915.547955821596;13016.284104374256;13085.738285234338;13154;4371.125774845043;4415.867523974286;4558.202314594966;4591.242444996572;4673.556012178871;105686;110117.44941275242;113974.43012784883;114400;114539.85460145376;11073.833892491619;11083.889161108447;11198.664040078811;11216.775664486664;11554.422278886022;19307.4207773767;23251.396033614816;23274;23292.301230963098;23329.76670233276;6836.350546698155;7732.6520306586335;7818.491798033224;7827.060752709597;7890.092639346434;4126.09225970286;4237.343211802176;4253.425787518645;4256.212600668886;4258.787060646955;3225.419424503565;3298.5711857458377;3301.570795796579;3313.519539666735;3317.386283537505;632.3486808587163;637.3148864970176;640.0527219714849;646.1954866191528;647.0488382078337;640.5804198250154;643.122028920586;644.7421031587403;647.9319671434525;669.845935434843;8846.867296990551;9896.208303335716;9937.45344006072;9963.153131983863;10154.796904061877;629.169496264935;653.5294587896707;662.9403353698094;664.8204984654213;669.4344570032333;4205.453291072202;4624;4836.540528649773;4847.5394837490385;4867.1969125093965;92119;112351.87648123414;113130;113224.43387783009;115800;98371.06515739433;99207.03964801731;101187;103328;103620.48189759154;85208.57395712982;86269;86526;87244.56377718071;87339;9399.577019034297;9475.52622368865;9477.620895164391;9482.857757133786;9505.382150160218;56443.30670079904;56535;56666.083435399465;56984.860302792884;57638.423615763306;76574.617126914;77649;77696.2230377689;78720.61749502484;79414.602926985;11796.115291353011;12886;13096.279704615956;13666.93166534161;14126.293685315899;12485.687857803627;14921.626959326104;14947.252637368305;15235.619109522351;15521.534353969399;13742.93128534351;14043.438262469386;14124.646883827987;14272.928635356757;14866.331015104563;14016;14206.360713767699;14425.927870360581;14566.635834104232;14649.63375915568;13703.177809331472;13771.793423098861;13925.651858703613;14161.787573186204;14455.060421072596;10475.580976760844;11054.834177487182;11221.102311815199;11241.831372529583;11392.772144557228;10937.398443085389;10994.28537145083;11087.667369978913;11180.832287515532;11273.210875238654 01:37:56 INFO - PROCESS | 1642 | __end_tp_report 01:37:56 INFO - PROCESS | 1642 | __start_cc_report 01:37:56 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1108 01:37:56 INFO - PROCESS | 1642 | __end_cc_report 01:37:56 INFO - PROCESS | 1642 | __startTimestamp1484213876086__endTimestamp 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | ------- Summary: start ------- 01:37:56 INFO - PROCESS | 1642 | Number of tests: 6 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5663.70 Median:5886.06 stddev:634.49 (10.8%) stddev-sans-first:609.29 01:37:56 INFO - PROCESS | 1642 | Values: 3323.1 3326.2 3326.7 3343.9 3378.2 4555.0 5463.0 5558.9 5587.6 5604.0 5549.8 5585.7 5586.6 5666.5 5674.3 5079.1 5115.1 5129.6 5164.3 5194.1 5077.0 5143.6 5217.0 5218.9 5236.3 5179.0 5185.7 5202.0 5210.7 5215.0 5058.7 5086.6 5110.9 5120.0 5125.7 5095.9 5139.7 5145.4 5151.5 5177.2 5545.5 5596.3 5610.4 5633.4 5634.3 5046.6 6042.7 6104.1 6156.6 6181.8 6102.0 6116.1 6165.2 6185.9 6186.3 5732.7 5739.6 5781.3 5793.3 5800.5 6098.9 6214.1 6227.4 6227.8 6230.0 5918.7 6084.9 6092.0 6100.7 6102.0 6101.2 6127.8 6139.1 6144.5 6153.8 6001.2 6042.3 6059.2 6095.2 6109.2 6136.6 6148.7 6189.1 6196.3 6208.9 4917.6 4918.2 4919.1 4921.9 4955.7 4330.2 4340.4 4351.5 4368.4 4425.8 4841.7 5676.1 5763.4 5773.7 5787.2 6182.8 6192.7 6197.7 6207.7 6215.0 5706.3 5727.3 5728.4 5728.5 5738.3 5238.0 5334.9 5336.7 5341.6 5344.7 6222.3 6234.9 6243.0 6254.2 6262.4 6212.0 6213.0 6222.3 6227.3 6242.2 6107.2 6146.0 6147.0 6228.8 6239.8 6044.9 6125.7 6129.9 6133.0 6137.7 6192.1 6194.3 6210.6 6216.3 6216.6 5886.1 5937.0 6011.2 6054.7 6065.4 5978.1 5996.4 6034.3 6053.5 6067.4 5874.5 5876.2 5885.7 5886.1 5892.3 5871.5 5917.3 5924.1 5929.1 6001.5 5802.7 5871.4 5915.8 5919.4 5930.3 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:67989.31 Median:36513.09 stddev:146912.82 (402.4%) stddev-sans-first:147237.42 01:37:56 INFO - PROCESS | 1642 | Values: 447.0 465.9 467.5 471.9 509.8 31437.7 40158.0 42624.6 42656.1 42672.4 43484.9 43863.0 43898.8 43908.9 43933.6 9251.8 9461.6 9469.5 9473.2 9476.2 8368.2 8592.5 11160.4 11408.9 11435.3 11255.2 11276.9 11334.0 11357.7 11364.3 8438.2 11321.8 11397.5 11398.4 11398.8 8461.5 8923.5 11093.3 11116.8 11296.9 41203.4 41597.8 41627.4 41702.8 41726.0 4033.4 4061.5 4068.1 4097.3 4210.7 25286.0 29655.7 30845.2 31113.5 31252.0 3133.8 3168.9 3252.1 3313.0 3314.9 478465.6 478809.0 480659.0 480748.0 483232.0 62374.0 62531.0 63078.4 63821.0 64384.0 66734.0 67023.0 68069.0 68448.0 68675.0 15791.2 16240.9 16268.0 16282.8 16284.4 11215.3 11490.1 11931.9 12003.0 12400.6 16781.5 17096.9 18263.9 18716.2 19150.8 6536.8 7494.1 7568.2 7594.9 7732.5 869.4 873.4 876.0 879.1 914.5 30020.8 30058.2 30390.7 30450.0 30963.1 1048.4 1059.9 1080.3 1094.4 1128.5 13160.9 13971.4 15257.5 15773.7 16240.5 610634.0 615357.0 618294.0 621768.9 622041.0 45078.0 55144.0 55483.4 55526.7 55794.0 1393.9 1432.1 1448.7 1451.5 1453.5 27535.2 28244.2 29082.6 29345.0 29593.6 47867.8 48146.0 48172.0 48325.0 48389.0 540216.3 543343.0 544733.0 545187.0 546388.0 22517.4 25025.1 25387.0 25488.1 25531.0 35520.8 40570.6 42485.4 43847.6 45032.9 30574.7 34297.5 35959.6 36862.1 37419.6 35595.8 36164.1 36896.3 37102.7 38748.4 33367.2 33506.5 35453.6 35945.0 37103.6 24951.0 31167.0 31332.2 32272.7 32795.8 23604.0 23690.3 23832.8 23937.9 24018.9 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:37353.30 Median:22077.51 stddev:109827.66 (497.5%) stddev-sans-first:110100.64 01:37:56 INFO - PROCESS | 1642 | Values: 368.1 392.7 393.3 400.4 422.4 14558.3 15008.3 20689.7 21968.9 22204.9 21048.7 21589.0 21777.5 22186.1 22437.0 4820.9 5807.7 6031.1 6053.8 6077.9 5938.9 5978.2 6049.5 6052.4 6077.0 5683.6 5834.0 5999.0 6011.8 6013.2 5898.6 5952.0 5960.1 5971.2 5971.6 5079.6 5082.3 5219.4 5235.3 5268.2 21517.2 25954.2 25964.1 25983.5 26000.3 2470.8 2638.7 2647.4 2649.6 2697.7 10370.1 10640.0 10661.3 14784.6 16064.2 1809.7 1827.2 1852.4 1863.1 1944.3 133122.0 135751.1 135983.0 137020.0 139916.0 10412.0 11565.1 11766.9 11775.6 12002.6 12511.0 14877.6 15648.2 15648.6 16248.0 7817.8 7984.6 8740.3 8759.3 8907.7 7162.5 8267.2 8491.9 8665.7 8665.9 4068.7 4671.3 4752.9 4761.2 4857.3 1957.2 1996.5 2012.0 2013.3 2014.4 931.7 986.4 1016.3 1017.0 1051.2 20987.9 21430.5 21503.4 21646.2 21757.7 912.5 1023.6 1027.1 1072.3 1083.8 10653.4 10733.0 11386.8 11447.3 11464.9 334312.0 672913.0 692715.0 732778.0 745801.0 137384.0 139312.0 141854.3 151961.0 158218.0 934.3 973.9 1008.4 1016.2 1034.3 13807.7 14459.8 18707.2 19257.4 19510.8 36937.8 42039.4 53145.7 55351.1 59511.1 88093.0 88507.0 90999.0 91064.5 91186.6 7285.2 7420.9 7605.2 7924.2 8598.1 9436.2 13091.6 13341.9 13941.4 13979.1 10286.3 11479.9 11577.4 11901.0 11953.6 11333.5 11472.3 11713.4 11732.4 12006.6 10452.9 10491.2 10929.3 11014.3 11471.4 7531.1 7650.4 7680.6 7764.3 7920.0 8515.6 10825.9 11434.3 11513.8 11723.7 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5428.86 Median:5138.11 stddev:2949.96 (57.4%) stddev-sans-first:2942.09 01:37:56 INFO - PROCESS | 1642 | Values: 1323.0 1353.4 1454.4 1482.5 1495.4 7470.1 7856.3 8136.3 8346.2 8365.7 8273.6 8366.6 8371.4 8377.5 8380.9 2057.2 2270.0 2298.3 2317.9 2319.0 2125.3 2258.5 2324.1 2333.9 2339.4 2264.8 2296.3 2301.1 2301.7 2301.8 2248.3 2252.9 2280.3 2281.9 2282.2 2226.7 2272.9 2299.9 2305.4 2307.7 7220.4 8354.0 8425.0 8440.2 8447.7 4978.8 5133.7 5133.9 5142.3 5145.6 3000.9 3280.0 3453.7 3462.9 3480.0 1122.0 1233.2 1233.5 1270.3 1287.7 10630.4 10745.6 10749.7 10761.2 10786.0 4361.6 4584.8 4618.3 4761.5 4769.4 9299.4 9426.0 9479.0 9513.0 9514.0 5102.5 5184.6 5197.5 5198.8 5203.8 4605.3 4705.4 4761.7 4765.5 4817.3 3725.5 3762.8 3829.1 3869.9 3925.6 1225.1 1225.7 1230.5 1239.7 1242.6 870.5 903.7 908.8 941.0 945.3 5122.3 5622.2 5851.8 5855.1 6015.8 946.8 956.4 1006.0 1013.4 1055.7 3621.4 3783.2 3809.6 3886.7 3890.8 9749.1 9910.8 10033.0 10035.3 10056.6 9303.3 9971.6 9981.1 9985.9 10005.6 7544.2 7840.0 7841.6 7846.2 7857.3 5754.7 5778.7 5801.3 5958.9 6088.2 9271.6 9276.9 9288.1 9291.5 9300.8 8410.9 9171.9 9216.9 9403.2 9479.6 5948.5 7250.5 7260.7 7334.8 7343.2 7901.3 7993.8 8017.8 8064.6 8074.3 7060.3 7125.5 7135.7 7154.1 7167.6 7006.0 7010.0 7090.5 7181.9 7211.6 6255.6 6395.7 6395.8 6396.6 6421.3 4764.3 4871.8 4882.5 4912.8 5060.6 3838.7 4945.3 5048.4 5050.6 5175.2 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4341.20 Median:4768.41 stddev:1309.46 (27.5%) stddev-sans-first:1278.55 01:37:56 INFO - PROCESS | 1642 | Values: 358.2 360.2 370.2 377.6 379.0 5410.8 5476.3 5485.1 5497.0 5507.6 4331.3 4440.4 5035.8 5245.8 5405.2 3544.5 3788.5 4120.6 4186.0 4211.6 3505.4 3785.0 4137.8 4138.8 4190.2 3821.2 3991.3 4119.8 4145.3 4169.0 3379.3 4018.2 4057.9 4060.4 4081.3 3092.6 3351.7 3481.7 3493.6 3503.5 5148.7 5160.4 5182.1 5183.5 5224.2 4360.1 4599.5 4633.7 4637.4 4658.9 4855.5 5335.8 5486.7 5525.3 5641.7 3818.7 3827.5 3839.6 3883.8 3884.0 5494.4 5567.6 5909.9 5958.6 5996.0 3396.5 3881.8 3918.0 3918.3 3928.2 3403.1 3815.7 3951.8 3960.9 3969.8 4051.6 4209.3 4236.6 4601.7 4662.6 5697.4 5702.6 5705.9 5723.4 5728.5 1073.6 1115.3 1211.7 1244.2 1294.0 816.2 822.7 843.4 855.5 856.6 4394.2 4683.8 4891.0 4892.7 4912.3 4474.1 4562.6 4630.3 5036.9 5539.4 4270.2 4409.8 4499.3 4983.0 5003.8 2425.9 2505.9 2796.9 2893.6 2910.5 4758.9 5264.2 5358.7 5519.6 5655.0 4600.9 4834.3 4933.8 5286.6 5473.6 4744.8 4872.3 5286.5 5756.4 5781.4 4606.0 4831.3 5122.9 5307.3 5492.5 4394.6 4609.8 4716.5 5327.5 5475.2 4855.5 5286.4 5643.8 5702.9 5744.9 3048.0 3398.5 3668.6 3678.8 3680.8 5026.6 5081.0 5433.2 5456.5 5512.6 4444.4 4826.4 5333.7 5366.9 5372.7 4392.8 4636.9 5112.6 5142.9 5293.0 4302.9 4876.8 5116.3 5163.2 5215.7 4936.9 5045.7 5072.2 5227.8 5283.4 4777.9 4785.7 4967.9 4972.9 5337.1 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21976.69 Median:4245.38 stddev:32315.44 (761.2%) stddev-sans-first:32366.71 01:37:56 INFO - PROCESS | 1642 | Values: 730.4 763.5 776.7 825.1 826.0 14594.5 15499.1 15499.9 15514.6 15529.0 12249.4 14335.9 14490.0 14509.6 14517.9 683.6 839.8 865.3 867.7 870.9 867.8 867.8 871.3 872.3 873.1 928.3 930.2 931.8 931.9 934.3 724.1 745.9 751.1 924.1 925.7 559.8 559.8 666.0 681.4 687.9 15184.8 15212.8 15249.5 15253.9 15269.8 13734.8 13789.7 13847.0 13895.9 13945.0 10649.7 12915.5 13016.3 13085.7 13154.0 4371.1 4415.9 4558.2 4591.2 4673.6 105686.0 110117.4 113974.4 114400.0 114539.9 11073.8 11083.9 11198.7 11216.8 11554.4 19307.4 23251.4 23274.0 23292.3 23329.8 6836.4 7732.7 7818.5 7827.1 7890.1 4126.1 4237.3 4253.4 4256.2 4258.8 3225.4 3298.6 3301.6 3313.5 3317.4 632.3 637.3 640.1 646.2 647.0 640.6 643.1 644.7 647.9 669.8 8846.9 9896.2 9937.5 9963.2 10154.8 629.2 653.5 662.9 664.8 669.4 4205.5 4624.0 4836.5 4847.5 4867.2 92119.0 112351.9 113130.0 113224.4 115800.0 98371.1 99207.0 101187.0 103328.0 103620.5 85208.6 86269.0 86526.0 87244.6 87339.0 9399.6 9475.5 9477.6 9482.9 9505.4 56443.3 56535.0 56666.1 56984.9 57638.4 76574.6 77649.0 77696.2 78720.6 79414.6 11796.1 12886.0 13096.3 13666.9 14126.3 12485.7 14921.6 14947.3 15235.6 15521.5 13742.9 14043.4 14124.6 14272.9 14866.3 14016.0 14206.4 14425.9 14566.6 14649.6 13703.2 13771.8 13925.7 14161.8 14455.1 10475.6 11054.8 11221.1 11241.8 11392.8 10937.4 10994.3 11087.7 11180.8 11273.2 01:37:56 INFO - PROCESS | 1642 | -------- Summary: end -------- 01:37:56 INFO - PROCESS | 1642 | 01:37:56 INFO - TEST-INFO | 1642: exit 0 01:37:56 INFO - TEST-OK | dromaeo_css | took 1119447ms 01:37:56 INFO - TEST-START | kraken 01:37:56 INFO - operating with platform_type : mac_ 01:37:56 INFO - Initialising browser for kraken test... 01:37:56 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmppN05VO/profile http://localhost:49241/getInfo.html) 01:37:59 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 01:37:59 INFO - PROCESS | 1649 | colorDepth:24 01:37:59 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 01:37:59 INFO - PROCESS | 1649 | __metrics 01:37:59 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" 01:37:59 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:37:59 INFO - TEST-INFO | 1649: exit 0 01:37:59 INFO - Browser initialized. 01:37:59 INFO - Running cycle 1/1 for kraken test... 01:37:59 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/T/tmppN05VO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:11 INFO - PROCESS | 1650 | RSS: Main: 234987520 01:38:11 INFO - PROCESS | 1650 | 01:38:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 01:38:15 INFO - PROCESS | 1650 | RSS: Main: 286531584 01:38:15 INFO - PROCESS | 1650 | 01:38:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 01:38:18 INFO - PROCESS | 1650 | RSS: Main: 286003200 01:38:18 INFO - PROCESS | 1650 | 01:38:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 01:38:22 INFO - PROCESS | 1650 | RSS: Main: 378204160 01:38:22 INFO - PROCESS | 1650 | 01:38:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 01:38:25 INFO - PROCESS | 1650 | RSS: Main: 282222592 01:38:25 INFO - PROCESS | 1650 | 01:38:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:38:28 INFO - PROCESS | 1650 | RSS: Main: 285585408 01:38:28 INFO - PROCESS | 1650 | 01:38:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 01:38:31 INFO - PROCESS | 1650 | RSS: Main: 326868992 01:38:31 INFO - PROCESS | 1650 | 01:38:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 01:38:35 INFO - PROCESS | 1650 | RSS: Main: 330199040 01:38:35 INFO - PROCESS | 1650 | 01:38:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 01:38:38 INFO - PROCESS | 1650 | RSS: Main: 324767744 01:38:38 INFO - PROCESS | 1650 | 01:38:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:38:40 INFO - PROCESS | 1650 | RSS: Main: 303906816 01:38:40 INFO - PROCESS | 1650 | 01:38:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:38:43 INFO - PROCESS | 1650 | RSS: Main: 307990528 01:38:43 INFO - PROCESS | 1650 | 01:38:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:38:46 INFO - PROCESS | 1650 | RSS: Main: 309055488 01:38:46 INFO - PROCESS | 1650 | 01:38:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:38:50 INFO - PROCESS | 1650 | RSS: Main: 325877760 01:38:50 INFO - PROCESS | 1650 | 01:38:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:38:53 INFO - PROCESS | 1650 | RSS: Main: 319950848 01:38:53 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 01:38:55 INFO - PROCESS | 1650 | RSS: Main: 363864064 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | __start_tp_report 01:38:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 01:38:55 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 01:38:55 INFO - PROCESS | 1650 | |i|pagename|runs| 01:38:55 INFO - PROCESS | 1650 | |0;ai-astar;114;114;115;114;113;113;114;114;113;114 01:38:55 INFO - PROCESS | 1650 | |1;audio-beat-detection;140;103;130;170;140;136;110;108;127;112 01:38:55 INFO - PROCESS | 1650 | |2;audio-dft;183;184;182;183;182;184;181;184;183;181 01:38:55 INFO - PROCESS | 1650 | |3;audio-fft;77;58;59;87;62;59;61;58;73;67 01:38:55 INFO - PROCESS | 1650 | |4;audio-oscillator;111;94;115;100;70;69;84;89;99;113 01:38:55 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;119;129;94;85;90;84;87;84;86;84 01:38:55 INFO - PROCESS | 1650 | |6;imaging-darkroom;97;95;96;97;95;107;100;84;96;95 01:38:55 INFO - PROCESS | 1650 | |7;imaging-desaturate;86;86;87;88;87;87;86;98;119;87 01:38:55 INFO - PROCESS | 1650 | |8;json-parse-financial;56;56;54;50;54;56;56;55;55;55 01:38:55 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;63;78;76;74;73;67;60;68;76;102 01:38:55 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;99;106;111;78;101;107;108;87;88 01:38:55 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;145;145;155;138;154;150;141;142;183;151 01:38:55 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;154;211;158;209;227;172;171;170;177;171 01:38:55 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;68;68;65;66;67;68;67;73;84 01:38:55 INFO - PROCESS | 1650 | __end_tp_report 01:38:55 INFO - PROCESS | 1650 | __start_cc_report 01:38:55 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1988 01:38:55 INFO - PROCESS | 1650 | __end_cc_report 01:38:55 INFO - PROCESS | 1650 | __startTimestamp1484213935760__endTimestamp 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | ------- Summary: start ------- 01:38:55 INFO - PROCESS | 1650 | Number of tests: 14 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 01:38:55 INFO - PROCESS | 1650 | Values: 114.0 114.0 115.0 114.0 113.0 113.0 114.0 114.0 113.0 114.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:133.00 stddev:20.34 (15.3%) stddev-sans-first:21.08 01:38:55 INFO - PROCESS | 1650 | Values: 140.0 103.0 130.0 170.0 140.0 136.0 110.0 108.0 127.0 112.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.16 (0.6%) stddev-sans-first:1.22 01:38:55 INFO - PROCESS | 1650 | Values: 183.0 184.0 182.0 183.0 182.0 184.0 181.0 184.0 183.0 181.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.10 Median:64.50 stddev:9.88 (15.3%) stddev-sans-first:9.66 01:38:55 INFO - PROCESS | 1650 | Values: 77.0 58.0 59.0 87.0 62.0 59.0 61.0 58.0 73.0 67.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:77.00 stddev:16.59 (21.5%) stddev-sans-first:16.47 01:38:55 INFO - PROCESS | 1650 | Values: 111.0 94.0 115.0 100.0 70.0 69.0 84.0 89.0 99.0 113.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:85.50 stddev:16.19 (18.9%) stddev-sans-first:14.48 01:38:55 INFO - PROCESS | 1650 | Values: 119.0 129.0 94.0 85.0 90.0 84.0 87.0 84.0 86.0 84.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:95.50 stddev:5.63 (5.9%) stddev-sans-first:5.97 01:38:55 INFO - PROCESS | 1650 | Values: 97.0 95.0 96.0 97.0 95.0 107.0 100.0 84.0 96.0 95.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:87.00 stddev:10.44 (12.0%) stddev-sans-first:10.91 01:38:55 INFO - PROCESS | 1650 | Values: 86.0 86.0 87.0 88.0 87.0 87.0 86.0 98.0 119.0 87.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:1.83 (3.3%) stddev-sans-first:1.88 01:38:55 INFO - PROCESS | 1650 | Values: 56.0 56.0 54.0 50.0 54.0 56.0 56.0 55.0 55.0 55.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:73.50 stddev:11.60 (15.8%) stddev-sans-first:11.63 01:38:55 INFO - PROCESS | 1650 | Values: 63.0 78.0 76.0 74.0 73.0 67.0 60.0 68.0 76.0 102.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:97.20 Median:82.50 stddev:11.35 (13.8%) stddev-sans-first:11.42 01:38:55 INFO - PROCESS | 1650 | Values: 87.0 99.0 106.0 111.0 78.0 101.0 107.0 108.0 87.0 88.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:150.50 stddev:12.77 (8.5%) stddev-sans-first:13.40 01:38:55 INFO - PROCESS | 1650 | Values: 145.0 145.0 155.0 138.0 154.0 150.0 141.0 142.0 183.0 151.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:174.50 stddev:24.64 (14.1%) stddev-sans-first:23.97 01:38:55 INFO - PROCESS | 1650 | Values: 154.0 211.0 158.0 209.0 227.0 172.0 171.0 170.0 177.0 171.0 01:38:55 INFO - PROCESS | 1650 | 01:38:55 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.00 stddev:5.58 (8.2%) stddev-sans-first:5.85 01:38:55 INFO - PROCESS | 1650 | Values: 67.0 68.0 68.0 65.0 66.0 67.0 68.0 67.0 73.0 84.0 01:38:55 INFO - PROCESS | 1650 | -------- Summary: end -------- 01:38:55 INFO - PROCESS | 1650 | 01:38:56 INFO - TEST-INFO | 1650: exit 0 01:38:56 INFO - TEST-OK | kraken | took 59867ms 01:38:56 INFO - SUITE-END | took 1179s 01:38:56 INFO - Completed test suite (00:19:39) 01:38:56 INFO - javascript benchmark 01:38:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.0861513083905, 3326.218338690407, 3326.683965023322, 3343.9498407523874, 3378.1554611347165, 4555.0, 5463.0, 5558.86102847429, 5587.580931430139, 5604.019296623095, 5549.833504994846, 5585.720713964306, 5586.581006424514, 5666.5183459406, 5674.347450043247, 5079.060373830835, 5115.130427827278, 5129.6409251352425, 5164.328637277149, 5194.065068287726, 5076.974615126919, 5143.639945203838, 5216.973915130419, 5218.947810521884, 5236.31927849379, 5179.0, 5185.740712964355, 5202.0376230397305, 5210.687358758487, 5214.957008598258, 5058.747062646853, 5086.593072554187, 5110.948890511085, 5120.0, 5125.743712814345, 5095.949040509621, 5139.691618502902, 5145.3568303962, 5151.459096794858, 5177.249298851683, 5545.473180047889, 5596.27248457702, 5610.354809196954, 5633.352164501053, 5634.295713035871, 5046.62150338726, 6042.6978651067275, 6104.114903338991, 6156.56904016719, 6181.752729890799, 6102.011330178901, 6116.092308610896, 6165.167702360169, 6185.938140618626, 6186.319504854462, 5732.742026608813, 5739.626924249994, 5781.335146458127, 5793.275840519935, 5800.506956908668, 6098.939010609926, 6214.098955651405, 6227.439530442282, 6227.782027629011, 6229.999999999909, 5918.704064796829, 6084.939150608526, 6092.0, 6100.72546735398, 6102.0, 6101.156499726972, 6127.754889804447, 6139.124180917401, 6144.4945988232275, 6153.84615384619, 6001.219841420675, 6042.274927008787, 6059.21230240066, 6095.207623008981, 6109.175261339751, 6136.56222693796, 6148.6925653717135, 6189.071639254058, 6196.256449226032, 6208.875822483525, 4917.582005529499, 4918.1884988977135, 4919.139150648693, 4921.876953076202, 4955.72743499111, 4330.17726631939, 4340.414044104069, 4351.499577548622, 4368.366586844953, 4425.822967081345, 4841.733704646208, 5676.120201368794, 5763.423657634287, 5773.6824474654295, 5787.2476578045425, 6182.752689892444, 6192.721327540272, 6197.690115494297, 6207.689615519206, 6215.0, 5706.258186435737, 5727.341355744059, 5728.398518155617, 5728.51307638847, 5738.282714660668, 5238.030964271622, 5334.8933021340135, 5336.653117547425, 5341.599380046434, 5344.732763361816, 6222.253329600387, 6234.875302494015, 6242.968785156045, 6254.249490061222, 6262.436380725757, 6212.0371342441995, 6213.03697926822, 6222.346653601307, 6227.283862355887, 6242.219722534684, 6107.175531303395, 6145.955187618027, 6146.969265153645, 6228.750849965951, 6239.812805615838, 6044.879102417839, 6125.662799505599, 6129.908988904127, 6132.998044146438, 6137.7447333336595, 6192.133101365903, 6194.318624951342, 6210.596311239755, 6216.2540495140875, 6216.595921265103, 5886.117082437669, 5937.020391635332, 6011.234831977339, 6054.727537260922, 6065.363136870565, 5978.073398623221, 5996.370381110095, 6034.336223015377, 6053.485453736482, 6067.423594758491, 5874.530037596896, 5876.1773351731645, 5885.73514191871, 5886.05823068307, 5892.2929248488745, 5871.500922421471, 5917.260342457193, 5924.111383292368, 5929.080992446177, 6001.549883758823, 5802.738876750641, 5871.354151043467, 5915.822525324247, 5919.378465261258, 5930.347661757117], "value": 5623.405196810893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.95530446955286, 465.88653119045506, 467.4951052862908, 471.91505529004775, 509.80627361602586, 31437.685623143763, 40157.99210039497, 42624.57375426245, 42656.14687706244, 42672.35991460131, 43484.91287717801, 43863.0, 43898.78050609751, 43908.90227744308, 43933.56066439335, 9251.768705782342, 9461.574229159703, 9469.526523673789, 9473.242140628767, 9476.19452346548, 8368.246857782799, 8592.484450932932, 11160.386178760165, 11408.885911140866, 11435.256708313933, 11255.155863310243, 11276.943615281913, 11334.0, 11357.716057098556, 11364.31814091153, 8438.198371154793, 11321.773564528705, 11397.48711307985, 11398.373089480076, 11398.772024559505, 8461.450005749606, 8923.509206993613, 11093.33439993603, 11116.833247501294, 11296.887031129749, 41203.381949270784, 41597.79201103975, 41627.37558936619, 41702.791486042675, 41726.0, 4033.415154802537, 4061.4517040199785, 4068.0643452005907, 4097.282975479279, 4210.7473551587, 25286.0, 29655.73786883441, 30845.228869278224, 31113.533297000562, 31252.0, 3133.7649676274373, 3168.8574014169417, 3252.0569034979826, 3313.022658315803, 3314.8839790607453, 478465.6076719629, 478809.0, 480659.0, 480748.0, 483232.0, 62374.0, 62531.0, 63078.369216308165, 63821.0, 64384.0, 66734.0, 67022.99465508021, 68069.0, 68448.0, 68675.0, 15791.21043947798, 16240.918795405947, 16268.023918564924, 16282.83717162837, 16284.43004494837, 11215.327080375204, 11490.13823963206, 11931.880681193077, 12003.0, 12400.56598019065, 16781.496555103367, 17096.91451542759, 18263.908680456512, 18716.157772900253, 19150.80849191518, 6536.836579085466, 7494.063242094739, 7568.205338439385, 7594.886076708854, 7732.497387669783, 869.4261787220404, 873.3886279604176, 875.9781005474787, 879.1164879296266, 914.4604683236922, 30020.84989575082, 30058.24854378658, 30390.69609303923, 30450.0, 30963.0711078668, 1048.4076496779296, 1059.86751656043, 1080.2816127275273, 1094.441834664311, 1128.5260190719916, 13160.934195329153, 13971.441142354395, 15257.465988690343, 15773.68452630941, 16240.51278461648, 610634.0, 615357.0, 618294.0, 621768.8911555413, 622041.0, 45078.0, 55144.0, 55483.445165547826, 55526.72236638872, 55794.0, 1393.853645367242, 1432.0763107795622, 1448.7175000874938, 1451.4557041109795, 1453.4767483706069, 27535.173944781687, 28244.15267541977, 29082.56376154317, 29345.007610425946, 29593.556096659, 47867.76066119786, 48146.0, 48172.0, 48325.0, 48389.0, 540216.2989185029, 543343.0, 544733.0, 545187.0, 546388.0, 22517.43706407353, 25025.124120655688, 25387.0, 25488.107916223584, 25530.978760849357, 35520.82239588785, 40570.59429405668, 42485.362719558616, 43847.56152438435, 45032.87417814581, 30574.694253058075, 34297.48553771646, 35959.64040359563, 36862.078448039014, 37419.6258037427, 35595.82202088973, 36164.09589760172, 36896.26207475782, 37102.70140545068, 38748.41877371898, 33367.165820853705, 33506.497402538494, 35453.645463545035, 35945.0, 37103.6289637111, 24951.0, 31167.0, 31332.216694582818, 32272.677273226967, 32795.83602081974, 23604.0, 23690.28929132129, 23832.761672383054, 23937.922793473987, 24018.87990560036], "value": 19756.13892184587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.1110119062461, 392.71331927692785, 393.341153567774, 400.35742633073914, 422.41917363625015, 14558.344874480646, 15008.324625391842, 20689.68965465519, 21968.90155492223, 22204.8897555122, 21048.684269735968, 21589.028493717782, 21777.455563610918, 22186.112555497763, 22437.0, 4820.927686084711, 5807.680577568242, 6031.095335699636, 6053.757849686007, 6077.939220607782, 5938.88122237555, 5978.192943952576, 6049.5462840287155, 6052.394760523935, 6077.0, 5683.602147849652, 5834.0, 5998.97000514999, 6011.75952961881, 6013.248343957005, 5898.557608179382, 5952.0, 5960.0761881908375, 5971.223740913653, 5971.611845230046, 5079.568236699885, 5082.263071854597, 5219.42586315505, 5235.319408476912, 5268.236105764643, 21517.246896358552, 25954.22137335883, 25964.09125680592, 25983.480330393286, 26000.34999125018, 2470.7776300132896, 2638.7493188147287, 2647.377866201441, 2649.5628221343454, 2697.7302269772867, 10370.118709780621, 10640.0, 10661.253712240146, 14784.556463306119, 16064.196790160446, 1809.746635471035, 1827.1960337451478, 1852.351676913083, 1863.1243315641627, 1944.3292064237814, 133122.0, 135751.10364515355, 135983.0, 137020.0, 139916.0, 10411.958804119527, 11565.074794016627, 11766.88233117675, 11775.646730598095, 12002.63992080239, 12511.0, 14877.553673389815, 15648.217589120499, 15648.608784780245, 16248.0, 7817.765467035998, 7984.640691168911, 8740.300775937909, 8759.255463285564, 8907.688230911886, 7162.534435261691, 8267.214614611603, 8491.872621910676, 8665.696700615448, 8665.913340866511, 4068.7386910057976, 4671.299305104261, 4752.904941901212, 4761.190597598416, 4857.271409288635, 1957.2268953763185, 1996.5407956170163, 2011.9899400502904, 2013.2752209204675, 2014.3554062699795, 931.6552875436132, 986.4278718343344, 1016.3343010328247, 1016.9796604067877, 1051.1800795379615, 20987.8950605246, 21430.464238394165, 21503.354899353046, 21646.238166417537, 21757.67363489549, 912.5118061836886, 1023.5956797065118, 1027.1372047480152, 1072.3351522056375, 1083.8211695070383, 10653.414062226497, 10733.034026937614, 11386.829197562043, 11447.25592836463, 11464.94267528657, 334312.0, 672913.0, 692715.0, 732778.0, 745801.0, 137384.0, 139312.0, 141854.2907285457, 151961.0, 158218.0, 934.2806039349526, 973.9318247722591, 1008.4050410257836, 1016.1972042086817, 1034.281174583657, 13807.654808629864, 14459.770919471963, 18707.158177881756, 19257.42227733114, 19510.8048919509, 36937.81531092327, 42039.36940945827, 53145.734271329944, 55351.06271280486, 59511.10733338917, 88093.0, 88507.0, 90999.0, 91064.5446772762, 91186.63220051571, 7285.198628151005, 7420.925790742023, 7605.201453847267, 7924.20757924203, 8598.140185981352, 9436.197923176607, 13091.607251782461, 13341.866581334063, 13941.372638231102, 13979.09135906163, 10286.279960402999, 11479.885201147881, 11577.421128943688, 11901.047916166513, 11953.641390758292, 11333.546658133582, 11472.311661300015, 11713.355765432641, 11732.41337933117, 12006.63980080599, 10452.94773526158, 10491.213159012952, 10929.344239345664, 11014.284071535325, 11471.4264286787, 7531.096268447822, 7650.387968962581, 7680.577568233801, 7764.262395072459, 7919.960400197962, 8515.616797244014, 10825.945870270598, 11434.313941163557, 11513.827292590786, 11723.720841892818], "value": 9804.273695137714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.9669258268536, 1353.4383230959152, 1454.3818876977282, 1482.4589025005876, 1495.4167874528932, 7470.103587569492, 7856.332211762, 8136.349092072634, 8346.16538346165, 8365.707200247993, 8273.627686754095, 8366.581670916461, 8371.372147088961, 8377.455465394745, 8380.916190838105, 2057.218257062314, 2269.9773002270013, 2298.333483289844, 2317.9072837086496, 2319.0, 2125.2774056820676, 2258.503129311549, 2324.0936034946385, 2333.8949747261413, 2339.4034521197154, 2264.784845439689, 2296.2996286132725, 2301.148575027234, 2301.666258392532, 2301.8158547316175, 2248.347979086063, 2252.8648281103106, 2280.2589158523465, 2281.920132795344, 2282.2126366403563, 2226.6660000999977, 2272.9318120456246, 2299.9425014374606, 2305.4005958450757, 2307.653851922208, 7220.386267167297, 8353.95823020881, 8425.0, 8440.155984401572, 8447.662093516252, 4978.77595508203, 5133.666311689728, 5133.897322053575, 5142.331496905415, 5145.562627176694, 3000.9496676163385, 3280.0, 3453.723702103826, 3462.9134271643156, 3479.9652003480146, 1121.966341009771, 1233.2477188914754, 1233.5374234662002, 1270.333075135552, 1287.6652070461653, 10630.362178269328, 10745.623903163352, 10749.731256718645, 10761.192910531663, 10786.029257366796, 4361.6074553290355, 4584.7936842842155, 4618.284165954283, 4761.4524329701835, 4769.42766867978, 9299.39553929006, 9426.0, 9478.95260523693, 9512.953575106732, 9514.04859514043, 5102.540771330524, 5184.637075404761, 5197.480251974772, 5198.766055527511, 5203.7918483261, 4605.263157894788, 4705.411823522059, 4761.738104404221, 4765.475797662254, 4817.253325734517, 3725.4970578972034, 3762.793046382475, 3829.100161462054, 3869.903252418712, 3925.646691797752, 1225.07506832341, 1225.6946352134948, 1230.4831970572382, 1239.69007748063, 1242.6272118364454, 870.4690139015196, 903.7153296711515, 908.7909780750332, 940.9781611759666, 945.2674177512346, 5122.282880396748, 5622.228997865741, 5851.824445266649, 5855.092460668603, 6015.819525414157, 946.8059047895165, 956.4452617481844, 1006.0442579549457, 1013.381837079381, 1055.7044027672264, 3621.4386770050683, 3783.2055268393947, 3809.6190380961684, 3886.7473614214987, 3890.7665540067687, 9749.122578967927, 9910.80178396428, 10033.0, 10035.34770239932, 10056.64801731936, 9303.302252331103, 9971.601135954481, 9981.051800078982, 9985.900140998643, 10005.649802256887, 7544.245575442522, 7840.0, 7841.568713720686, 7846.215378462222, 7857.253560911704, 5754.712264386848, 5778.711064446845, 5801.332846722681, 5958.880822383615, 6088.178095956989, 9271.629134834531, 9276.907230927603, 9288.11762882525, 9291.535423228946, 9300.813983720423, 8410.915890841257, 9171.862422063808, 9216.907830921873, 9403.200727938201, 9479.620815167316, 5948.524118070457, 7250.456215783943, 7260.673269702982, 7334.816629584303, 7343.155537113087, 7901.328387087162, 7993.8401231976195, 8017.759467215993, 8064.637091331021, 8074.273315401642, 7060.258672839484, 7125.501214915113, 7135.714571417293, 7154.141503019463, 7167.641617918979, 7006.0, 7009.983552384773, 7090.4682148840075, 7181.892271615826, 7211.6033618151505, 6255.615677974541, 6395.744170233139, 6395.840103997437, 6396.6481843497195, 6421.261554921057, 4764.332993380999, 4871.756412179448, 4882.536159064884, 4912.803487860446, 5060.620453466078, 3838.654521093115, 4945.282933974481, 5048.444671086104, 5050.570701490415, 5175.249588809676], "value": 4420.75779649597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.16368778901267, 360.1841828258992, 370.1855916982637, 377.57899941565165, 378.98863034108984, 5410.837674869756, 5476.315460567429, 5485.0949593317055, 5496.972515137424, 5507.5593952483805, 4331.30699088146, 4440.37834703141, 5035.791410061586, 5245.816396426126, 5405.18922161676, 3544.4860495228177, 3788.4696142540065, 4120.567340429257, 4185.979070104645, 4211.642010429102, 3505.3690335739557, 3784.993953204806, 4137.813798379065, 4138.7997480730555, 4190.171634146938, 3821.235752849427, 3991.3015222335976, 4119.794010299488, 4145.336746120622, 4168.958310416887, 3379.307242015381, 4018.2164477926817, 4057.857974970862, 4060.3706425504092, 4081.2859448466734, 3092.6443459002276, 3351.6648335166533, 3481.704055155315, 3493.567637268733, 3503.544539209912, 5148.691078535262, 5160.354955630546, 5182.119039763249, 5183.481651834786, 5224.216367544861, 4360.106178233455, 4599.5400459953735, 4633.745144017078, 4637.373954516131, 4658.9068218635775, 4855.538723821267, 5335.7865685372535, 5486.725663716838, 5525.309336332958, 5641.746121424546, 3818.6754125899056, 3827.5215598050245, 3839.616038396166, 3883.8058097095313, 3883.9611603884164, 5494.395616482184, 5567.610267281292, 5909.911351329733, 5958.642481451084, 5995.970020149958, 3396.4735466002808, 3881.825317860703, 3917.9617401388655, 3918.333883239799, 3928.2143571285856, 3403.0981789825714, 3815.7138214634015, 3951.841926322915, 3960.940585891214, 3969.801509924492, 4051.6150965658217, 4209.2633789086785, 4236.644273832406, 4601.677882548256, 4662.580367766849, 5697.379205565487, 5702.6293290935955, 5705.885882282414, 5723.395854886016, 5728.48443640066, 1073.5974009746344, 1115.3252282369212, 1211.6970757310673, 1244.234795600699, 1293.9870601294056, 816.2327412232482, 822.6997146041651, 843.3927572148043, 855.4867079752099, 856.5631527920681, 4394.1764167870615, 4683.765811709401, 4891.021795640886, 4892.678976676278, 4912.287718280901, 4474.127545128734, 4562.58936695699, 4630.277117340362, 5036.859334782703, 5539.446055394428, 4270.1603433716855, 4409.824926053237, 4499.302608095751, 4983.0, 5003.824866129741, 2425.902963881425, 2505.937351566189, 2796.944061118807, 2893.5821447491, 2910.461564610554, 4758.881027974328, 5264.15773476242, 5358.732063396815, 5519.613627046068, 5654.964212883358, 4600.907981840344, 4834.307992202701, 4933.753312334369, 5286.60350473716, 5473.589480788957, 4744.833930812405, 4872.317875497433, 5286.54175808251, 5756.366799652119, 5781.4218578141845, 4606.0, 4831.347768051268, 5122.8975420492125, 5307.310049693515, 5492.450754924475, 4394.626456751212, 4609.847538115471, 4716.481187069488, 5327.547158491571, 5475.151351540518, 4855.5387238212315, 5286.427240437071, 5643.811246645632, 5702.942970570241, 5744.885102298014, 3047.9847600761855, 3398.5021009557463, 3668.559772827278, 3678.779273243614, 3680.7975561344383, 5026.592554084862, 5081.0, 5433.212184233185, 5456.45435456467, 5512.614117011771, 4444.355568442623, 4826.444958829639, 5333.679979201261, 5366.865828354323, 5372.737406709342, 4392.802323895497, 4636.863968327782, 5112.565431938327, 5142.948570514247, 5292.973535132453, 4302.9354559681005, 4876.829310974099, 5116.341815601862, 5163.230841485662, 5215.687058776485, 4936.901261974812, 5045.6720313180995, 5072.213806859942, 5227.7714737036, 5283.365996080495, 4777.945483442153, 4785.665003449725, 4967.863818558055, 4972.900541989212, 5337.146056630921], "value": 3939.686990783412, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.3864753606969, 763.503722580323, 776.7009701265015, 825.0841565861895, 825.9504429734217, 14594.48919287825, 15499.147546884917, 15499.922500387496, 15514.612134696637, 15529.0, 12249.387530623455, 14335.856641433582, 14490.0, 14509.637259068528, 14517.854821451783, 683.6342556732162, 839.7858546070773, 865.3423398217337, 867.6963062927956, 870.9172628600304, 867.8090820019618, 867.8481265778495, 871.263782104121, 872.2716531696042, 873.1225118755674, 928.336239588694, 930.2046750028729, 931.8322701913653, 931.9347645664806, 934.2666007184362, 724.080417869303, 745.8843879198732, 751.1399447632485, 924.0620769918538, 925.7222833150062, 559.7593034994951, 559.8180591307841, 666.0309250041179, 681.3595220492771, 687.88993760998, 15184.772228416583, 15212.847871521253, 15249.542513724606, 15253.923730381388, 15269.847301526954, 13734.793978090336, 13789.724205515833, 13847.0, 13895.930520347434, 13944.999999999898, 10649.680509584647, 12915.547955821596, 13016.284104374256, 13085.738285234338, 13154.0, 4371.125774845043, 4415.867523974286, 4558.202314594966, 4591.242444996572, 4673.556012178871, 105686.0, 110117.44941275242, 113974.43012784883, 114400.0, 114539.85460145376, 11073.833892491619, 11083.889161108447, 11198.664040078811, 11216.775664486664, 11554.422278886022, 19307.4207773767, 23251.396033614816, 23274.0, 23292.301230963098, 23329.76670233276, 6836.350546698155, 7732.6520306586335, 7818.491798033224, 7827.060752709597, 7890.092639346434, 4126.09225970286, 4237.343211802176, 4253.425787518645, 4256.212600668886, 4258.787060646955, 3225.419424503565, 3298.5711857458377, 3301.570795796579, 3313.519539666735, 3317.386283537505, 632.3486808587163, 637.3148864970176, 640.0527219714849, 646.1954866191528, 647.0488382078337, 640.5804198250154, 643.122028920586, 644.7421031587403, 647.9319671434525, 669.845935434843, 8846.867296990551, 9896.208303335716, 9937.45344006072, 9963.153131983863, 10154.796904061877, 629.169496264935, 653.5294587896707, 662.9403353698094, 664.8204984654213, 669.4344570032333, 4205.453291072202, 4624.0, 4836.540528649773, 4847.5394837490385, 4867.1969125093965, 92119.0, 112351.87648123414, 113130.0, 113224.43387783009, 115800.0, 98371.06515739433, 99207.03964801731, 101187.0, 103328.0, 103620.48189759154, 85208.57395712982, 86269.0, 86526.0, 87244.56377718071, 87339.0, 9399.577019034297, 9475.52622368865, 9477.620895164391, 9482.857757133786, 9505.382150160218, 56443.30670079904, 56535.0, 56666.083435399465, 56984.860302792884, 57638.423615763306, 76574.617126914, 77649.0, 77696.2230377689, 78720.61749502484, 79414.602926985, 11796.115291353011, 12886.0, 13096.279704615956, 13666.93166534161, 14126.293685315899, 12485.687857803627, 14921.626959326104, 14947.252637368305, 15235.619109522351, 15521.534353969399, 13742.93128534351, 14043.438262469386, 14124.646883827987, 14272.928635356757, 14866.331015104563, 14016.0, 14206.360713767699, 14425.927870360581, 14566.635834104232, 14649.63375915568, 13703.177809331472, 13771.793423098861, 13925.651858703613, 14161.787573186204, 14455.060421072596, 10475.580976760844, 11054.834177487182, 11221.102311815199, 11241.831372529583, 11392.772144557228, 10937.398443085389, 10994.28537145083, 11087.667369978913, 11180.832287515532, 11273.210875238654], "value": 7668.413024790984, "unit": "score"}], "name": "dromaeo_css", "value": 7252.231940730534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 103.0, 130.0, 170.0, 140.0, 136.0, 110.0, 108.0, 127.0, 112.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 183.0, 182.0, 184.0, 181.0, 184.0, 183.0, 181.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 58.0, 59.0, 87.0, 62.0, 59.0, 61.0, 58.0, 73.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 94.0, 115.0, 100.0, 70.0, 69.0, 84.0, 89.0, 99.0, 113.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 94.0, 85.0, 90.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 97.0, 95.0, 107.0, 100.0, 84.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 88.0, 87.0, 87.0, 86.0, 98.0, 119.0, 87.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 50.0, 54.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 78.0, 76.0, 74.0, 73.0, 67.0, 60.0, 68.0, 76.0, 102.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 99.0, 106.0, 111.0, 78.0, 101.0, 107.0, 108.0, 87.0, 88.0], "value": 97.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 155.0, 138.0, 154.0, 150.0, 141.0, 142.0, 183.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 211.0, 158.0, 209.0, 227.0, 172.0, 171.0, 170.0, 177.0, 171.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 65.0, 66.0, 67.0, 68.0, 67.0, 73.0, 84.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1493.4, "alertThreshold": 2.0}]} 01:38:56 INFO - Return code: 0 01:38:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:38:57 INFO - # TBPL SUCCESS # 01:38:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:57 INFO - 2017-01-12 01:38:57.039 screenresolution[1654:10766] starting screenresolution argv=screenresolution get 01:38:57 INFO - 2017-01-12 01:38:57.042 screenresolution[1654:10766] Display 0: 1600x1200x32@60 01:38:57 INFO - 2017-01-12 01:38:57.048 screenresolution[1655:10769] starting screenresolution argv=screenresolution list 01:38:57 INFO - Available Modes on Display 0 01:38:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:57 INFO - Intel Iris: 01:38:57 INFO - Chipset Model: Intel Iris 01:38:57 INFO - Type: GPU 01:38:57 INFO - Bus: Built-In 01:38:57 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:57 INFO - Vendor: Intel (0x8086) 01:38:57 INFO - Device ID: 0x0a2e 01:38:57 INFO - Revision ID: 0x0009 01:38:57 INFO - Displays: 01:38:57 INFO - Display: 01:38:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:57 INFO - Display Serial Number: 1600x1200 60 01:38:57 INFO - Main Display: Yes 01:38:57 INFO - Mirror: Off 01:38:57 INFO - Online: Yes 01:38:57 INFO - Rotation: Supported 01:38:57 INFO - Return code: 0 01:38:57 INFO - Running post-action listener: _resource_record_post_action 01:38:57 INFO - [mozharness: 2017-01-12 09:38:57.282734Z] Finished run-tests step (success) 01:38:57 INFO - Running post-run listener: _resource_record_post_run 01:38:57 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32463872; Write bytes: 554003456; Read time: 202; Write time: 1657 01:38:57 INFO - TinderboxPrint: CPU usage
53.8% 01:38:57 INFO - TinderboxPrint: I/O read bytes / time
32,463,872 / 202 01:38:57 INFO - TinderboxPrint: I/O write bytes / time
554,003,456 / 1,657 01:38:57 INFO - TinderboxPrint: CPU idle
2,222.2 (46.2%) 01:38:57 INFO - TinderboxPrint: CPU system
963.9 (20.0%) 01:38:57 INFO - TinderboxPrint: CPU user
1,623.6 (33.8%) 01:38:57 INFO - TinderboxPrint: Swap in / out
293,310,464 / 0 01:38:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251638272; Write bytes: 251379712; Read time: 18153; Write time: 539 01:38:57 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29051904; Write bytes: 296756736; Read time: 175; Write time: 1091 01:38:57 INFO - Running post-run listener: _upload_blobber_files 01:38:57 INFO - Blob upload gear active. 01:38:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:38:57 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 01:38:57 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'] 01:38:57 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 01:38:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:38:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:38:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:38:58 INFO - (blobuploader) - INFO - Done attempting. 01:38:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:38:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:38:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:39:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:00 INFO - (blobuploader) - INFO - Done attempting. 01:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:02 INFO - (blobuploader) - INFO - Done attempting. 01:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:04 INFO - (blobuploader) - INFO - Done attempting. 01:39:04 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:04 INFO - Return code: 0 01:39:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/69ee0642893d836a9a0c94df4053a6ab7c030653c7e15be982799dc9ecd24db2688561c445cf2fae4e51fe8ab10f8c0163d75b9aa913e30e90c9f52aaab2eb9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b66851664c5dab07289de54368a1797b3be5bfee9a4b317b9f3684269b016ffe8ee816d954df10fc6eb416e206890343555fe6637d3c2990a8241b5b535e956e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8d8441d2ba489bc117516887ff8ce0063301c166de8c8adeaf3ac30430b172fb2363832c0e4268e44f2d6c9ded840a1d781f990da503e24bb02bf4c4ec02cd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4767d744df8c1536cf224b2db5ae60ed47b338334dd973e3b4a4615945b00d5d9e8bd383180d3a717b685e53412170c725e17e9ee3b48f953b52bc5daaedd032"} 01:39:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:04 INFO - Contents: 01:39:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/69ee0642893d836a9a0c94df4053a6ab7c030653c7e15be982799dc9ecd24db2688561c445cf2fae4e51fe8ab10f8c0163d75b9aa913e30e90c9f52aaab2eb9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b66851664c5dab07289de54368a1797b3be5bfee9a4b317b9f3684269b016ffe8ee816d954df10fc6eb416e206890343555fe6637d3c2990a8241b5b535e956e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8d8441d2ba489bc117516887ff8ce0063301c166de8c8adeaf3ac30430b172fb2363832c0e4268e44f2d6c9ded840a1d781f990da503e24bb02bf4c4ec02cd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4767d744df8c1536cf224b2db5ae60ed47b338334dd973e3b4a4615945b00d5d9e8bd383180d3a717b685e53412170c725e17e9ee3b48f953b52bc5daaedd032"} 01:39:04 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:04 INFO - Copying logs to upload dir... 01:39:04 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.154901 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 01:39:04.702808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 01:39:04.709950) ========= 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.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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/69ee0642893d836a9a0c94df4053a6ab7c030653c7e15be982799dc9ecd24db2688561c445cf2fae4e51fe8ab10f8c0163d75b9aa913e30e90c9f52aaab2eb9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b66851664c5dab07289de54368a1797b3be5bfee9a4b317b9f3684269b016ffe8ee816d954df10fc6eb416e206890343555fe6637d3c2990a8241b5b535e956e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8d8441d2ba489bc117516887ff8ce0063301c166de8c8adeaf3ac30430b172fb2363832c0e4268e44f2d6c9ded840a1d781f990da503e24bb02bf4c4ec02cd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4767d744df8c1536cf224b2db5ae60ed47b338334dd973e3b4a4615945b00d5d9e8bd383180d3a717b685e53412170c725e17e9ee3b48f953b52bc5daaedd032"} build_url:https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010890 build_url: 'https://queue.taskcluster.net/v1/task/CKG8YsXUQ_amy_ZX3b6lSQ/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/69ee0642893d836a9a0c94df4053a6ab7c030653c7e15be982799dc9ecd24db2688561c445cf2fae4e51fe8ab10f8c0163d75b9aa913e30e90c9f52aaab2eb9c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b66851664c5dab07289de54368a1797b3be5bfee9a4b317b9f3684269b016ffe8ee816d954df10fc6eb416e206890343555fe6637d3c2990a8241b5b535e956e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d8d8441d2ba489bc117516887ff8ce0063301c166de8c8adeaf3ac30430b172fb2363832c0e4268e44f2d6c9ded840a1d781f990da503e24bb02bf4c4ec02cd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4767d744df8c1536cf224b2db5ae60ed47b338334dd973e3b4a4615945b00d5d9e8bd383180d3a717b685e53412170c725e17e9ee3b48f953b52bc5daaedd032"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 01:39:04.746651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:39:04.746974) ========= 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.V9DPtd6I85/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.6rUbfR8kDw/Listeners TMPDIR=/var/folders/s_/1z479xxn5mnd2jsf1r01_wr800000w/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.005188 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 01:39:04.795265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 01:39:04.798621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 01:39:04.798986) ========= ========= Total master_lag: 0.20 =========