builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1484915002.94 results: success (0) buildid: 20170120021724 builduid: f49a2f583c344a2d840e6ddbe0d0d339 revision: 585ed02acd43399decd146f7b83d10e93c765c13 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:22.942423) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:22.942886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:22.943206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:22.970217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:22.970544) ========= 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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-20 04:23:22-- 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.0M=0.001s 2017-01-20 04:23:23 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130735 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:23.128433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:23.129116) ========= 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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.024445 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:23.180127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 04:23:23.180862) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 585ed02acd43399decd146f7b83d10e93c765c13 --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 585ed02acd43399decd146f7b83d10e93c765c13 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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-20 04:23:23,261 truncating revision to first 12 chars 2017-01-20 04:23:23,261 Setting DEBUG logging. 2017-01-20 04:23:23,261 attempt 1/10 2017-01-20 04:23:23,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/585ed02acd43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 04:23:24,372 unpacking tar archive at: graphics-585ed02acd43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-20 04:23:24.596410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:24.596985) ========= script_repo_revision: 585ed02acd43399decd146f7b83d10e93c765c13 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:24.597424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:24.597704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 04:23:24.617535) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-20 04:23:24.617849) ========= /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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:23:24 INFO - MultiFileLogger online at 20170120 04:23:24 in /builds/slave/test 04:23:24 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 04:23:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:24 INFO - {'append_to_log': False, 04:23:24 INFO - 'base_work_dir': '/builds/slave/test', 04:23:24 INFO - 'blob_upload_branch': 'Graphics', 04:23:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:24 INFO - 'branch': 'Graphics', 04:23:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:24 INFO - 'config_files': ('talos/mac_config.py',), 04:23:24 INFO - 'default_actions': ('clobber', 04:23:24 INFO - 'read-buildbot-config', 04:23:24 INFO - 'download-and-extract', 04:23:24 INFO - 'populate-webroot', 04:23:24 INFO - 'create-virtualenv', 04:23:24 INFO - 'install', 04:23:24 INFO - 'run-tests'), 04:23:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:24 INFO - 'download_minidump_stackwalk': True, 04:23:24 INFO - 'download_symbols': 'ondemand', 04:23:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:24 INFO - 'installer_path': 'installer.exe', 04:23:24 INFO - 'log_level': 'info', 04:23:24 INFO - 'log_name': 'talos', 04:23:24 INFO - 'log_to_console': True, 04:23:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:23:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:23:24 INFO - 'opt_config_files': (), 04:23:24 INFO - 'pip_index': False, 04:23:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:24 INFO - 'cmd': ('bash', 04:23:24 INFO - '-c', 04:23:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:24 INFO - 'enabled': True, 04:23:24 INFO - 'halt_on_failure': False, 04:23:24 INFO - 'name': 'check_screen_resolution'},), 04:23:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:24 INFO - 'cmd': ('bash', 04:23:24 INFO - '-c', 04:23:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:24 INFO - 'enabled': True, 04:23:24 INFO - 'halt_on_failure': False, 04:23:24 INFO - 'name': 'check_screen_resolution'},), 04:23:24 INFO - 'run_cmd_checks_enabled': True, 04:23:24 INFO - 'sps_profile': False, 04:23:24 INFO - 'sps_profile_interval': 0, 04:23:24 INFO - 'suite': 'dromaeojs', 04:23:24 INFO - 'system_bits': '32', 04:23:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:24 INFO - 'title': 't-yosemite-r7-0263', 04:23:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:24 INFO - 'use_talos_json': True, 04:23:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:24 INFO - 'work_dir': 'build'} 04:23:24 INFO - [mozharness: 2017-01-20 12:23:24.806904Z] Running clobber step. 04:23:24 INFO - Running pre-action listener: _resource_record_pre_action 04:23:24 INFO - Running main action method: clobber 04:23:24 INFO - rmtree: /builds/slave/test/build 04:23:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:27 INFO - Running post-action listener: _resource_record_post_action 04:23:27 INFO - [mozharness: 2017-01-20 12:23:27.217578Z] Finished clobber step (success) 04:23:27 INFO - [mozharness: 2017-01-20 12:23:27.217702Z] Running read-buildbot-config step. 04:23:27 INFO - Running pre-action listener: _resource_record_pre_action 04:23:27 INFO - Running main action method: read_buildbot_config 04:23:27 INFO - Using buildbot properties: 04:23:27 INFO - { 04:23:27 INFO - "project": "", 04:23:27 INFO - "product": "firefox", 04:23:27 INFO - "script_repo_revision": "default", 04:23:27 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 04:23:27 INFO - "repository": "", 04:23:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 04:23:27 INFO - "buildid": "20170120021724", 04:23:27 INFO - "pgo_build": "False", 04:23:27 INFO - "basedir": "/builds/slave/test", 04:23:27 INFO - "buildnumber": 11, 04:23:27 INFO - "slavename": "t-yosemite-r7-0263", 04:23:27 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:23:27 INFO - "platform": "yosemite_r7", 04:23:27 INFO - "scheduler": "tests-graphics-macosx64-talos", 04:23:27 INFO - "branch": "graphics", 04:23:27 INFO - "repo_path": "projects/graphics", 04:23:27 INFO - "revision": "585ed02acd43399decd146f7b83d10e93c765c13", 04:23:27 INFO - "stage_platform": "macosx64", 04:23:27 INFO - "builduid": "f49a2f583c344a2d840e6ddbe0d0d339", 04:23:27 INFO - "slavebuilddir": "test" 04:23:27 INFO - } 04:23:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:23:27 INFO - Running post-action listener: _resource_record_post_action 04:23:27 INFO - [mozharness: 2017-01-20 12:23:27.221217Z] Finished read-buildbot-config step (success) 04:23:27 INFO - [mozharness: 2017-01-20 12:23:27.221319Z] Running download-and-extract step. 04:23:27 INFO - Running pre-action listener: _resource_record_pre_action 04:23:27 INFO - Running main action method: download_and_extract 04:23:27 INFO - mkdir: /builds/slave/test/build/tests 04:23:27 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')]} 04:23:27 INFO - trying https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:23:27 INFO - Downloading https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/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 04:23:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/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 04:23:28 INFO - Downloaded 1199 bytes. 04:23:28 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:23:28 INFO - Using the following test package requirements: 04:23:28 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:23:28 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:23:28 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:23:28 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'jsshell-mac.zip'], 04:23:28 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:23:28 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:23:28 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:23:28 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:23:28 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:23:28 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:23:28 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:23:28 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:23:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:23:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:23:28 INFO - Fetch https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:23:29 INFO - Expected file size: 16340635 04:23:29 INFO - Obtained file size: 16340635 04:23:35 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 04:23:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:23:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:23:35 INFO - Fetch https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:23:36 INFO - Expected file size: 16340635 04:23:36 INFO - Obtained file size: 16340635 04:23:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:23:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:23:42 INFO - Fetch https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:23:44 INFO - Expected file size: 14403463 04:23:44 INFO - Obtained file size: 14403463 04:23:45 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')]} 04:23:45 INFO - trying https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:23:45 INFO - Downloading https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/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 04:23:47 INFO - Downloaded 69937799 bytes. 04:23:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:23:47 INFO - mkdir: /builds/slave/test/properties 04:23:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:47 INFO - Contents: 04:23:47 INFO - build_url:https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:23:47 INFO - Running post-action listener: _resource_record_post_action 04:23:47 INFO - Running post-action listener: set_extra_try_arguments 04:23:47 INFO - [mozharness: 2017-01-20 12:23:47.696706Z] Finished download-and-extract step (success) 04:23:47 INFO - [mozharness: 2017-01-20 12:23:47.696847Z] Running populate-webroot step. 04:23:47 INFO - Running pre-action listener: _resource_record_pre_action 04:23:47 INFO - Running main action method: populate_webroot 04:23:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:47 INFO - '--tppagecycles', 04:23:47 INFO - '7'], 04:23:47 INFO - 'tests': ['tsvgm']}}, 04:23:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['damp', 'tps']}, 04:23:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'tests': ['damp', 'tps']}, 04:23:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['dromaeo_dom']}, 04:23:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['basic_compositor_video']}, 04:23:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['a11yr', 04:23:47 INFO - 'ts_paint', 04:23:47 INFO - 'tpaint', 04:23:47 INFO - 'sessionrestore', 04:23:47 INFO - 'sessionrestore_no_auto_restore', 04:23:47 INFO - 'tabpaint']}, 04:23:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tsvgx', 04:23:47 INFO - 'tsvgr_opacity', 04:23:47 INFO - 'tart', 04:23:47 INFO - 'tscrollx', 04:23:47 INFO - 'cart', 04:23:47 INFO - 'tsvg_static']}, 04:23:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:47 INFO - 'tsvgr_opacity', 04:23:47 INFO - 'tart', 04:23:47 INFO - 'tscrollx', 04:23:47 INFO - 'cart', 04:23:47 INFO - 'tsvg_static']}, 04:23:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s'], 04:23:47 INFO - 'tests': ['tp5o']}, 04:23:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:23:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--disable-e10s', 04:23:47 INFO - '--xperf_path', 04:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:47 INFO - 'tests': ['tp5n']}, 04:23:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:23:47 INFO - 'talos_options': ['--xperf_path', 04:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:47 INFO - 'tests': ['tp5n']}}, 04:23:47 INFO - 'talos.zip': {'path': '', 04:23:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:47 INFO - Running post-action listener: _resource_record_post_action 04:23:47 INFO - [mozharness: 2017-01-20 12:23:47.715119Z] Finished populate-webroot step (success) 04:23:47 INFO - [mozharness: 2017-01-20 12:23:47.715228Z] Running create-virtualenv step. 04:23:47 INFO - Running pre-action listener: _resource_record_pre_action 04:23:47 INFO - Running main action method: create_virtualenv 04:23:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:47 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 04:23:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:47 INFO - Using real prefix '/tools/python27' 04:23:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:51 INFO - Installing pip.................done. 04:23:51 INFO - Return code: 0 04:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:23:51 INFO - Reading from file tmpfile_stdout 04:23:51 INFO - Output received: 04:23:51 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) 04:23:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:51 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')]} 04:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:51 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')]} 04:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:51 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:23:51 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 04:23:51 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 04:23:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:23:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:51 INFO - 'HOME': '/Users/cltbld', 04:23:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:51 INFO - 'LOGNAME': 'cltbld', 04:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:51 INFO - 'MOZ_NO_REMOTE': '1', 04:23:51 INFO - 'NO_EM_RESTART': '1', 04:23:51 INFO - 'PAGER': '/bin/cat', 04:23:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:51 INFO - 'PWD': '/builds/slave/test', 04:23:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:51 INFO - 'SHELL': '/bin/bash', 04:23:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:23:51 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:23:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:51 INFO - 'USER': 'cltbld', 04:23:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:51 INFO - 'XPC_FLAGS': '0x0', 04:23:51 INFO - 'XPC_SERVICE_NAME': '0', 04:23:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:52 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 04:23:52 INFO - Cleaning up... 04:23:52 INFO - Return code: 0 04:23:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:52 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:23:52 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 04:23:52 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 04:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:52 INFO - 'HOME': '/Users/cltbld', 04:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:52 INFO - 'LOGNAME': 'cltbld', 04:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:52 INFO - 'MOZ_NO_REMOTE': '1', 04:23:52 INFO - 'NO_EM_RESTART': '1', 04:23:52 INFO - 'PAGER': '/bin/cat', 04:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:52 INFO - 'PWD': '/builds/slave/test', 04:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:52 INFO - 'SHELL': '/bin/bash', 04:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:23:52 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:52 INFO - 'USER': 'cltbld', 04:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:52 INFO - 'XPC_FLAGS': '0x0', 04:23:52 INFO - 'XPC_SERVICE_NAME': '0', 04:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:52 INFO - Downloading/unpacking psutil>=3.1.1 04:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:55 INFO - Installing collected packages: psutil 04:23:55 INFO - Running setup.py install for psutil 04:23:55 INFO - building 'psutil._psutil_osx' extension 04:23:55 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 04:23:56 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 04:23:56 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 04:23:56 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 04:23:56 INFO - building 'psutil._psutil_posix' extension 04:23:56 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 04:23:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:23:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:23:56 INFO - ^ 04:23:56 INFO - 1 warning generated. 04:23:56 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 04:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:57 INFO - Successfully installed psutil 04:23:57 INFO - Cleaning up... 04:23:57 INFO - Return code: 0 04:23:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:57 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')]} 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 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')]} 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:57 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:23:57 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 04:23:57 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 04:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:23:57 INFO - 'HOME': '/Users/cltbld', 04:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:23:57 INFO - 'LOGNAME': 'cltbld', 04:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:57 INFO - 'MOZ_NO_REMOTE': '1', 04:23:57 INFO - 'NO_EM_RESTART': '1', 04:23:57 INFO - 'PAGER': '/bin/cat', 04:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:57 INFO - 'PWD': '/builds/slave/test', 04:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:23:57 INFO - 'SHELL': '/bin/bash', 04:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:23:57 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:23:57 INFO - 'USER': 'cltbld', 04:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:57 INFO - 'XPC_FLAGS': '0x0', 04:23:57 INFO - 'XPC_SERVICE_NAME': '0', 04:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:24:00 INFO - Installing collected packages: mozsystemmonitor 04:24:00 INFO - Running setup.py install for mozsystemmonitor 04:24:00 INFO - Successfully installed mozsystemmonitor 04:24:00 INFO - Cleaning up... 04:24:00 INFO - Return code: 0 04:24:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:24:00 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')]} 04:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:00 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')]} 04:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:00 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:00 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 04:24:00 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 04:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:00 INFO - 'HOME': '/Users/cltbld', 04:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:00 INFO - 'LOGNAME': 'cltbld', 04:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:00 INFO - 'MOZ_NO_REMOTE': '1', 04:24:00 INFO - 'NO_EM_RESTART': '1', 04:24:00 INFO - 'PAGER': '/bin/cat', 04:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:00 INFO - 'PWD': '/builds/slave/test', 04:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:00 INFO - 'SHELL': '/bin/bash', 04:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:00 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:00 INFO - 'USER': 'cltbld', 04:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:00 INFO - 'XPC_FLAGS': '0x0', 04:24:00 INFO - 'XPC_SERVICE_NAME': '0', 04:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:00 INFO - Downloading/unpacking jsonschema==2.5.1 04:24:00 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 04:24:00 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 04:24:00 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 04:24:00 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 04:24:00 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 04:24:00 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 04:24:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:03 INFO - warning: no files found matching '*.txt' 04:24:03 INFO - no previously-included directories found matching 'build' 04:24:03 INFO - no previously-included directories found matching 'dist' 04:24:03 INFO - no previously-included directories found matching '.git*' 04:24:03 INFO - Installing collected packages: jsonschema, functools32 04:24:03 INFO - Running setup.py install for functools32 04:24:03 INFO - warning: no files found matching '*.txt' 04:24:03 INFO - no previously-included directories found matching 'build' 04:24:03 INFO - no previously-included directories found matching 'dist' 04:24:03 INFO - no previously-included directories found matching '.git*' 04:24:03 INFO - Successfully installed jsonschema functools32 04:24:03 INFO - Cleaning up... 04:24:04 INFO - Return code: 0 04:24:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:04 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 04:24:04 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 04:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:04 INFO - 'HOME': '/Users/cltbld', 04:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:04 INFO - 'LOGNAME': 'cltbld', 04:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:04 INFO - 'MOZ_NO_REMOTE': '1', 04:24:04 INFO - 'NO_EM_RESTART': '1', 04:24:04 INFO - 'PAGER': '/bin/cat', 04:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:04 INFO - 'PWD': '/builds/slave/test', 04:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:04 INFO - 'SHELL': '/bin/bash', 04:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:04 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:04 INFO - 'USER': 'cltbld', 04:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:04 INFO - 'XPC_FLAGS': '0x0', 04:24:04 INFO - 'XPC_SERVICE_NAME': '0', 04:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:24:04 INFO - Cleaning up... 04:24:04 INFO - Return code: 0 04:24:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:04 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:04 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 04:24:04 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 04:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:04 INFO - 'HOME': '/Users/cltbld', 04:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:04 INFO - 'LOGNAME': 'cltbld', 04:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:04 INFO - 'MOZ_NO_REMOTE': '1', 04:24:04 INFO - 'NO_EM_RESTART': '1', 04:24:04 INFO - 'PAGER': '/bin/cat', 04:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:04 INFO - 'PWD': '/builds/slave/test', 04:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:04 INFO - 'SHELL': '/bin/bash', 04:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:04 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:04 INFO - 'USER': 'cltbld', 04:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:04 INFO - 'XPC_FLAGS': '0x0', 04:24:04 INFO - 'XPC_SERVICE_NAME': '0', 04:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:07 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:07 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 04:24:08 INFO - Downloading docopt-0.6.1.tar.gz 04:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:08 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:08 INFO - Running setup.py install for blobuploader 04:24:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:08 INFO - Running setup.py install for requests 04:24:09 INFO - Running setup.py install for docopt 04:24:09 INFO - Successfully installed blobuploader requests docopt 04:24:09 INFO - Cleaning up... 04:24:09 INFO - Return code: 0 04:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:09 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:09 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 04:24:09 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 04:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:09 INFO - 'HOME': '/Users/cltbld', 04:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:09 INFO - 'LOGNAME': 'cltbld', 04:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:09 INFO - 'MOZ_NO_REMOTE': '1', 04:24:09 INFO - 'NO_EM_RESTART': '1', 04:24:09 INFO - 'PAGER': '/bin/cat', 04:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:09 INFO - 'PWD': '/builds/slave/test', 04:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:09 INFO - 'SHELL': '/bin/bash', 04:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:09 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:09 INFO - 'USER': 'cltbld', 04:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:09 INFO - 'XPC_FLAGS': '0x0', 04:24:09 INFO - 'XPC_SERVICE_NAME': '0', 04:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:09 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Er3mJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:09 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GrjWOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:09 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4ZONrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-947pKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7HY5rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-UKCXCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4WZ7i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-fEetMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-i2ROt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-wjt1zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-LILCL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-nej4LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:10 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-HTP1Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-aQXyhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-kln3dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-qFovuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:11 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-b0AVHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:11 INFO - Running setup.py install for manifestparser 04:24:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:11 INFO - Running setup.py install for mozcrash 04:24:11 INFO - Running setup.py install for mozdebug 04:24:11 INFO - Running setup.py install for mozdevice 04:24:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Running setup.py install for mozfile 04:24:12 INFO - Running setup.py install for mozhttpd 04:24:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Running setup.py install for mozinfo 04:24:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Running setup.py install for mozInstall 04:24:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Running setup.py install for mozleak 04:24:12 INFO - Running setup.py install for mozlog 04:24:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:12 INFO - Running setup.py install for moznetwork 04:24:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Running setup.py install for mozprocess 04:24:13 INFO - Running setup.py install for mozprofile 04:24:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Running setup.py install for mozrunner 04:24:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:13 INFO - Running setup.py install for mozscreenshot 04:24:13 INFO - Running setup.py install for moztest 04:24:13 INFO - Running setup.py install for mozversion 04:24:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:14 INFO - Cleaning up... 04:24:14 INFO - Return code: 0 04:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:14 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:14 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 04:24:14 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 04:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:14 INFO - 'HOME': '/Users/cltbld', 04:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:14 INFO - 'LOGNAME': 'cltbld', 04:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:14 INFO - 'MOZ_NO_REMOTE': '1', 04:24:14 INFO - 'NO_EM_RESTART': '1', 04:24:14 INFO - 'PAGER': '/bin/cat', 04:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:14 INFO - 'PWD': '/builds/slave/test', 04:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:14 INFO - 'SHELL': '/bin/bash', 04:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:14 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:14 INFO - 'USER': 'cltbld', 04:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:14 INFO - 'XPC_FLAGS': '0x0', 04:24:14 INFO - 'XPC_SERVICE_NAME': '0', 04:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-oNmXW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-5_Rot6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-UmudmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NUtAJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-eXDa6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-BKo6h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:14 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)) 04:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:14 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-t4uN6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-fPnlVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-9UJyky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-QK5E6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mP6s3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-rs1OFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ivYPd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-avleD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-JqDC9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:15 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)) 04:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:15 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-NzGpRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:16 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)) 04:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:16 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-P7nPzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:16 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)) 04:24:16 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)) 04:24:16 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)) 04:24:16 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)) 04:24:16 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)) 04:24:16 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)) 04:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:16 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 04:24:16 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 04:24:16 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 04:24:16 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 04:24:16 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 04:24:16 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 04:24:18 INFO - Downloading blessings-1.6.tar.gz 04:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:18 INFO - Installing collected packages: blessings 04:24:18 INFO - Running setup.py install for blessings 04:24:18 INFO - Successfully installed blessings 04:24:18 INFO - Cleaning up... 04:24:19 INFO - Return code: 0 04:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:19 INFO - Reading from file tmpfile_stdout 04:24:19 INFO - Current package versions: 04:24:19 INFO - blessings == 1.6 04:24:19 INFO - blobuploader == 1.2.4 04:24:19 INFO - docopt == 0.6.1 04:24:19 INFO - functools32 == 3.2.3-2 04:24:19 INFO - jsonschema == 2.5.1 04:24:19 INFO - manifestparser == 1.1 04:24:19 INFO - mozInstall == 1.12 04:24:19 INFO - mozcrash == 1.0 04:24:19 INFO - mozdebug == 0.1 04:24:19 INFO - mozdevice == 0.49 04:24:19 INFO - mozfile == 1.2 04:24:19 INFO - mozhttpd == 0.7 04:24:19 INFO - mozinfo == 0.9 04:24:19 INFO - mozleak == 0.1 04:24:19 INFO - mozlog == 3.4 04:24:19 INFO - moznetwork == 0.27 04:24:19 INFO - mozprocess == 0.24 04:24:19 INFO - mozprofile == 0.28 04:24:19 INFO - mozrunner == 6.13 04:24:19 INFO - mozscreenshot == 0.1 04:24:19 INFO - mozsystemmonitor == 0.3 04:24:19 INFO - moztest == 0.8 04:24:19 INFO - mozversion == 1.4 04:24:19 INFO - psutil == 3.1.1 04:24:19 INFO - requests == 1.2.3 04:24:19 INFO - wsgiref == 0.1.2 04:24:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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')]} 04:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:20 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 04:24:20 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 04:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:20 INFO - 'HOME': '/Users/cltbld', 04:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:20 INFO - 'LOGNAME': 'cltbld', 04:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:20 INFO - 'MOZ_NO_REMOTE': '1', 04:24:20 INFO - 'NO_EM_RESTART': '1', 04:24:20 INFO - 'PAGER': '/bin/cat', 04:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:20 INFO - 'PWD': '/builds/slave/test', 04:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:20 INFO - 'SHELL': '/bin/bash', 04:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:20 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:20 INFO - 'USER': 'cltbld', 04:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:20 INFO - 'XPC_FLAGS': '0x0', 04:24:20 INFO - 'XPC_SERVICE_NAME': '0', 04:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 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)) 04:24:20 INFO - Cleaning up... 04:24:20 INFO - Return code: 0 04:24:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:21 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 0x107249b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10724c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd17a568b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, '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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:24:21 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 04:24:21 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 04:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:21 INFO - 'HOME': '/Users/cltbld', 04:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:21 INFO - 'LOGNAME': 'cltbld', 04:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:21 INFO - 'MOZ_NO_REMOTE': '1', 04:24:21 INFO - 'NO_EM_RESTART': '1', 04:24:21 INFO - 'PAGER': '/bin/cat', 04:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:21 INFO - 'PWD': '/builds/slave/test', 04:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:21 INFO - 'SHELL': '/bin/bash', 04:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:21 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:21 INFO - 'USER': 'cltbld', 04:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:21 INFO - 'XPC_FLAGS': '0x0', 04:24:21 INFO - 'XPC_SERVICE_NAME': '0', 04:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:24:21 INFO - Cleaning up... 04:24:21 INFO - Return code: 0 04:24:21 INFO - Running post-action listener: _resource_record_post_action 04:24:21 INFO - Running post-action listener: _start_resource_monitoring 04:24:21 INFO - Starting resource monitoring. 04:24:21 INFO - [mozharness: 2017-01-20 12:24:21.423462Z] Finished create-virtualenv step (success) 04:24:21 INFO - [mozharness: 2017-01-20 12:24:21.424428Z] Running install step. 04:24:21 INFO - Running pre-action listener: _resource_record_pre_action 04:24:21 INFO - Running main action method: install 04:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:21 INFO - Reading from file tmpfile_stdout 04:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:21 INFO - Reading from file tmpfile_stdout 04:24:21 INFO - Output received: 04:24:21 INFO - Usage: mozinstall [options] installer 04:24:21 INFO - Options: 04:24:21 INFO - -h, --help show this help message and exit 04:24:21 INFO - -d DEST, --destination=DEST 04:24:21 INFO - Directory to install application into. [default: 04:24:21 INFO - "/builds/slave/test"] 04:24:21 INFO - --app=APP Application being installed. [default: firefox] 04:24:21 INFO - mkdir: /builds/slave/test/build/application 04:24:21 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'] 04:24:21 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 04:24:43 INFO - Reading from file tmpfile_stdout 04:24:43 INFO - Output received: 04:24:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:24:43 INFO - Running post-action listener: _resource_record_post_action 04:24:43 INFO - [mozharness: 2017-01-20 12:24:43.395198Z] Finished install step (success) 04:24:43 INFO - [mozharness: 2017-01-20 12:24:43.395299Z] Running run-tests step. 04:24:43 INFO - Running pre-action listener: _resource_record_pre_action 04:24:43 INFO - Running main action method: run_tests 04:24:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:24:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:24:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:24:43 INFO - 2017-01-20 04:24:43.408 screenresolution[1623:7263] starting screenresolution argv=screenresolution get 04:24:43 INFO - 2017-01-20 04:24:43.410 screenresolution[1623:7263] Display 0: 1600x1200x32@60 04:24:43 INFO - 2017-01-20 04:24:43.416 screenresolution[1624:7266] starting screenresolution argv=screenresolution list 04:24:43 INFO - Available Modes on Display 0 04:24:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:24:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:24:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:24:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:24:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:24:43 INFO - Intel Iris: 04:24:43 INFO - Chipset Model: Intel Iris 04:24:43 INFO - Type: GPU 04:24:43 INFO - Bus: Built-In 04:24:43 INFO - VRAM (Dynamic, Max): 1536 MB 04:24:43 INFO - Vendor: Intel (0x8086) 04:24:43 INFO - Device ID: 0x0a2e 04:24:43 INFO - Revision ID: 0x0009 04:24:43 INFO - Displays: 04:24:43 INFO - Display: 04:24:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:24:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:24:43 INFO - Display Serial Number: 1600x1200 60 04:24:43 INFO - Main Display: Yes 04:24:43 INFO - Mirror: Off 04:24:43 INFO - Online: Yes 04:24:43 INFO - Rotation: Supported 04:24:43 INFO - Return code: 0 04:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:43 INFO - Python 2.7.3 04:24:43 INFO - Return code: 0 04:24:43 INFO - grabbing minidump binary from tooltool 04:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107027d30>, '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 0x106f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10701cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:24:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:24:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:24:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:43 INFO - Return code: 0 04:24:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:24:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:24:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 04:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vOS7ACb0wR/Render', 04:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:43 INFO - 'HOME': '/Users/cltbld', 04:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:43 INFO - 'LOGNAME': 'cltbld', 04:24:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:43 INFO - 'MOZ_NO_REMOTE': '1', 04:24:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:43 INFO - 'NO_EM_RESTART': '1', 04:24:43 INFO - 'PAGER': '/bin/cat', 04:24:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:43 INFO - 'PWD': '/builds/slave/test', 04:24:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:43 INFO - 'SHELL': '/bin/bash', 04:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YW7zNiguOJ/Listeners', 04:24:43 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:43 INFO - 'USER': 'cltbld', 04:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:43 INFO - 'XPC_FLAGS': '0x0', 04:24:43 INFO - 'XPC_SERVICE_NAME': '0', 04:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:24:44 INFO - mozversion application_buildid: 20170120021724 04:24:44 INFO - mozversion application_changeset: 585ed02acd43399decd146f7b83d10e93c765c13 04:24:44 INFO - mozversion application_display_name: Nightly 04:24:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:44 INFO - mozversion application_name: Firefox 04:24:44 INFO - mozversion application_remotingname: firefox 04:24:44 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 04:24:44 INFO - mozversion application_vendor: Mozilla 04:24:44 INFO - mozversion application_version: 53.0a1 04:24:44 INFO - mozversion platform_buildid: 20170120021724 04:24:44 INFO - mozversion platform_changeset: 585ed02acd43399decd146f7b83d10e93c765c13 04:24:44 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 04:24:44 INFO - mozversion platform_version: 53.0a1 04:24:44 INFO - using testdate: 1484915084 04:24:44 INFO - actual date: 1484915084 04:24:44 INFO - starting webserver on 'localhost:49244' 04:24:44 INFO - SUITE-START | Running 2 tests 04:24:44 INFO - TEST-START | dromaeo_css 04:24:44 INFO - operating with platform_type : mac_ 04:24:44 INFO - Initialising browser for dromaeo_css test... 04:24:44 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpwUUgKo/profile http://localhost:49244/getInfo.html) 04:24:46 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 04:24:46 INFO - PROCESS | 1634 | colorDepth:24 04:24:46 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 04:24:46 INFO - PROCESS | 1634 | __metrics 04:24:46 INFO - PROCESS | 1634 | 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" 04:24:46 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:47 INFO - TEST-INFO | 1634: exit 0 04:24:47 INFO - Browser initialized. 04:24:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:47 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpwUUgKo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:59 INFO - PROCESS | 1636 | RSS: Main: 235278336 04:24:59 INFO - PROCESS | 1636 | 04:28:03 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 04:28:05 INFO - PROCESS | 1636 | RSS: Main: 396644352 04:28:05 INFO - PROCESS | 1636 | 04:29:49 INFO - PROCESS | 1636 | ************************* 04:29:49 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 04:29:49 INFO - PROCESS | 1636 | 04:29:49 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:29:49 INFO - PROCESS | 1636 | Full stack: 04:29:49 INFO - PROCESS | 1636 | ************************* 04:31:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 04:31:09 INFO - PROCESS | 1636 | RSS: Main: 385269760 04:31:09 INFO - PROCESS | 1636 | 04:34:11 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 04:34:12 INFO - PROCESS | 1636 | RSS: Main: 359006208 04:34:12 INFO - PROCESS | 1636 | 04:37:14 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 04:37:15 INFO - PROCESS | 1636 | RSS: Main: 340529152 04:37:15 INFO - PROCESS | 1636 | 04:40:18 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 04:40:19 INFO - PROCESS | 1636 | RSS: Main: 328986624 04:40:19 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 04:43:22 INFO - PROCESS | 1636 | RSS: Main: 404250624 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | __start_tp_report 04:43:22 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 04:43:22 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 04:43:22 INFO - PROCESS | 1636 | |i|pagename|runs| 04:43:22 INFO - PROCESS | 1636 | |0;dojo.html;3333.39998800216;3353.3293341331723;3357.3117510910265;3367.1582104473882;3407.591089069312;4905.288733133693;5180.782516108721;5652.717364131792;5690.772369105236;5708.20085188074;5641.492265696086;5694;5702.714864256791;5707.457791509811;5707.543396528278;4871.464138944713;5143.794248230076;5166.509181627739;5195.896082078356;5262.92105618416;5179.430262671103;5244.344456942882;5257.342832145981;5257.947420525784;5274.05067087924;5247.317848679685;5255.132903071008;5255.264263003182;5258.763355649005;5260.8158714445;5242.6330156889035;5253.212018197263;5257.447967963347;5259.2899958505495;5260.026895024433;4491.4161159049445;5011.774470148852;5193.558547523465;5227.294315267428;5230.267762513251;5651.4348565143155;5710.743016564223;5714.828555143353;5783.768649254025;5790.189373487715;6230.408111229426;6238.688065596702;6246.562740608159;6247.500199983991;6278.4663303619245;6124.502994489374;6129.939558357089;6141.324454310023;6142.662153581551;6143.815685529441;5702.173184888168;5712;5717.3996730342715;5719.113537401709;5760.10718338654;6263.6241825490615;6276.780312689125;6287.1198032275515;6301.180846489927;6314.71583778731;5946.881062378815;6007.459328660354;6010.609310394811;6092.421219984094;6093;6111.43980788641;6177.382261773877;6181.81454556364;6189.6286222826775;6197.194364732556;6127.842042281593;6153.815385538441;6179.3820617937845;6188.845278867974;6202.34875338092;6224.657643829632;6232.8130156095385;6246.063090536456;6251.843703907348;6263.561550691408;4902.534259245366;4999.3000979862845;5003.799848006039;5005.399352077774;5012.24816277554;4402.801873915681;4414.713043652152;4435.290353543418;4456.3538286948215;4456.952616135206;5801.6519008859605;5857.47282744555;5861.560382971209;5866.911996320058;5887.558433117533;6197.81406557804;6250.499960003189;6256.374362563707;6260.7495700171485;6294.937050629526;5691.373948865621;5713.314402271754;5794.507466865363;5804.6807425592;5847.064469684915;5385.192221166778;5400.027994960945;5404.675719456766;5415.079436495806;5483.259759932358;6252.556594267257;6315.90526142099;6325.841853953688;6325.968370158212;6326.367363263636;6237.688115594111;6246.906296405648;6263.530235232284;6288.748450061947;6305.747770089329;5548.833534993957;6216.937830621636;6223.657698826608;6255.186825712628;6285.497160227263;6201.906971395523;6202.038684003986;6211.378862113753;6216.533759968111;6218.81343559694;5500.834974950758;6132.724027418866;6228.408301211378;6272.121902933684;6286.371362863677;5633.746481408264;5881.441263080001;5941.989861723431;5968.22413086296;6060.151578778887;5989.730462129128;6092.45167934888;6093.238345206849;6098.237720284965;6120;4943.233798761198;5889.617174883619;5924.7926322578505;5930.318013428338;5944.138099975566;5851.356350801323;5979.40205979416;6022.939770602238;6040.214772079602;6050.0924861269405;5154.61340399464;5818.883622327615;5844.736986835517;5851.385604511635;5946.554008449297 04:43:22 INFO - PROCESS | 1636 | |1;ext.html;453.80713196891315;471.9244920812671;499.2162305180868;506.192622766687;519.5402069168786;30110.096697099067;39429.60570394295;41151.58848411515;41255.58744412559;41438.34246630139;42642;42689.99999999992;42789.78605106978;42837.929051773724;43189.70430887079;9295.11696388842;9472.81054378912;9483.099105584959;9484.525773711286;9506.952465237664;8411.747647570552;8666.783330416727;8677.609507572142;8755.912440875574;8762;11224.775504489906;11485.885141148565;11550.133739969493;11664.6500604982;11684.415779211047;10462.947685261524;10903.473513708088;11359.772804543903;11417.48621312043;11499.425028748528;8360;11189.496472658668;11201.943990280079;11291.49188286529;11301.49143288554;31812.363752725047;39057.21885562273;39710;39772.20455590872;41360;4047.433359329696;4063.79681015948;4068.5117785865887;4095.1195492969155;4213.262679031157;30725;30769.538456923165;30830.383392332253;30843.84578077118;30910.84544577285;2753.2979090332037;3112.081935828913;3337.1823903143886;3342.4652055670977;3345.5149003394613;464560;465859;467528;467603;467857;47376;56976;57085.143722844194;57468.13797793037;57601.423985759604;61368.69315653393;61605.383946159964;61707.6914615424;61823;61868.38131618626;15510.146941918303;15781.28984195714;15791.763123553155;15812.446564370191;15817.209139543207;12267.509299628093;12364.56724014655;12382.318972456602;12388.504459821506;12419.75160496803;11666.475008624462;13532.32338383077;13705.246211458267;14023.929880350737;15503.612409689847;7514.173440921494;7719.691212351556;7728.845423091507;7830.373570114377;7878.172791856887;734.8162959260185;782.3467404717125;811.8619834628128;847.4152834544145;851.565701492231;29403.41193176167;29596.852015739783;29661.703382965894;30094.24764380908;30119;942.472215559289;1067.3809190669392;1086.6033897627467;1107.1419649771492;1185.4546908422221;12907.741845163044;12954.80567791484;15388.845836562303;15742.527724168292;15761.921190393974;592215;596640;597480.0125999342;599287;600632;58537;58558.12162817561;58646.82706345934;58730.70634646885;58760.41239587635;1396.818413606245;1435.2178062955713;1456.839747627739;1459.0589070049546;1469.955901322962;28907.42185156243;29017.564736528548;29186.708132919248;30018.24954376158;30023.69976300209;48431.03137937292;49089;49099.754501228694;49132.75433622809;49299.26051109308;523799;524122;525110;525365;525735;37823;38214;38701;38738.80630596829;38819.611803882726;44628.33057504205;44637.107257855314;45358.77320613376;45879;46495.83760406017;29057.837686492305;37247.81376093102;37570.436443452825;37828.05429864275;37936;37098.6290137106;37139;37421.81289093646;37740.62259377371;38380.80809595934;36261.09347266339;37194;37982.81008594939;38012.23975520419;38094.61905381022;30496.542551861297;32814.671853281165;33366.16584585405;33380.666193337755;33584.49623255604;17160.65678686444;24244.87877560601;24518.264452066465;24881.253562392434;25022.62466063047 04:43:22 INFO - PROCESS | 1636 | |2;jquery.html;360.96570825771545;368.22672387985233;377.0573566084788;397.92956945815735;421.6605632465864;15245.466408675698;16217.675646487063;20156.992150392478;20836.270730524433;21129.788702112975;17974.382305592528;20339.898300508477;21061.57876842462;21245.787542124614;21304.721716697008;5656.802011929593;6023;6045.183900173464;6052.213212282397;6062.4543791058795;5730.914036289459;5833.183354330397;5881.294244690622;5898.469137777599;5914.408559144073;5852.268466441695;5855.61938474;5857.209276747649;5863.618864773797;5868.149118377833;5596.300462442195;5892.646441213519;5956.97021514894;5961.910571341434;5968.074948383008;4990.82532111378;5189.532942035197;5194.558462530689;5194.948050519484;5202.505761952609;25563.360915977064;25917.74082259172;25958.74041259582;26276;26404.20787376382;2430.343807172054;2698.0961377938415;2749.381389187437;2757.200411880552;2782.2070709847594;8007.879881801778;15442.922785386114;15507.844921550753;15622.921885390613;15811.023622047243;1805.3320271499497;1841.235887106849;1845.4002449204063;1852.6938508351714;1883.6437764809316;96798;117417;120341.39829300885;120681;121484;9977.600895964226;10638.255322127377;10874.401907895142;11039.337639741481;11340.6030788922;13100.279484628247;13345.332733363293;13547.322633868267;13558.661033474242;13598.524051658145;8062.355011599058;8354.373421993374;8519.872201916976;8569.528675922884;8675.826483470422;8319.66721331152;8426.578671066545;8440.493570385797;8567.100454452317;8590.269827064645;6885.311468853075;6895.620740859301;7009.12385951756;7009.264027277062;7030.437564994788;1620.7892973913315;1890.9716354254697;1935.458071739915;1940.8544359172836;1948.2596613287144;1057.259918057363;1061.9044286014296;1074.2104553153426;1091.2034215023077;1133.2067552713133;19858.808471491757;20904.26835060796;22097.226597069024;22754.544909101725;22835.429114272276;974.0892265731422;1085.5778929602247;1107.396468924438;1133.4106264742288;1135.920485566019;10621.628243011457;11813.940930295294;11876.693563707986;11935.880641193651;11946.76106477883;668048;682876;699069;711613.4419327871;727082;140222.2988885049;146070;146536;148253;153814.23092884463;978.7504186432415;1025.2003437318904;1065.073386154051;1069.1820757120809;1069.3583849690278;19094.809051909302;19376.903115484332;19451.51371215731;19516.414507564798;19659.901700491406;54647;54966.725166373915;55552;56218;56896.715516422155;77117.61441192759;78940.60529697315;80199;80840.95795210099;82799.17200827914;5953.1367951647635;8158.184181581794;8376.83246335082;8430.892276930766;8493;10488.9582021213;10636.680899573024;13152.079354445097;13340.733185336432;13447.798283025959;11167.218294719616;11200.159988000769;11239.269447486215;11742.412879356169;11847.170698051053;11255;11261.887381126084;11264.098872090377;11684.474198660911;11719.765604687687;10903.618373356894;11410.315381077162;11577.247478913843;11827.763444731228;11888.9894358977;6985;7216.5670059796585;7252.347288744038;7456.962715186606;8763.3427492937;9741.269404794528;10101.191904647758;10554.050135487843;10627.574897004342;10636.84044739345 04:43:22 INFO - PROCESS | 1636 | |3;mootools.html;1446.3202294921384;1461.568837193028;1471.1761413608378;1479.9926000369996;1497.775333699945;6612.933870661292;8484.406091573592;8484.745457636272;8491.320694344453;8504.192101750325;7498.88751668724;7715.421343399239;7722.304992550669;8018.879716804253;8300.792480187998;2281.7946384825323;2330.3707998840305;2334.8365614407;2341.7658234176533;2345.097137602027;2007.8795272283637;2304.5506126305377;2333.7199536055696;2338.0530884991604;2338.1232037985756;2036.4908772806798;2127.1491403438595;2131.2007997001124;2249.5950728868797;2292.7363353214428;2307.6077066898583;2326.7091613548305;2330.1844354475966;2332.661764044221;2333.824963127772;2247.2696373678455;2308.7806658367595;2321.94195145121;2324.976750232493;2328.55757406094;8429.030661473947;8498.107698691672;8505.787355316104;8509;8536.74389768308;4457.064016556527;4460.33095035744;5050.646454748169;5115.335006449138;5161.019406312788;3223.613166420021;3395.813230272334;3400.064982129934;3446.3107378524396;3455.3262113887804;1004.4174378860243;1141.3494308244303;1232.49467718236;1235.7281398092496;1240.5906051003146;10367.37795732251;10693.144548436185;10715.19636027301;10794.838077428767;10977.83533247002;3862.304785138646;4300;4369.3227549729845;4383.057642606855;4448.221561226773;8675.6529738811;8682.044975052739;8688.174623410765;8696.869546956801;8704.521251331238;5135.332406787168;5135.768890399941;5140.588752899759;5152.536271735562;5157.613179011589;4530.524294948983;4667.346571479996;4721.6694831362165;4747.121782470185;4800.615950723934;3630.2557975614936;3649.7627654202925;3669.7614655047337;3708.610595887447;3729.0490924814;1147.7015975846173;1157.5890558851654;1158.501844206999;1166.4517676691942;1175.8588969323564;679.480197648799;759.4152502572988;793.095870707394;796.9163237859941;814.2061490047157;5469.863253418617;5491.560675145979;5725.685087320154;5944.970275148597;5963.4334738199805;970.669972209438;981.1267971505366;982.9557669904872;986.3785814936545;1068.0921216965517;3618.457231415309;3641.304076362494;3683.6684698377276;3701.481792549045;3771.0949372150485;9750;10104.646337378303;10109.545070471846;10145.746356341004;10177.134943529734;9993.250506212064;10055.346402483816;10056.446895420822;10068.993100689873;10130.544125514221;7643.235676432201;7780.455368124177;7947.125816160218;7949.7217597383815;7952.721654742172;4498.820047198206;4681.976590117028;5392.460753924576;5512.751926163252;5541.806036788693;9120.133587309196;9134.168407793339;9245.306602005012;9291.62833486653;9450.480223587769;9251.76870578241;9421.199198068241;9441.15029647335;9557.952210238904;9579.760505987406;6703.396694297537;6848.00703897942;6848.486363522856;6849.691763870737;6853.760118395832;7746.341560967156;7771.72798952034;7837.373010159287;7923.326517246099;7949.682012719658;5761;7031.472639551952;7151.141862976476;7166.964165179141;7177.856442871218;6761.256261811295;6771.221309549464;6825.8634827302185;6977.8255543609785;7004.089468369079;6267.122602835698;6271.466925311217;6410.4871610272;6416.197975253093;6484.773032943825;4710.7880145392855;4781.13939490895;4860.125177467949;4957.132501812096;5015.573676237561;4777.546133117348;4905.950940490692;4939.209726443752;4987.875303117451;5032.496750324938 04:43:22 INFO - PROCESS | 1636 | |4;prototype.html;355.864771386873;361.3135043417506;366.4338596867839;375.9060234941265;378.4115700086365;5249.265102885599;5359.5444387227135;5365.597580181482;5383.676979381235;5391.73041347933;4225.59856813603;4580.496145424009;5060.721660308682;5083.237514372846;5218.199721096225;4157.584241575849;4189.266878296301;4192.5116583612835;4209.379388935251;4240.703150779431;3626.8005259710703;3664.322100411419;4043.2519983802945;4113.9098138993195;4234.5765423457715;3690.5571331440265;4050.675945924319;4165.854195103172;4168.958310416902;4174.935391475169;3972.1728005117534;4124.237016151991;4129.7109202356;4137.668986481104;4150.27370210212;3267.39553182662;3379.8648054078053;3389.559357283562;3626.546681664792;3716.6840818530186;4404.603585677304;4757.881052973668;5112.130937740556;5280.287161233223;5292.232626269208;4082.714210005271;4138.944569134851;4152.6055024772595;4616.69991450558;4619.69971951822;4674.672772905898;5538.47384498472;5539.889202215933;5549.864326655426;5609.625641717806;3787.8295476703615;3813.389857622767;3815.0271680721517;3825.368814145663;3847.3074846527616;4923.32606913651;5409.6213265071465;5446.700431476267;5886.7939622113445;5913.76344946206;3702.6852717519314;3738.7382883197915;3823.8644311664725;3869.980650096788;3890.2219556088894;3543.982280088583;3657.8536858525363;3904.8285514345584;3938.6455219030427;3988.7806170660892;3822.8853134406013;4212.620864122183;4307.612314891675;4566.269396896547;4600.700954437951;5594.608377413623;5604.579656525777;5630.8029218977135;5632.2678051853;5651.350094739076;994.1698681600944;1194.8506436695413;1256.2211428914131;1277.386854309918;1285.1967520299813;773.6634563964693;829.4779080387436;834.6119054639622;842.0526907229367;878.2271600991087;4187.74367689698;4862.17343051682;4890.867217201459;4930.580900623487;4948.505149485023;4936.642423333612;5285.568638426367;5326.6005049621435;5404.6218214355085;5526.032944234743;4578.8871856071855;4900.191468407673;4957.727324997088;4972.378452693413;4975.417699256602;2367.3963139399343;2614.5685961816466;2764.9170524884285;2832.504311745436;2893.30560665443;5008.5993120550265;5262.55268302191;5403.567714582824;5496.890062198733;5600.103983362643;4623.514530974267;5041.521055499722;5493.516750477349;5538.335399751975;5552.888942221133;4625.653076019312;5173.1722924331925;5552.7223638817895;5569.777208911598;5620.915686264628;4701.694389864648;4728.645351598575;5112.309838171799;5234.18870075139;5339.359276886798;4985.3826740961285;4991.427700274402;5140.588752899685;5207.947920520746;5393.4628630840025;5130.230465430215;5535.944640553704;5539.540669760881;5587.497125258747;5646.3788983212635;3333.316867630611;3379.712724418452;3483.89548313551;3600.225951420457;3600.7839529628304;5208.39580209895;5267.525922666979;5373.194020896896;5434.429384914527;5471.6169868108855;4399.108383395171;4872.443116524886;4962.727050012284;5163.741812909265;5296;4024.2555127301544;4799.856004319876;4803.639727020418;4902.774306423395;4957.7273249971595;4304.655627549726;4454.532274111301;4680.7191568506;5009.0733214354;5122.820701275437;4441.356003379557;5086.796528138833;5328.520433161034;5489.200507741001;5532.806351777668;4748.5726284633165;5064.949350506447;5108.948910510996;5381.515663590296;5434.918476222939 04:43:22 INFO - PROCESS | 1636 | |5;yui.html;713.5504632081788;728.231715540105;762.2910693055458;769.3229957637278;836.5608055770722;14680.706385872289;15531.689366212697;15549.222538873068;15566.844331556682;15579.454719084833;14416.855831441682;14551.636209094779;14568.344424500896;14611.63470913225;14615.196164210964;681.9659017049153;705.0305829484458;706.5230969095866;830.0620299062051;860.1398601398586;860.1914200651399;864.1962974433774;865.3899001204136;871.3073106880046;872.4111224923151;933.8505839065751;935.4995077633433;935.9953200233989;936.166811537732;936.7611259128912;881.722257488889;881.8633111867671;882.5940067568894;927.6289484206304;929.4284015330591;531.4101347504267;549.8103154411762;638.0939066525499;659.6240143118424;688.4664385101536;14983.02610330336;15011.399544018335;15024.399024039134;15061.096334219981;15077.170755608437;11199.608013719562;11391.259568128045;13707.45170193191;13765.036447448683;13839.723205535933;12543.435545400478;12585.370731463481;12705.428255728515;12860.421281042376;13117.803232951514;4303.74177549348;4403.524819185576;4435.135148646015;4547.15877562652;4564.7717614119165;95718.9999999993;96722;98929;100330.99669003363;100581.99418005873;9697.369670971364;10737.463126843626;10885.782284354269;10972.780544389068;11372.31766094037;21233.575328493345;21294;21393.358199254046;21502.89248553747;21562.89218553897;7517.097948246245;7582.052243469567;7640.732574359982;7661.885071723928;7820.843583128306;4091.8158682859344;4130.938035929464;4164.312888373445;4274.508431530352;4281.764502952367;3407.8296085195643;3510.157562185057;3513.6837684607995;3514.262004978932;3514.8594056237976;517.7178437751435;667.626129367546;682.723307415127;684.9657517124124;698.1900994846055;541.3260490689117;665.9134312539339;676.4419354032942;687.4156966578469;696.2341424433184;8662.523561204069;9780.706578802647;10038.799224015478;10157.593696252066;10492.685219443429;551.969641669712;560.6327855254815;595.3629616310507;654.754467074847;709.8651256261294;5010.473900240495;5076.873078173001;5122.206058061007;5134.332536770196;5135.229715542624;85230;86336.56831715927;95324.04675953151;97059.51470242745;98356.50821745988;84231;85561;85909;86828;87348;77553.61223193735;78790.21209787944;79086;79489.80765288525;79826.60086699529;8900.721196829087;10582.894171058191;10783.352998820095;10797.082248008694;11033.337999720043;49568;50108.24837627366;50602.24096638627;50623.74688126536;50715.74642126766;65234.67382663056;65748.34251657613;67637.6472470538;68170;68866;12550.623481295575;12867.613971580868;12898.484060637844;13009.479620815062;13362.398692059076;14517.98374113802;14697.327803626004;14784.334704938088;14847;15254.923725381303;13414.530491432753;13673.453061877812;13865.72268554603;14283.571492855232;14317.57047288583;13467.663308416975;13536.458541658223;13837.446502140205;14177.574672759421;14540.85459145395;13189.010824188032;13488.5279015234;13510.392032358764;13516.256605886378;13738.450461981409;8755.15579187999;10465.476726163814;10577.31247468912;10776.407297598707;10834.837477437686;10332.741681458023;10466;10490.370577765358;10497.790044199226;10508.474576271003 04:43:22 INFO - PROCESS | 1636 | __end_tp_report 04:43:22 INFO - PROCESS | 1636 | __start_cc_report 04:43:22 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1660 04:43:22 INFO - PROCESS | 1636 | __end_cc_report 04:43:22 INFO - PROCESS | 1636 | __startTimestamp1484916202846__endTimestamp 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | ------- Summary: start ------- 04:43:22 INFO - PROCESS | 1636 | Number of tests: 6 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5704.25 Median:5866.91 stddev:637.23 (10.9%) stddev-sans-first:611.43 04:43:22 INFO - PROCESS | 1636 | Values: 3333.4 3353.3 3357.3 3367.2 3407.6 4905.3 5180.8 5652.7 5690.8 5708.2 5641.5 5694.0 5702.7 5707.5 5707.5 4871.5 5143.8 5166.5 5195.9 5262.9 5179.4 5244.3 5257.3 5257.9 5274.1 5247.3 5255.1 5255.3 5258.8 5260.8 5242.6 5253.2 5257.4 5259.3 5260.0 4491.4 5011.8 5193.6 5227.3 5230.3 5651.4 5710.7 5714.8 5783.8 5790.2 6230.4 6238.7 6246.6 6247.5 6278.5 6124.5 6129.9 6141.3 6142.7 6143.8 5702.2 5712.0 5717.4 5719.1 5760.1 6263.6 6276.8 6287.1 6301.2 6314.7 5946.9 6007.5 6010.6 6092.4 6093.0 6111.4 6177.4 6181.8 6189.6 6197.2 6127.8 6153.8 6179.4 6188.8 6202.3 6224.7 6232.8 6246.1 6251.8 6263.6 4902.5 4999.3 5003.8 5005.4 5012.2 4402.8 4414.7 4435.3 4456.4 4457.0 5801.7 5857.5 5861.6 5866.9 5887.6 6197.8 6250.5 6256.4 6260.7 6294.9 5691.4 5713.3 5794.5 5804.7 5847.1 5385.2 5400.0 5404.7 5415.1 5483.3 6252.6 6315.9 6325.8 6326.0 6326.4 6237.7 6246.9 6263.5 6288.7 6305.7 5548.8 6216.9 6223.7 6255.2 6285.5 6201.9 6202.0 6211.4 6216.5 6218.8 5500.8 6132.7 6228.4 6272.1 6286.4 5633.7 5881.4 5942.0 5968.2 6060.2 5989.7 6092.5 6093.2 6098.2 6120.0 4943.2 5889.6 5924.8 5930.3 5944.1 5851.4 5979.4 6022.9 6040.2 6050.1 5154.6 5818.9 5844.7 5851.4 5946.6 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:66683.42 Median:38297.40 stddev:141898.07 (370.5%) stddev-sans-first:142209.00 04:43:22 INFO - PROCESS | 1636 | Values: 453.8 471.9 499.2 506.2 519.5 30110.1 39429.6 41151.6 41255.6 41438.3 42642.0 42690.0 42789.8 42837.9 43189.7 9295.1 9472.8 9483.1 9484.5 9507.0 8411.7 8666.8 8677.6 8755.9 8762.0 11224.8 11485.9 11550.1 11664.7 11684.4 10462.9 10903.5 11359.8 11417.5 11499.4 8360.0 11189.5 11201.9 11291.5 11301.5 31812.4 39057.2 39710.0 39772.2 41360.0 4047.4 4063.8 4068.5 4095.1 4213.3 30725.0 30769.5 30830.4 30843.8 30910.8 2753.3 3112.1 3337.2 3342.5 3345.5 464560.0 465859.0 467528.0 467603.0 467857.0 47376.0 56976.0 57085.1 57468.1 57601.4 61368.7 61605.4 61707.7 61823.0 61868.4 15510.1 15781.3 15791.8 15812.4 15817.2 12267.5 12364.6 12382.3 12388.5 12419.8 11666.5 13532.3 13705.2 14023.9 15503.6 7514.2 7719.7 7728.8 7830.4 7878.2 734.8 782.3 811.9 847.4 851.6 29403.4 29596.9 29661.7 30094.2 30119.0 942.5 1067.4 1086.6 1107.1 1185.5 12907.7 12954.8 15388.8 15742.5 15761.9 592215.0 596640.0 597480.0 599287.0 600632.0 58537.0 58558.1 58646.8 58730.7 58760.4 1396.8 1435.2 1456.8 1459.1 1470.0 28907.4 29017.6 29186.7 30018.2 30023.7 48431.0 49089.0 49099.8 49132.8 49299.3 523799.0 524122.0 525110.0 525365.0 525735.0 37823.0 38214.0 38701.0 38738.8 38819.6 44628.3 44637.1 45358.8 45879.0 46495.8 29057.8 37247.8 37570.4 37828.1 37936.0 37098.6 37139.0 37421.8 37740.6 38380.8 36261.1 37194.0 37982.8 38012.2 38094.6 30496.5 32814.7 33366.2 33380.7 33584.5 17160.7 24244.9 24518.3 24881.3 25022.6 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:38521.91 Median:21700.97 stddev:116086.96 (534.9%) stddev-sans-first:116377.25 04:43:22 INFO - PROCESS | 1636 | Values: 361.0 368.2 377.1 397.9 421.7 15245.5 16217.7 20157.0 20836.3 21129.8 17974.4 20339.9 21061.6 21245.8 21304.7 5656.8 6023.0 6045.2 6052.2 6062.5 5730.9 5833.2 5881.3 5898.5 5914.4 5852.3 5855.6 5857.2 5863.6 5868.1 5596.3 5892.6 5957.0 5961.9 5968.1 4990.8 5189.5 5194.6 5194.9 5202.5 25563.4 25917.7 25958.7 26276.0 26404.2 2430.3 2698.1 2749.4 2757.2 2782.2 8007.9 15442.9 15507.8 15622.9 15811.0 1805.3 1841.2 1845.4 1852.7 1883.6 96798.0 117417.0 120341.4 120681.0 121484.0 9977.6 10638.3 10874.4 11039.3 11340.6 13100.3 13345.3 13547.3 13558.7 13598.5 8062.4 8354.4 8519.9 8569.5 8675.8 8319.7 8426.6 8440.5 8567.1 8590.3 6885.3 6895.6 7009.1 7009.3 7030.4 1620.8 1891.0 1935.5 1940.9 1948.3 1057.3 1061.9 1074.2 1091.2 1133.2 19858.8 20904.3 22097.2 22754.5 22835.4 974.1 1085.6 1107.4 1133.4 1135.9 10621.6 11813.9 11876.7 11935.9 11946.8 668048.0 682876.0 699069.0 711613.4 727082.0 140222.3 146070.0 146536.0 148253.0 153814.2 978.8 1025.2 1065.1 1069.2 1069.4 19094.8 19376.9 19451.5 19516.4 19659.9 54647.0 54966.7 55552.0 56218.0 56896.7 77117.6 78940.6 80199.0 80841.0 82799.2 5953.1 8158.2 8376.8 8430.9 8493.0 10489.0 10636.7 13152.1 13340.7 13447.8 11167.2 11200.2 11239.3 11742.4 11847.2 11255.0 11261.9 11264.1 11684.5 11719.8 10903.6 11410.3 11577.2 11827.8 11889.0 6985.0 7216.6 7252.3 7457.0 8763.3 9741.3 10101.2 10554.1 10627.6 10636.8 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5349.97 Median:5001.72 stddev:2947.31 (58.9%) stddev-sans-first:2940.97 04:43:22 INFO - PROCESS | 1636 | Values: 1446.3 1461.6 1471.2 1480.0 1497.8 6612.9 8484.4 8484.7 8491.3 8504.2 7498.9 7715.4 7722.3 8018.9 8300.8 2281.8 2330.4 2334.8 2341.8 2345.1 2007.9 2304.6 2333.7 2338.1 2338.1 2036.5 2127.1 2131.2 2249.6 2292.7 2307.6 2326.7 2330.2 2332.7 2333.8 2247.3 2308.8 2321.9 2325.0 2328.6 8429.0 8498.1 8505.8 8509.0 8536.7 4457.1 4460.3 5050.6 5115.3 5161.0 3223.6 3395.8 3400.1 3446.3 3455.3 1004.4 1141.3 1232.5 1235.7 1240.6 10367.4 10693.1 10715.2 10794.8 10977.8 3862.3 4300.0 4369.3 4383.1 4448.2 8675.7 8682.0 8688.2 8696.9 8704.5 5135.3 5135.8 5140.6 5152.5 5157.6 4530.5 4667.3 4721.7 4747.1 4800.6 3630.3 3649.8 3669.8 3708.6 3729.0 1147.7 1157.6 1158.5 1166.5 1175.9 679.5 759.4 793.1 796.9 814.2 5469.9 5491.6 5725.7 5945.0 5963.4 970.7 981.1 983.0 986.4 1068.1 3618.5 3641.3 3683.7 3701.5 3771.1 9750.0 10104.6 10109.5 10145.7 10177.1 9993.3 10055.3 10056.4 10069.0 10130.5 7643.2 7780.5 7947.1 7949.7 7952.7 4498.8 4682.0 5392.5 5512.8 5541.8 9120.1 9134.2 9245.3 9291.6 9450.5 9251.8 9421.2 9441.2 9558.0 9579.8 6703.4 6848.0 6848.5 6849.7 6853.8 7746.3 7771.7 7837.4 7923.3 7949.7 5761.0 7031.5 7151.1 7167.0 7177.9 6761.3 6771.2 6825.9 6977.8 7004.1 6267.1 6271.5 6410.5 6416.2 6484.8 4710.8 4781.1 4860.1 4957.1 5015.6 4777.5 4906.0 4939.2 4987.9 5032.5 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4349.90 Median:4881.66 stddev:1302.01 (26.7%) stddev-sans-first:1270.68 04:43:22 INFO - PROCESS | 1636 | Values: 355.9 361.3 366.4 375.9 378.4 5249.3 5359.5 5365.6 5383.7 5391.7 4225.6 4580.5 5060.7 5083.2 5218.2 4157.6 4189.3 4192.5 4209.4 4240.7 3626.8 3664.3 4043.3 4113.9 4234.6 3690.6 4050.7 4165.9 4169.0 4174.9 3972.2 4124.2 4129.7 4137.7 4150.3 3267.4 3379.9 3389.6 3626.5 3716.7 4404.6 4757.9 5112.1 5280.3 5292.2 4082.7 4138.9 4152.6 4616.7 4619.7 4674.7 5538.5 5539.9 5549.9 5609.6 3787.8 3813.4 3815.0 3825.4 3847.3 4923.3 5409.6 5446.7 5886.8 5913.8 3702.7 3738.7 3823.9 3870.0 3890.2 3544.0 3657.9 3904.8 3938.6 3988.8 3822.9 4212.6 4307.6 4566.3 4600.7 5594.6 5604.6 5630.8 5632.3 5651.4 994.2 1194.9 1256.2 1277.4 1285.2 773.7 829.5 834.6 842.1 878.2 4187.7 4862.2 4890.9 4930.6 4948.5 4936.6 5285.6 5326.6 5404.6 5526.0 4578.9 4900.2 4957.7 4972.4 4975.4 2367.4 2614.6 2764.9 2832.5 2893.3 5008.6 5262.6 5403.6 5496.9 5600.1 4623.5 5041.5 5493.5 5538.3 5552.9 4625.7 5173.2 5552.7 5569.8 5620.9 4701.7 4728.6 5112.3 5234.2 5339.4 4985.4 4991.4 5140.6 5207.9 5393.5 5130.2 5535.9 5539.5 5587.5 5646.4 3333.3 3379.7 3483.9 3600.2 3600.8 5208.4 5267.5 5373.2 5434.4 5471.6 4399.1 4872.4 4962.7 5163.7 5296.0 4024.3 4799.9 4803.6 4902.8 4957.7 4304.7 4454.5 4680.7 5009.1 5122.8 4441.4 5086.8 5328.5 5489.2 5532.8 4748.6 5064.9 5108.9 5381.5 5434.9 04:43:22 INFO - PROCESS | 1636 | 04:43:22 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19933.85 Median:4555.97 stddev:27832.93 (610.9%) stddev-sans-first:27873.59 04:43:22 INFO - PROCESS | 1636 | Values: 713.6 728.2 762.3 769.3 836.6 14680.7 15531.7 15549.2 15566.8 15579.5 14416.9 14551.6 14568.3 14611.6 14615.2 682.0 705.0 706.5 830.1 860.1 860.2 864.2 865.4 871.3 872.4 933.9 935.5 936.0 936.2 936.8 881.7 881.9 882.6 927.6 929.4 531.4 549.8 638.1 659.6 688.5 14983.0 15011.4 15024.4 15061.1 15077.2 11199.6 11391.3 13707.5 13765.0 13839.7 12543.4 12585.4 12705.4 12860.4 13117.8 4303.7 4403.5 4435.1 4547.2 4564.8 95719.0 96722.0 98929.0 100331.0 100582.0 9697.4 10737.5 10885.8 10972.8 11372.3 21233.6 21294.0 21393.4 21502.9 21562.9 7517.1 7582.1 7640.7 7661.9 7820.8 4091.8 4130.9 4164.3 4274.5 4281.8 3407.8 3510.2 3513.7 3514.3 3514.9 517.7 667.6 682.7 685.0 698.2 541.3 665.9 676.4 687.4 696.2 8662.5 9780.7 10038.8 10157.6 10492.7 552.0 560.6 595.4 654.8 709.9 5010.5 5076.9 5122.2 5134.3 5135.2 85230.0 86336.6 95324.0 97059.5 98356.5 84231.0 85561.0 85909.0 86828.0 87348.0 77553.6 78790.2 79086.0 79489.8 79826.6 8900.7 10582.9 10783.4 10797.1 11033.3 49568.0 50108.2 50602.2 50623.7 50715.7 65234.7 65748.3 67637.6 68170.0 68866.0 12550.6 12867.6 12898.5 13009.5 13362.4 14518.0 14697.3 14784.3 14847.0 15254.9 13414.5 13673.5 13865.7 14283.6 14317.6 13467.7 13536.5 13837.4 14177.6 14540.9 13189.0 13488.5 13510.4 13516.3 13738.5 8755.2 10465.5 10577.3 10776.4 10834.8 10332.7 10466.0 10490.4 10497.8 10508.5 04:43:22 INFO - PROCESS | 1636 | -------- Summary: end -------- 04:43:22 INFO - PROCESS | 1636 | 04:43:23 INFO - TEST-INFO | 1636: exit 0 04:43:23 INFO - TEST-OK | dromaeo_css | took 1119521ms 04:43:23 INFO - TEST-START | kraken 04:43:23 INFO - operating with platform_type : mac_ 04:43:23 INFO - Initialising browser for kraken test... 04:43:23 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpzFM5Ss/profile http://localhost:49244/getInfo.html) 04:43:25 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 04:43:25 INFO - PROCESS | 1646 | colorDepth:24 04:43:25 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 04:43:25 INFO - PROCESS | 1646 | __metrics 04:43:25 INFO - PROCESS | 1646 | 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" 04:43:25 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:26 INFO - TEST-INFO | 1646: exit 0 04:43:26 INFO - Browser initialized. 04:43:26 INFO - Running cycle 1/1 for kraken test... 04:43:26 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpzFM5Ss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:38 INFO - PROCESS | 1647 | RSS: Main: 235872256 04:43:38 INFO - PROCESS | 1647 | 04:43:41 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:42 INFO - PROCESS | 1647 | RSS: Main: 287182848 04:43:42 INFO - PROCESS | 1647 | 04:43:44 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 04:43:45 INFO - PROCESS | 1647 | RSS: Main: 286674944 04:43:45 INFO - PROCESS | 1647 | 04:43:48 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 04:43:49 INFO - PROCESS | 1647 | RSS: Main: 379064320 04:43:49 INFO - PROCESS | 1647 | 04:43:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 04:43:52 INFO - PROCESS | 1647 | RSS: Main: 281808896 04:43:52 INFO - PROCESS | 1647 | 04:43:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:54 INFO - PROCESS | 1647 | RSS: Main: 285831168 04:43:54 INFO - PROCESS | 1647 | 04:43:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:58 INFO - PROCESS | 1647 | RSS: Main: 326402048 04:43:58 INFO - PROCESS | 1647 | 04:44:01 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:01 INFO - PROCESS | 1647 | RSS: Main: 328351744 04:44:01 INFO - PROCESS | 1647 | 04:44:04 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 04:44:05 INFO - PROCESS | 1647 | RSS: Main: 326574080 04:44:05 INFO - PROCESS | 1647 | 04:44:06 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:07 INFO - PROCESS | 1647 | RSS: Main: 303452160 04:44:07 INFO - PROCESS | 1647 | 04:44:09 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:10 INFO - PROCESS | 1647 | RSS: Main: 307363840 04:44:10 INFO - PROCESS | 1647 | 04:44:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:12 INFO - PROCESS | 1647 | RSS: Main: 308420608 04:44:12 INFO - PROCESS | 1647 | 04:44:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:16 INFO - PROCESS | 1647 | RSS: Main: 327467008 04:44:16 INFO - PROCESS | 1647 | 04:44:19 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:20 INFO - PROCESS | 1647 | RSS: Main: 320770048 04:44:20 INFO - PROCESS | 1647 | 04:44:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 04:44:22 INFO - PROCESS | 1647 | RSS: Main: 364797952 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | __start_tp_report 04:44:22 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 04:44:22 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 04:44:22 INFO - PROCESS | 1647 | |i|pagename|runs| 04:44:22 INFO - PROCESS | 1647 | |0;ai-astar;116;115;113;114;113;112;114;114;115;115 04:44:22 INFO - PROCESS | 1647 | |1;audio-beat-detection;148;111;111;148;113;112;110;112;131;112 04:44:22 INFO - PROCESS | 1647 | |2;audio-dft;184;186;184;186;186;184;183;181;185;184 04:44:22 INFO - PROCESS | 1647 | |3;audio-fft;82;59;74;110;85;60;58;58;75;73 04:44:22 INFO - PROCESS | 1647 | |4;audio-oscillator;94;70;86;70;68;71;83;68;69;83 04:44:22 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;92;130;87;91;109;114;134;83;86;84 04:44:22 INFO - PROCESS | 1647 | |6;imaging-darkroom;95;95;95;95;96;95;95;95;94;95 04:44:22 INFO - PROCESS | 1647 | |7;imaging-desaturate;86;85;85;86;87;86;86;85;86;86 04:44:22 INFO - PROCESS | 1647 | |8;json-parse-financial;55;55;53;54;55;56;56;55;55;55 04:44:22 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;65;71;76;79;72;70;70;69;70;71 04:44:22 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;88;86;88;88;91;85;87;90;94;108 04:44:22 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;144;157;154;142;136;141;141;145;196;149 04:44:22 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;175;173;174;174;173;173;174;172;173;172 04:44:22 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;67;68;69;67;67;67;67;67;65;66 04:44:22 INFO - PROCESS | 1647 | __end_tp_report 04:44:22 INFO - PROCESS | 1647 | __start_cc_report 04:44:22 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1985 04:44:22 INFO - PROCESS | 1647 | __end_cc_report 04:44:22 INFO - PROCESS | 1647 | __startTimestamp1484916262247__endTimestamp 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | ------- Summary: start ------- 04:44:22 INFO - PROCESS | 1647 | Number of tests: 14 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.20 (1.0%) stddev-sans-first:1.05 04:44:22 INFO - PROCESS | 1647 | Values: 116.0 115.0 113.0 114.0 113.0 112.0 114.0 114.0 115.0 115.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:112.50 stddev:15.58 (13.9%) stddev-sans-first:13.06 04:44:22 INFO - PROCESS | 1647 | Values: 148.0 111.0 111.0 148.0 113.0 112.0 110.0 112.0 131.0 112.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:1.57 (0.8%) stddev-sans-first:1.66 04:44:22 INFO - PROCESS | 1647 | Values: 184.0 186.0 184.0 186.0 186.0 184.0 183.0 181.0 185.0 184.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.50 stddev:16.37 (22.3%) stddev-sans-first:17.07 04:44:22 INFO - PROCESS | 1647 | Values: 82.0 59.0 74.0 110.0 85.0 60.0 58.0 58.0 75.0 73.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.00 stddev:9.40 (12.2%) stddev-sans-first:7.45 04:44:22 INFO - PROCESS | 1647 | Values: 94.0 70.0 86.0 70.0 68.0 71.0 83.0 68.0 69.0 83.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:101.00 Median:85.00 stddev:19.37 (22.8%) stddev-sans-first:20.27 04:44:22 INFO - PROCESS | 1647 | Values: 92.0 130.0 87.0 91.0 109.0 114.0 134.0 83.0 86.0 84.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:44:22 INFO - PROCESS | 1647 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:44:22 INFO - PROCESS | 1647 | Values: 86.0 85.0 85.0 86.0 87.0 86.0 86.0 85.0 86.0 86.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 04:44:22 INFO - PROCESS | 1647 | Values: 55.0 55.0 53.0 54.0 55.0 56.0 56.0 55.0 55.0 55.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:3.83 (5.4%) stddev-sans-first:3.32 04:44:22 INFO - PROCESS | 1647 | Values: 65.0 71.0 76.0 79.0 72.0 70.0 70.0 69.0 70.0 71.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:6.67 (7.6%) stddev-sans-first:7.01 04:44:22 INFO - PROCESS | 1647 | Values: 88.0 86.0 88.0 88.0 91.0 85.0 87.0 90.0 94.0 108.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:147.00 stddev:17.20 (11.7%) stddev-sans-first:18.08 04:44:22 INFO - PROCESS | 1647 | Values: 144.0 157.0 154.0 142.0 136.0 141.0 141.0 145.0 196.0 149.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:0.95 (0.5%) stddev-sans-first:0.78 04:44:22 INFO - PROCESS | 1647 | Values: 175.0 173.0 174.0 174.0 173.0 173.0 174.0 172.0 173.0 172.0 04:44:22 INFO - PROCESS | 1647 | 04:44:22 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 04:44:22 INFO - PROCESS | 1647 | Values: 67.0 68.0 69.0 67.0 67.0 67.0 67.0 67.0 65.0 66.0 04:44:22 INFO - PROCESS | 1647 | -------- Summary: end -------- 04:44:22 INFO - PROCESS | 1647 | 04:44:23 INFO - TEST-INFO | 1647: exit 0 04:44:23 INFO - TEST-OK | kraken | took 59663ms 04:44:23 INFO - SUITE-END | took 1179s 04:44:23 INFO - Completed test suite (00:19:39) 04:44:23 INFO - javascript benchmark 04:44:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.39998800216, 3353.3293341331723, 3357.3117510910265, 3367.1582104473882, 3407.591089069312, 4905.288733133693, 5180.782516108721, 5652.717364131792, 5690.772369105236, 5708.20085188074, 5641.492265696086, 5694.0, 5702.714864256791, 5707.457791509811, 5707.543396528278, 4871.464138944713, 5143.794248230076, 5166.509181627739, 5195.896082078356, 5262.92105618416, 5179.430262671103, 5244.344456942882, 5257.342832145981, 5257.947420525784, 5274.05067087924, 5247.317848679685, 5255.132903071008, 5255.264263003182, 5258.763355649005, 5260.8158714445, 5242.6330156889035, 5253.212018197263, 5257.447967963347, 5259.2899958505495, 5260.026895024433, 4491.4161159049445, 5011.774470148852, 5193.558547523465, 5227.294315267428, 5230.267762513251, 5651.4348565143155, 5710.743016564223, 5714.828555143353, 5783.768649254025, 5790.189373487715, 6230.408111229426, 6238.688065596702, 6246.562740608159, 6247.500199983991, 6278.4663303619245, 6124.502994489374, 6129.939558357089, 6141.324454310023, 6142.662153581551, 6143.815685529441, 5702.173184888168, 5712.0, 5717.3996730342715, 5719.113537401709, 5760.10718338654, 6263.6241825490615, 6276.780312689125, 6287.1198032275515, 6301.180846489927, 6314.71583778731, 5946.881062378815, 6007.459328660354, 6010.609310394811, 6092.421219984094, 6093.0, 6111.43980788641, 6177.382261773877, 6181.81454556364, 6189.6286222826775, 6197.194364732556, 6127.842042281593, 6153.815385538441, 6179.3820617937845, 6188.845278867974, 6202.34875338092, 6224.657643829632, 6232.8130156095385, 6246.063090536456, 6251.843703907348, 6263.561550691408, 4902.534259245366, 4999.3000979862845, 5003.799848006039, 5005.399352077774, 5012.24816277554, 4402.801873915681, 4414.713043652152, 4435.290353543418, 4456.3538286948215, 4456.952616135206, 5801.6519008859605, 5857.47282744555, 5861.560382971209, 5866.911996320058, 5887.558433117533, 6197.81406557804, 6250.499960003189, 6256.374362563707, 6260.7495700171485, 6294.937050629526, 5691.373948865621, 5713.314402271754, 5794.507466865363, 5804.6807425592, 5847.064469684915, 5385.192221166778, 5400.027994960945, 5404.675719456766, 5415.079436495806, 5483.259759932358, 6252.556594267257, 6315.90526142099, 6325.841853953688, 6325.968370158212, 6326.367363263636, 6237.688115594111, 6246.906296405648, 6263.530235232284, 6288.748450061947, 6305.747770089329, 5548.833534993957, 6216.937830621636, 6223.657698826608, 6255.186825712628, 6285.497160227263, 6201.906971395523, 6202.038684003986, 6211.378862113753, 6216.533759968111, 6218.81343559694, 5500.834974950758, 6132.724027418866, 6228.408301211378, 6272.121902933684, 6286.371362863677, 5633.746481408264, 5881.441263080001, 5941.989861723431, 5968.22413086296, 6060.151578778887, 5989.730462129128, 6092.45167934888, 6093.238345206849, 6098.237720284965, 6120.0, 4943.233798761198, 5889.617174883619, 5924.7926322578505, 5930.318013428338, 5944.138099975566, 5851.356350801323, 5979.40205979416, 6022.939770602238, 6040.214772079602, 6050.0924861269405, 5154.61340399464, 5818.883622327615, 5844.736986835517, 5851.385604511635, 5946.554008449297], "value": 5664.282216505905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.80713196891315, 471.9244920812671, 499.2162305180868, 506.192622766687, 519.5402069168786, 30110.096697099067, 39429.60570394295, 41151.58848411515, 41255.58744412559, 41438.34246630139, 42642.0, 42689.99999999992, 42789.78605106978, 42837.929051773724, 43189.70430887079, 9295.11696388842, 9472.81054378912, 9483.099105584959, 9484.525773711286, 9506.952465237664, 8411.747647570552, 8666.783330416727, 8677.609507572142, 8755.912440875574, 8762.0, 11224.775504489906, 11485.885141148565, 11550.133739969493, 11664.6500604982, 11684.415779211047, 10462.947685261524, 10903.473513708088, 11359.772804543903, 11417.48621312043, 11499.425028748528, 8360.0, 11189.496472658668, 11201.943990280079, 11291.49188286529, 11301.49143288554, 31812.363752725047, 39057.21885562273, 39710.0, 39772.20455590872, 41360.0, 4047.433359329696, 4063.79681015948, 4068.5117785865887, 4095.1195492969155, 4213.262679031157, 30725.0, 30769.538456923165, 30830.383392332253, 30843.84578077118, 30910.84544577285, 2753.2979090332037, 3112.081935828913, 3337.1823903143886, 3342.4652055670977, 3345.5149003394613, 464560.0, 465859.0, 467528.0, 467603.0, 467857.0, 47376.0, 56976.0, 57085.143722844194, 57468.13797793037, 57601.423985759604, 61368.69315653393, 61605.383946159964, 61707.6914615424, 61823.0, 61868.38131618626, 15510.146941918303, 15781.28984195714, 15791.763123553155, 15812.446564370191, 15817.209139543207, 12267.509299628093, 12364.56724014655, 12382.318972456602, 12388.504459821506, 12419.75160496803, 11666.475008624462, 13532.32338383077, 13705.246211458267, 14023.929880350737, 15503.612409689847, 7514.173440921494, 7719.691212351556, 7728.845423091507, 7830.373570114377, 7878.172791856887, 734.8162959260185, 782.3467404717125, 811.8619834628128, 847.4152834544145, 851.565701492231, 29403.41193176167, 29596.852015739783, 29661.703382965894, 30094.24764380908, 30119.0, 942.472215559289, 1067.3809190669392, 1086.6033897627467, 1107.1419649771492, 1185.4546908422221, 12907.741845163044, 12954.80567791484, 15388.845836562303, 15742.527724168292, 15761.921190393974, 592215.0, 596640.0, 597480.0125999342, 599287.0, 600632.0, 58537.0, 58558.12162817561, 58646.82706345934, 58730.70634646885, 58760.41239587635, 1396.818413606245, 1435.2178062955713, 1456.839747627739, 1459.0589070049546, 1469.955901322962, 28907.42185156243, 29017.564736528548, 29186.708132919248, 30018.24954376158, 30023.69976300209, 48431.03137937292, 49089.0, 49099.754501228694, 49132.75433622809, 49299.26051109308, 523799.0, 524122.0, 525110.0, 525365.0, 525735.0, 37823.0, 38214.0, 38701.0, 38738.80630596829, 38819.611803882726, 44628.33057504205, 44637.107257855314, 45358.77320613376, 45879.0, 46495.83760406017, 29057.837686492305, 37247.81376093102, 37570.436443452825, 37828.05429864275, 37936.0, 37098.6290137106, 37139.0, 37421.81289093646, 37740.62259377371, 38380.80809595934, 36261.09347266339, 37194.0, 37982.81008594939, 38012.23975520419, 38094.61905381022, 30496.542551861297, 32814.671853281165, 33366.16584585405, 33380.666193337755, 33584.49623255604, 17160.65678686444, 24244.87877560601, 24518.264452066465, 24881.253562392434, 25022.62466063047], "value": 19759.33250968832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.96570825771545, 368.22672387985233, 377.0573566084788, 397.92956945815735, 421.6605632465864, 15245.466408675698, 16217.675646487063, 20156.992150392478, 20836.270730524433, 21129.788702112975, 17974.382305592528, 20339.898300508477, 21061.57876842462, 21245.787542124614, 21304.721716697008, 5656.802011929593, 6023.0, 6045.183900173464, 6052.213212282397, 6062.4543791058795, 5730.914036289459, 5833.183354330397, 5881.294244690622, 5898.469137777599, 5914.408559144073, 5852.268466441695, 5855.61938474, 5857.209276747649, 5863.618864773797, 5868.149118377833, 5596.300462442195, 5892.646441213519, 5956.97021514894, 5961.910571341434, 5968.074948383008, 4990.82532111378, 5189.532942035197, 5194.558462530689, 5194.948050519484, 5202.505761952609, 25563.360915977064, 25917.74082259172, 25958.74041259582, 26276.0, 26404.20787376382, 2430.343807172054, 2698.0961377938415, 2749.381389187437, 2757.200411880552, 2782.2070709847594, 8007.879881801778, 15442.922785386114, 15507.844921550753, 15622.921885390613, 15811.023622047243, 1805.3320271499497, 1841.235887106849, 1845.4002449204063, 1852.6938508351714, 1883.6437764809316, 96798.0, 117417.0, 120341.39829300885, 120681.0, 121484.0, 9977.600895964226, 10638.255322127377, 10874.401907895142, 11039.337639741481, 11340.6030788922, 13100.279484628247, 13345.332733363293, 13547.322633868267, 13558.661033474242, 13598.524051658145, 8062.355011599058, 8354.373421993374, 8519.872201916976, 8569.528675922884, 8675.826483470422, 8319.66721331152, 8426.578671066545, 8440.493570385797, 8567.100454452317, 8590.269827064645, 6885.311468853075, 6895.620740859301, 7009.12385951756, 7009.264027277062, 7030.437564994788, 1620.7892973913315, 1890.9716354254697, 1935.458071739915, 1940.8544359172836, 1948.2596613287144, 1057.259918057363, 1061.9044286014296, 1074.2104553153426, 1091.2034215023077, 1133.2067552713133, 19858.808471491757, 20904.26835060796, 22097.226597069024, 22754.544909101725, 22835.429114272276, 974.0892265731422, 1085.5778929602247, 1107.396468924438, 1133.4106264742288, 1135.920485566019, 10621.628243011457, 11813.940930295294, 11876.693563707986, 11935.880641193651, 11946.76106477883, 668048.0, 682876.0, 699069.0, 711613.4419327871, 727082.0, 140222.2988885049, 146070.0, 146536.0, 148253.0, 153814.23092884463, 978.7504186432415, 1025.2003437318904, 1065.073386154051, 1069.1820757120809, 1069.3583849690278, 19094.809051909302, 19376.903115484332, 19451.51371215731, 19516.414507564798, 19659.901700491406, 54647.0, 54966.725166373915, 55552.0, 56218.0, 56896.715516422155, 77117.61441192759, 78940.60529697315, 80199.0, 80840.95795210099, 82799.17200827914, 5953.1367951647635, 8158.184181581794, 8376.83246335082, 8430.892276930766, 8493.0, 10488.9582021213, 10636.680899573024, 13152.079354445097, 13340.733185336432, 13447.798283025959, 11167.218294719616, 11200.159988000769, 11239.269447486215, 11742.412879356169, 11847.170698051053, 11255.0, 11261.887381126084, 11264.098872090377, 11684.474198660911, 11719.765604687687, 10903.618373356894, 11410.315381077162, 11577.247478913843, 11827.763444731228, 11888.9894358977, 6985.0, 7216.5670059796585, 7252.347288744038, 7456.962715186606, 8763.3427492937, 9741.269404794528, 10101.191904647758, 10554.050135487843, 10627.574897004342, 10636.84044739345], "value": 9938.133251855135, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.3202294921384, 1461.568837193028, 1471.1761413608378, 1479.9926000369996, 1497.775333699945, 6612.933870661292, 8484.406091573592, 8484.745457636272, 8491.320694344453, 8504.192101750325, 7498.88751668724, 7715.421343399239, 7722.304992550669, 8018.879716804253, 8300.792480187998, 2281.7946384825323, 2330.3707998840305, 2334.8365614407, 2341.7658234176533, 2345.097137602027, 2007.8795272283637, 2304.5506126305377, 2333.7199536055696, 2338.0530884991604, 2338.1232037985756, 2036.4908772806798, 2127.1491403438595, 2131.2007997001124, 2249.5950728868797, 2292.7363353214428, 2307.6077066898583, 2326.7091613548305, 2330.1844354475966, 2332.661764044221, 2333.824963127772, 2247.2696373678455, 2308.7806658367595, 2321.94195145121, 2324.976750232493, 2328.55757406094, 8429.030661473947, 8498.107698691672, 8505.787355316104, 8509.0, 8536.74389768308, 4457.064016556527, 4460.33095035744, 5050.646454748169, 5115.335006449138, 5161.019406312788, 3223.613166420021, 3395.813230272334, 3400.064982129934, 3446.3107378524396, 3455.3262113887804, 1004.4174378860243, 1141.3494308244303, 1232.49467718236, 1235.7281398092496, 1240.5906051003146, 10367.37795732251, 10693.144548436185, 10715.19636027301, 10794.838077428767, 10977.83533247002, 3862.304785138646, 4300.0, 4369.3227549729845, 4383.057642606855, 4448.221561226773, 8675.6529738811, 8682.044975052739, 8688.174623410765, 8696.869546956801, 8704.521251331238, 5135.332406787168, 5135.768890399941, 5140.588752899759, 5152.536271735562, 5157.613179011589, 4530.524294948983, 4667.346571479996, 4721.6694831362165, 4747.121782470185, 4800.615950723934, 3630.2557975614936, 3649.7627654202925, 3669.7614655047337, 3708.610595887447, 3729.0490924814, 1147.7015975846173, 1157.5890558851654, 1158.501844206999, 1166.4517676691942, 1175.8588969323564, 679.480197648799, 759.4152502572988, 793.095870707394, 796.9163237859941, 814.2061490047157, 5469.863253418617, 5491.560675145979, 5725.685087320154, 5944.970275148597, 5963.4334738199805, 970.669972209438, 981.1267971505366, 982.9557669904872, 986.3785814936545, 1068.0921216965517, 3618.457231415309, 3641.304076362494, 3683.6684698377276, 3701.481792549045, 3771.0949372150485, 9750.0, 10104.646337378303, 10109.545070471846, 10145.746356341004, 10177.134943529734, 9993.250506212064, 10055.346402483816, 10056.446895420822, 10068.993100689873, 10130.544125514221, 7643.235676432201, 7780.455368124177, 7947.125816160218, 7949.7217597383815, 7952.721654742172, 4498.820047198206, 4681.976590117028, 5392.460753924576, 5512.751926163252, 5541.806036788693, 9120.133587309196, 9134.168407793339, 9245.306602005012, 9291.62833486653, 9450.480223587769, 9251.76870578241, 9421.199198068241, 9441.15029647335, 9557.952210238904, 9579.760505987406, 6703.396694297537, 6848.00703897942, 6848.486363522856, 6849.691763870737, 6853.760118395832, 7746.341560967156, 7771.72798952034, 7837.373010159287, 7923.326517246099, 7949.682012719658, 5761.0, 7031.472639551952, 7151.141862976476, 7166.964165179141, 7177.856442871218, 6761.256261811295, 6771.221309549464, 6825.8634827302185, 6977.8255543609785, 7004.089468369079, 6267.122602835698, 6271.466925311217, 6410.4871610272, 6416.197975253093, 6484.773032943825, 4710.7880145392855, 4781.13939490895, 4860.125177467949, 4957.132501812096, 5015.573676237561, 4777.546133117348, 4905.950940490692, 4939.209726443752, 4987.875303117451, 5032.496750324938], "value": 4334.910812560955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.864771386873, 361.3135043417506, 366.4338596867839, 375.9060234941265, 378.4115700086365, 5249.265102885599, 5359.5444387227135, 5365.597580181482, 5383.676979381235, 5391.73041347933, 4225.59856813603, 4580.496145424009, 5060.721660308682, 5083.237514372846, 5218.199721096225, 4157.584241575849, 4189.266878296301, 4192.5116583612835, 4209.379388935251, 4240.703150779431, 3626.8005259710703, 3664.322100411419, 4043.2519983802945, 4113.9098138993195, 4234.5765423457715, 3690.5571331440265, 4050.675945924319, 4165.854195103172, 4168.958310416902, 4174.935391475169, 3972.1728005117534, 4124.237016151991, 4129.7109202356, 4137.668986481104, 4150.27370210212, 3267.39553182662, 3379.8648054078053, 3389.559357283562, 3626.546681664792, 3716.6840818530186, 4404.603585677304, 4757.881052973668, 5112.130937740556, 5280.287161233223, 5292.232626269208, 4082.714210005271, 4138.944569134851, 4152.6055024772595, 4616.69991450558, 4619.69971951822, 4674.672772905898, 5538.47384498472, 5539.889202215933, 5549.864326655426, 5609.625641717806, 3787.8295476703615, 3813.389857622767, 3815.0271680721517, 3825.368814145663, 3847.3074846527616, 4923.32606913651, 5409.6213265071465, 5446.700431476267, 5886.7939622113445, 5913.76344946206, 3702.6852717519314, 3738.7382883197915, 3823.8644311664725, 3869.980650096788, 3890.2219556088894, 3543.982280088583, 3657.8536858525363, 3904.8285514345584, 3938.6455219030427, 3988.7806170660892, 3822.8853134406013, 4212.620864122183, 4307.612314891675, 4566.269396896547, 4600.700954437951, 5594.608377413623, 5604.579656525777, 5630.8029218977135, 5632.2678051853, 5651.350094739076, 994.1698681600944, 1194.8506436695413, 1256.2211428914131, 1277.386854309918, 1285.1967520299813, 773.6634563964693, 829.4779080387436, 834.6119054639622, 842.0526907229367, 878.2271600991087, 4187.74367689698, 4862.17343051682, 4890.867217201459, 4930.580900623487, 4948.505149485023, 4936.642423333612, 5285.568638426367, 5326.6005049621435, 5404.6218214355085, 5526.032944234743, 4578.8871856071855, 4900.191468407673, 4957.727324997088, 4972.378452693413, 4975.417699256602, 2367.3963139399343, 2614.5685961816466, 2764.9170524884285, 2832.504311745436, 2893.30560665443, 5008.5993120550265, 5262.55268302191, 5403.567714582824, 5496.890062198733, 5600.103983362643, 4623.514530974267, 5041.521055499722, 5493.516750477349, 5538.335399751975, 5552.888942221133, 4625.653076019312, 5173.1722924331925, 5552.7223638817895, 5569.777208911598, 5620.915686264628, 4701.694389864648, 4728.645351598575, 5112.309838171799, 5234.18870075139, 5339.359276886798, 4985.3826740961285, 4991.427700274402, 5140.588752899685, 5207.947920520746, 5393.4628630840025, 5130.230465430215, 5535.944640553704, 5539.540669760881, 5587.497125258747, 5646.3788983212635, 3333.316867630611, 3379.712724418452, 3483.89548313551, 3600.225951420457, 3600.7839529628304, 5208.39580209895, 5267.525922666979, 5373.194020896896, 5434.429384914527, 5471.6169868108855, 4399.108383395171, 4872.443116524886, 4962.727050012284, 5163.741812909265, 5296.0, 4024.2555127301544, 4799.856004319876, 4803.639727020418, 4902.774306423395, 4957.7273249971595, 4304.655627549726, 4454.532274111301, 4680.7191568506, 5009.0733214354, 5122.820701275437, 4441.356003379557, 5086.796528138833, 5328.520433161034, 5489.200507741001, 5532.806351777668, 4748.5726284633165, 5064.949350506447, 5108.948910510996, 5381.515663590296, 5434.918476222939], "value": 3948.156057266683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.5504632081788, 728.231715540105, 762.2910693055458, 769.3229957637278, 836.5608055770722, 14680.706385872289, 15531.689366212697, 15549.222538873068, 15566.844331556682, 15579.454719084833, 14416.855831441682, 14551.636209094779, 14568.344424500896, 14611.63470913225, 14615.196164210964, 681.9659017049153, 705.0305829484458, 706.5230969095866, 830.0620299062051, 860.1398601398586, 860.1914200651399, 864.1962974433774, 865.3899001204136, 871.3073106880046, 872.4111224923151, 933.8505839065751, 935.4995077633433, 935.9953200233989, 936.166811537732, 936.7611259128912, 881.722257488889, 881.8633111867671, 882.5940067568894, 927.6289484206304, 929.4284015330591, 531.4101347504267, 549.8103154411762, 638.0939066525499, 659.6240143118424, 688.4664385101536, 14983.02610330336, 15011.399544018335, 15024.399024039134, 15061.096334219981, 15077.170755608437, 11199.608013719562, 11391.259568128045, 13707.45170193191, 13765.036447448683, 13839.723205535933, 12543.435545400478, 12585.370731463481, 12705.428255728515, 12860.421281042376, 13117.803232951514, 4303.74177549348, 4403.524819185576, 4435.135148646015, 4547.15877562652, 4564.7717614119165, 95718.9999999993, 96722.0, 98929.0, 100330.99669003363, 100581.99418005873, 9697.369670971364, 10737.463126843626, 10885.782284354269, 10972.780544389068, 11372.31766094037, 21233.575328493345, 21294.0, 21393.358199254046, 21502.89248553747, 21562.89218553897, 7517.097948246245, 7582.052243469567, 7640.732574359982, 7661.885071723928, 7820.843583128306, 4091.8158682859344, 4130.938035929464, 4164.312888373445, 4274.508431530352, 4281.764502952367, 3407.8296085195643, 3510.157562185057, 3513.6837684607995, 3514.262004978932, 3514.8594056237976, 517.7178437751435, 667.626129367546, 682.723307415127, 684.9657517124124, 698.1900994846055, 541.3260490689117, 665.9134312539339, 676.4419354032942, 687.4156966578469, 696.2341424433184, 8662.523561204069, 9780.706578802647, 10038.799224015478, 10157.593696252066, 10492.685219443429, 551.969641669712, 560.6327855254815, 595.3629616310507, 654.754467074847, 709.8651256261294, 5010.473900240495, 5076.873078173001, 5122.206058061007, 5134.332536770196, 5135.229715542624, 85230.0, 86336.56831715927, 95324.04675953151, 97059.51470242745, 98356.50821745988, 84231.0, 85561.0, 85909.0, 86828.0, 87348.0, 77553.61223193735, 78790.21209787944, 79086.0, 79489.80765288525, 79826.60086699529, 8900.721196829087, 10582.894171058191, 10783.352998820095, 10797.082248008694, 11033.337999720043, 49568.0, 50108.24837627366, 50602.24096638627, 50623.74688126536, 50715.74642126766, 65234.67382663056, 65748.34251657613, 67637.6472470538, 68170.0, 68866.0, 12550.623481295575, 12867.613971580868, 12898.484060637844, 13009.479620815062, 13362.398692059076, 14517.98374113802, 14697.327803626004, 14784.334704938088, 14847.0, 15254.923725381303, 13414.530491432753, 13673.453061877812, 13865.72268554603, 14283.571492855232, 14317.57047288583, 13467.663308416975, 13536.458541658223, 13837.446502140205, 14177.574672759421, 14540.85459145395, 13189.010824188032, 13488.5279015234, 13510.392032358764, 13516.256605886378, 13738.450461981409, 8755.15579187999, 10465.476726163814, 10577.31247468912, 10776.407297598707, 10834.837477437686, 10332.741681458023, 10466.0, 10490.370577765358, 10497.790044199226, 10508.474576271003], "value": 7450.612527020795, "unit": "score"}], "name": "dromaeo_css", "value": 7221.704856146644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 111.0, 148.0, 113.0, 112.0, 110.0, 112.0, 131.0, 112.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 186.0, 186.0, 184.0, 183.0, 181.0, 185.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 74.0, 110.0, 85.0, 60.0, 58.0, 58.0, 75.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 86.0, 70.0, 68.0, 71.0, 83.0, 68.0, 69.0, 83.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 130.0, 87.0, 91.0, 109.0, 114.0, 134.0, 83.0, 86.0, 84.0], "value": 101.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 86.0, 87.0, 86.0, 86.0, 85.0, 86.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 76.0, 79.0, 72.0, 70.0, 70.0, 69.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 88.0, 91.0, 85.0, 87.0, 90.0, 94.0, 108.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 157.0, 154.0, 142.0, 136.0, 141.0, 141.0, 145.0, 196.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 174.0, 174.0, 173.0, 173.0, 174.0, 172.0, 173.0, 172.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 65.0, 66.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1458.1, "alertThreshold": 2.0}]} 04:44:23 INFO - Return code: 0 04:44:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:23 ERROR - # TBPL SUCCESS # 04:44:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:23 INFO - 2017-01-20 04:44:23.567 screenresolution[1651:9603] starting screenresolution argv=screenresolution get 04:44:23 INFO - 2017-01-20 04:44:23.569 screenresolution[1651:9603] Display 0: 1600x1200x32@60 04:44:23 INFO - 2017-01-20 04:44:23.575 screenresolution[1652:9606] starting screenresolution argv=screenresolution list 04:44:23 INFO - Available Modes on Display 0 04:44:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:23 INFO - Intel Iris: 04:44:23 INFO - Chipset Model: Intel Iris 04:44:23 INFO - Type: GPU 04:44:23 INFO - Bus: Built-In 04:44:23 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:23 INFO - Vendor: Intel (0x8086) 04:44:23 INFO - Device ID: 0x0a2e 04:44:23 INFO - Revision ID: 0x0009 04:44:23 INFO - Displays: 04:44:23 INFO - Display: 04:44:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:23 INFO - Display Serial Number: 1600x1200 60 04:44:23 INFO - Main Display: Yes 04:44:23 INFO - Mirror: Off 04:44:23 INFO - Online: Yes 04:44:23 INFO - Rotation: Supported 04:44:23 INFO - Return code: 0 04:44:23 INFO - Running post-action listener: _resource_record_post_action 04:44:23 INFO - [mozharness: 2017-01-20 12:44:23.812564Z] Finished run-tests step (success) 04:44:23 INFO - Running post-run listener: _resource_record_post_run 04:44:23 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37757952; Write bytes: 552348160; Read time: 243; Write time: 1660 04:44:23 INFO - TinderboxPrint: CPU usage
53.8% 04:44:23 INFO - TinderboxPrint: I/O read bytes / time
37,757,952 / 243 04:44:23 INFO - TinderboxPrint: I/O write bytes / time
552,348,160 / 1,660 04:44:23 INFO - TinderboxPrint: CPU idle
2,221.6 (46.2%) 04:44:23 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 04:44:23 INFO - TinderboxPrint: CPU user
1,625.2 (33.8%) 04:44:23 INFO - TinderboxPrint: Swap in / out
288,702,464 / 0 04:44:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 228628992; Write bytes: 225859584; Read time: 16254; Write time: 496 04:44:23 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36815872; Write bytes: 296272384; Read time: 230; Write time: 1096 04:44:24 INFO - Running post-run listener: _upload_blobber_files 04:44:24 INFO - Blob upload gear active. 04:44:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:24 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 04:44:24 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'] 04:44:24 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 04:44:24 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:44:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:26 INFO - (blobuploader) - INFO - Done attempting. 04:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:28 INFO - (blobuploader) - INFO - Done attempting. 04:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:29 INFO - (blobuploader) - INFO - Done attempting. 04:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:33 INFO - (blobuploader) - INFO - Done attempting. 04:44:33 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:33 INFO - Return code: 0 04:44:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5841f454923f2ff48e5715315a1c46b0fdf8b10ec522e7b07794a06058ac8a52652d8c7c353f78526e7d777c6e6b9442b6bc881110e61ab80eb340121aaf1e95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cbd1542554283668d7c927ed236b1972ea2cdf5fc2987e2a48c41e7f8ac174264e76b1779425891680e3aab283fe5b4c9db01e1bf9d02a1c577150207e60d7fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8ae7d64754aeb3e090694f102e37742bd5e59404a10ce7d20a1e6abf5b01d64664b8e216b2c5de8209fb02c9053e4743b11c7e2a70e2f2141c9f7fac5089b1c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/41de3e27bd5b569253ed26c6aa474b502c64dc76b52e88d7ccd3d57c20fbfc1b2678e531b26248501b731aaef97b73721e2abf32cfe992f006108188eb0f0e80"} 04:44:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:33 INFO - Contents: 04:44:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/5841f454923f2ff48e5715315a1c46b0fdf8b10ec522e7b07794a06058ac8a52652d8c7c353f78526e7d777c6e6b9442b6bc881110e61ab80eb340121aaf1e95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cbd1542554283668d7c927ed236b1972ea2cdf5fc2987e2a48c41e7f8ac174264e76b1779425891680e3aab283fe5b4c9db01e1bf9d02a1c577150207e60d7fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8ae7d64754aeb3e090694f102e37742bd5e59404a10ce7d20a1e6abf5b01d64664b8e216b2c5de8209fb02c9053e4743b11c7e2a70e2f2141c9f7fac5089b1c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/41de3e27bd5b569253ed26c6aa474b502c64dc76b52e88d7ccd3d57c20fbfc1b2678e531b26248501b731aaef97b73721e2abf32cfe992f006108188eb0f0e80"} 04:44:33 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:33 INFO - Copying logs to upload dir... 04:44:33 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.578545 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-01-20 04:44:33.247935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 04:44:33.251466) ========= 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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/5841f454923f2ff48e5715315a1c46b0fdf8b10ec522e7b07794a06058ac8a52652d8c7c353f78526e7d777c6e6b9442b6bc881110e61ab80eb340121aaf1e95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cbd1542554283668d7c927ed236b1972ea2cdf5fc2987e2a48c41e7f8ac174264e76b1779425891680e3aab283fe5b4c9db01e1bf9d02a1c577150207e60d7fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8ae7d64754aeb3e090694f102e37742bd5e59404a10ce7d20a1e6abf5b01d64664b8e216b2c5de8209fb02c9053e4743b11c7e2a70e2f2141c9f7fac5089b1c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/41de3e27bd5b569253ed26c6aa474b502c64dc76b52e88d7ccd3d57c20fbfc1b2678e531b26248501b731aaef97b73721e2abf32cfe992f006108188eb0f0e80"} build_url:https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/a-uzGB-BQcWObAMwOKfCjw/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/5841f454923f2ff48e5715315a1c46b0fdf8b10ec522e7b07794a06058ac8a52652d8c7c353f78526e7d777c6e6b9442b6bc881110e61ab80eb340121aaf1e95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cbd1542554283668d7c927ed236b1972ea2cdf5fc2987e2a48c41e7f8ac174264e76b1779425891680e3aab283fe5b4c9db01e1bf9d02a1c577150207e60d7fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8ae7d64754aeb3e090694f102e37742bd5e59404a10ce7d20a1e6abf5b01d64664b8e216b2c5de8209fb02c9053e4743b11c7e2a70e2f2141c9f7fac5089b1c8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/41de3e27bd5b569253ed26c6aa474b502c64dc76b52e88d7ccd3d57c20fbfc1b2678e531b26248501b731aaef97b73721e2abf32cfe992f006108188eb0f0e80"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 04:44:33.290408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:44:33.290829) ========= 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.vOS7ACb0wR/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.YW7zNiguOJ/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005366 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 04:44:33.339589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 04:44:33.339959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 04:44:33.340323) ========= ========= Total master_lag: 0.20 =========