builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0189 starttime: 1474653891.42 results: success (0) buildid: 20160923084600 builduid: 3c0488bddbe74bc880a26ce033a18866 revision: a18668c1ff8da7e0b6b6945a4186448762064d7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:04:51.419365) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:04:51.419816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 24 secs) (at 2016-09-23 11:04:51.420092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 24 secs) (at 2016-09-23 11:05:16.147714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 11:05:16.147976) ========= 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.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-23 11:05:16-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 31.8M=0s 2016-09-23 11:05:17 (31.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.510036 ========= master_lag: 0.68 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 11:05:17.341930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:17.342205) ========= 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.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.027631 ========= master_lag: 0.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:17.757089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-09-23 11:05:17.757389) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a18668c1ff8da7e0b6b6945a4186448762064d7c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a18668c1ff8da7e0b6b6945a4186448762064d7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-23 11:05:20,538 truncating revision to first 12 chars 2016-09-23 11:05:20,538 Setting DEBUG logging. 2016-09-23 11:05:20,538 attempt 1/10 2016-09-23 11:05:20,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a18668c1ff8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 11:05:21,174 unpacking tar archive at: fx-team-a18668c1ff8d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894945 ========= master_lag: 7.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-09-23 11:05:25.854171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:25.854436) ========= script_repo_revision: a18668c1ff8da7e0b6b6945a4186448762064d7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:25.854800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:25.855058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:05:25.898348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-23 11:05:25.898615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:05:26 INFO - MultiFileLogger online at 20160923 11:05:26 in /builds/slave/test 11:05:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:05:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:26 INFO - {'append_to_log': False, 11:05:26 INFO - 'base_work_dir': '/builds/slave/test', 11:05:26 INFO - 'blob_upload_branch': 'Fx-Team', 11:05:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:26 INFO - 'branch': 'Fx-Team', 11:05:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:26 INFO - 'config_files': ('talos/mac_config.py',), 11:05:26 INFO - 'default_actions': ('clobber', 11:05:26 INFO - 'read-buildbot-config', 11:05:26 INFO - 'download-and-extract', 11:05:26 INFO - 'populate-webroot', 11:05:26 INFO - 'create-virtualenv', 11:05:26 INFO - 'install', 11:05:26 INFO - 'run-tests'), 11:05:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:26 INFO - 'download_minidump_stackwalk': True, 11:05:26 INFO - 'download_symbols': 'ondemand', 11:05:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:26 INFO - 'installer_path': 'installer.exe', 11:05:26 INFO - 'log_level': 'info', 11:05:26 INFO - 'log_name': 'talos', 11:05:26 INFO - 'log_to_console': True, 11:05:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:05:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:05:26 INFO - 'opt_config_files': (), 11:05:26 INFO - 'pip_index': False, 11:05:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:26 INFO - 'cmd': ('bash', 11:05:26 INFO - '-c', 11:05:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:26 INFO - 'enabled': True, 11:05:26 INFO - 'halt_on_failure': False, 11:05:26 INFO - 'name': 'check_screen_resolution'},), 11:05:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:05:26 INFO - 'cmd': ('bash', 11:05:26 INFO - '-c', 11:05:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:05:26 INFO - 'enabled': True, 11:05:26 INFO - 'halt_on_failure': False, 11:05:26 INFO - 'name': 'check_screen_resolution'},), 11:05:26 INFO - 'run_cmd_checks_enabled': True, 11:05:26 INFO - 'sps_profile': False, 11:05:26 INFO - 'sps_profile_interval': 0, 11:05:26 INFO - 'suite': 'dromaeojs', 11:05:26 INFO - 'system_bits': '32', 11:05:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:26 INFO - 'title': 't-yosemite-r7-0189', 11:05:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:26 INFO - 'use_talos_json': True, 11:05:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:26 INFO - 'work_dir': 'build'} 11:05:26 INFO - [mozharness: 2016-09-23 18:05:26.098186Z] Running clobber step. 11:05:26 INFO - Running pre-action listener: _resource_record_pre_action 11:05:26 INFO - Running main action method: clobber 11:05:26 INFO - rmtree: /builds/slave/test/build 11:05:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:28 INFO - Running post-action listener: _resource_record_post_action 11:05:28 INFO - [mozharness: 2016-09-23 18:05:28.137740Z] Finished clobber step (success) 11:05:28 INFO - [mozharness: 2016-09-23 18:05:28.137937Z] Running read-buildbot-config step. 11:05:28 INFO - Running pre-action listener: _resource_record_pre_action 11:05:28 INFO - Running main action method: read_buildbot_config 11:05:28 INFO - Using buildbot properties: 11:05:28 INFO - { 11:05:28 INFO - "project": "", 11:05:28 INFO - "product": "firefox", 11:05:28 INFO - "script_repo_revision": "production", 11:05:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:05:28 INFO - "repository": "", 11:05:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:05:28 INFO - "buildid": "20160923084600", 11:05:28 INFO - "pgo_build": "False", 11:05:28 INFO - "basedir": "/builds/slave/test", 11:05:28 INFO - "buildnumber": 160, 11:05:28 INFO - "slavename": "t-yosemite-r7-0189", 11:05:28 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:05:28 INFO - "platform": "yosemite_r7", 11:05:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:05:28 INFO - "branch": "fx-team", 11:05:28 INFO - "repo_path": "integration/fx-team", 11:05:28 INFO - "revision": "a18668c1ff8da7e0b6b6945a4186448762064d7c", 11:05:28 INFO - "stage_platform": "macosx64", 11:05:28 INFO - "builduid": "3c0488bddbe74bc880a26ce033a18866", 11:05:28 INFO - "slavebuilddir": "test" 11:05:28 INFO - } 11:05:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 11:05:28 INFO - Running post-action listener: _resource_record_post_action 11:05:28 INFO - [mozharness: 2016-09-23 18:05:28.141358Z] Finished read-buildbot-config step (success) 11:05:28 INFO - [mozharness: 2016-09-23 18:05:28.141422Z] Running download-and-extract step. 11:05:28 INFO - Running pre-action listener: _resource_record_pre_action 11:05:28 INFO - Running main action method: download_and_extract 11:05:28 INFO - mkdir: /builds/slave/test/build/tests 11:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:05:28 INFO - trying https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 11:05:28 INFO - Downloading https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 11:05:29 INFO - Downloaded 1199 bytes. 11:05:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:05:29 INFO - Using the following test package requirements: 11:05:29 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:05:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 11:05:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 11:05:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'jsshell-mac.zip'], 11:05:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 11:05:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:05:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 11:05:29 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 11:05:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 11:05:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:05:29 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 11:05:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:05:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:05:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:05:29 INFO - Fetch https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:05:29 INFO - Expected file size: 16438930 11:05:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:05:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:05:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:05:36 INFO - Fetch https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:05:37 INFO - Expected file size: 16438930 11:05:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 11:05:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:05:44 INFO - Fetch https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 11:05:45 INFO - Expected file size: 14414059 11:05: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')]} 11:05:45 INFO - trying https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:05:45 INFO - Downloading https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 11:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 11:05:48 INFO - Downloaded 111569822 bytes. 11:05:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:05:48 INFO - mkdir: /builds/slave/test/properties 11:05:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:48 INFO - Contents: 11:05:48 INFO - build_url:https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:05:49 INFO - Running post-action listener: _resource_record_post_action 11:05:49 INFO - Running post-action listener: set_extra_try_arguments 11:05:49 INFO - [mozharness: 2016-09-23 18:05:49.371129Z] Finished download-and-extract step (success) 11:05:49 INFO - [mozharness: 2016-09-23 18:05:49.371246Z] Running populate-webroot step. 11:05:49 INFO - Running pre-action listener: _resource_record_pre_action 11:05:49 INFO - Running main action method: populate_webroot 11:05:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:49 INFO - '--tppagecycles', 11:05:49 INFO - '7'], 11:05:49 INFO - 'tests': ['tsvgm']}}, 11:05:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['damp', 'tps']}, 11:05:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'tests': ['damp', 'tps']}, 11:05:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['dromaeo_dom']}, 11:05:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['basic_compositor_video']}, 11:05:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:05:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['a11yr', 11:05:49 INFO - 'ts_paint', 11:05:49 INFO - 'tpaint', 11:05:49 INFO - 'sessionrestore', 11:05:49 INFO - 'sessionrestore_no_auto_restore', 11:05:49 INFO - 'tabpaint']}, 11:05:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['tsvgx', 11:05:49 INFO - 'tsvgr_opacity', 11:05:49 INFO - 'tart', 11:05:49 INFO - 'tscrollx', 11:05:49 INFO - 'cart']}, 11:05:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:49 INFO - 'tsvgr_opacity', 11:05:49 INFO - 'tart', 11:05:49 INFO - 'tscrollx', 11:05:49 INFO - 'cart']}, 11:05:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'talos_options': ['--disable-e10s'], 11:05:49 INFO - 'tests': ['tp5o']}, 11:05:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'tests': ['tp5o']}, 11:05:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'talos_options': ['--disable-e10s', 11:05:49 INFO - '--xperf_path', 11:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:49 INFO - 'tests': ['tp5n']}, 11:05:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:49 INFO - 'talos_options': ['--xperf_path', 11:05:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:49 INFO - 'tests': ['tp5n']}}, 11:05:49 INFO - 'talos.zip': {'path': '', 11:05:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:49 INFO - Running post-action listener: _resource_record_post_action 11:05:49 INFO - [mozharness: 2016-09-23 18:05:49.390204Z] Finished populate-webroot step (success) 11:05:49 INFO - [mozharness: 2016-09-23 18:05:49.390315Z] Running create-virtualenv step. 11:05:49 INFO - Running pre-action listener: _resource_record_pre_action 11:05:49 INFO - Running main action method: create_virtualenv 11:05:49 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:49 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 11:05:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:49 INFO - Using real prefix '/tools/python27' 11:05:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:53 INFO - Installing pip.................done. 11:05:53 INFO - Return code: 0 11:05:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:53 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')]} 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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')]} 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:05:53 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 11:05:53 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 11:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:53 INFO - 'HOME': '/Users/cltbld', 11:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:53 INFO - 'LOGNAME': 'cltbld', 11:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:53 INFO - 'MOZ_NO_REMOTE': '1', 11:05:53 INFO - 'NO_EM_RESTART': '1', 11:05:53 INFO - 'PAGER': '/bin/cat', 11:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:53 INFO - 'PWD': '/builds/slave/test', 11:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:53 INFO - 'SHELL': '/bin/bash', 11:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:05:53 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:53 INFO - 'USER': 'cltbld', 11:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:53 INFO - 'XPC_FLAGS': '0x0', 11:05:53 INFO - 'XPC_SERVICE_NAME': '0', 11:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:53 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 11:05:53 INFO - Cleaning up... 11:05:53 INFO - Return code: 0 11:05:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05:53 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')]} 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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')]} 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:05:53 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 11:05:53 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 11:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:53 INFO - 'HOME': '/Users/cltbld', 11:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:53 INFO - 'LOGNAME': 'cltbld', 11:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:53 INFO - 'MOZ_NO_REMOTE': '1', 11:05:53 INFO - 'NO_EM_RESTART': '1', 11:05:53 INFO - 'PAGER': '/bin/cat', 11:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:53 INFO - 'PWD': '/builds/slave/test', 11:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:53 INFO - 'SHELL': '/bin/bash', 11:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:05:53 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:53 INFO - 'USER': 'cltbld', 11:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:53 INFO - 'XPC_FLAGS': '0x0', 11:05:53 INFO - 'XPC_SERVICE_NAME': '0', 11:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:53 INFO - Downloading/unpacking psutil>=3.1.1 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:57 INFO - Installing collected packages: psutil 11:05:57 INFO - Running setup.py install for psutil 11:05:57 INFO - building 'psutil._psutil_osx' extension 11:05:57 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 11:05:57 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 11:05:57 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 11:05:57 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 11:05:58 INFO - building 'psutil._psutil_posix' extension 11:05:58 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 11:05:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:05:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:05:58 INFO - ^ 11:05:58 INFO - 1 warning generated. 11:05:58 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 11:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:58 INFO - Successfully installed psutil 11:05:58 INFO - Cleaning up... 11:05:58 INFO - Return code: 0 11:05:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:58 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')]} 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 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')]} 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:58 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:05:58 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 11:05:58 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 11:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:05:58 INFO - 'HOME': '/Users/cltbld', 11:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:05:58 INFO - 'LOGNAME': 'cltbld', 11:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:58 INFO - 'MOZ_NO_REMOTE': '1', 11:05:58 INFO - 'NO_EM_RESTART': '1', 11:05:58 INFO - 'PAGER': '/bin/cat', 11:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:58 INFO - 'PWD': '/builds/slave/test', 11:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:05:58 INFO - 'SHELL': '/bin/bash', 11:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:05:58 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:05:58 INFO - 'USER': 'cltbld', 11:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:58 INFO - 'XPC_FLAGS': '0x0', 11:05:58 INFO - 'XPC_SERVICE_NAME': '0', 11:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:06:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:06:01 INFO - Installing collected packages: mozsystemmonitor 11:06:01 INFO - Running setup.py install for mozsystemmonitor 11:06:01 INFO - Successfully installed mozsystemmonitor 11:06:01 INFO - Cleaning up... 11:06:01 INFO - Return code: 0 11:06:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:06:01 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')]} 11:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:01 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')]} 11:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:01 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06:01 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 11:06:01 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 11:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:01 INFO - 'HOME': '/Users/cltbld', 11:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:01 INFO - 'LOGNAME': 'cltbld', 11:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:01 INFO - 'MOZ_NO_REMOTE': '1', 11:06:01 INFO - 'NO_EM_RESTART': '1', 11:06:01 INFO - 'PAGER': '/bin/cat', 11:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:01 INFO - 'PWD': '/builds/slave/test', 11:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:01 INFO - 'SHELL': '/bin/bash', 11:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:01 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:01 INFO - 'USER': 'cltbld', 11:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:01 INFO - 'XPC_FLAGS': '0x0', 11:06:01 INFO - 'XPC_SERVICE_NAME': '0', 11:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:06:01 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 11:06:01 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 11:06:01 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 11:06:01 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 11:06:01 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 11:06:01 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 11:06:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:06:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:06:04 INFO - warning: no files found matching '*.txt' 11:06:04 INFO - no previously-included directories found matching 'build' 11:06:04 INFO - no previously-included directories found matching 'dist' 11:06:04 INFO - no previously-included directories found matching '.git*' 11:06:04 INFO - Installing collected packages: jsonschema, functools32 11:06:04 INFO - Running setup.py install for functools32 11:06:04 INFO - warning: no files found matching '*.txt' 11:06:04 INFO - no previously-included directories found matching 'build' 11:06:04 INFO - no previously-included directories found matching 'dist' 11:06:04 INFO - no previously-included directories found matching '.git*' 11:06:04 INFO - Successfully installed jsonschema functools32 11:06:04 INFO - Cleaning up... 11:06:04 INFO - Return code: 0 11:06:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06: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 11:06: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 11:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:04 INFO - 'HOME': '/Users/cltbld', 11:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:04 INFO - 'LOGNAME': 'cltbld', 11:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:04 INFO - 'MOZ_NO_REMOTE': '1', 11:06:04 INFO - 'NO_EM_RESTART': '1', 11:06:04 INFO - 'PAGER': '/bin/cat', 11:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:04 INFO - 'PWD': '/builds/slave/test', 11:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:04 INFO - 'SHELL': '/bin/bash', 11:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:04 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:04 INFO - 'USER': 'cltbld', 11:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:04 INFO - 'XPC_FLAGS': '0x0', 11:06:04 INFO - 'XPC_SERVICE_NAME': '0', 11:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:06:04 INFO - Cleaning up... 11:06:04 INFO - Return code: 0 11:06:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06: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 11:06: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 11:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:04 INFO - 'HOME': '/Users/cltbld', 11:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:04 INFO - 'LOGNAME': 'cltbld', 11:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:04 INFO - 'MOZ_NO_REMOTE': '1', 11:06:04 INFO - 'NO_EM_RESTART': '1', 11:06:04 INFO - 'PAGER': '/bin/cat', 11:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:04 INFO - 'PWD': '/builds/slave/test', 11:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:04 INFO - 'SHELL': '/bin/bash', 11:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:04 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:04 INFO - 'USER': 'cltbld', 11:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:04 INFO - 'XPC_FLAGS': '0x0', 11:06:04 INFO - 'XPC_SERVICE_NAME': '0', 11:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:06:05 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 11:06:05 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 11:06:05 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 11:06:05 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 11:06:05 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 11:06:05 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 11:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 11:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:06:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:06:08 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 11:06:08 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 11:06:08 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 11:06:08 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 11:06:08 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 11:06:08 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 11:06:08 INFO - Downloading docopt-0.6.1.tar.gz 11:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:06:08 INFO - Running setup.py install for blobuploader 11:06:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:06:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:06:09 INFO - Running setup.py install for requests 11:06:09 INFO - Running setup.py install for docopt 11:06:09 INFO - Successfully installed blobuploader requests docopt 11:06:09 INFO - Cleaning up... 11:06:09 INFO - Return code: 0 11:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06: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 11:06: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 11:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:09 INFO - 'HOME': '/Users/cltbld', 11:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:09 INFO - 'LOGNAME': 'cltbld', 11:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:09 INFO - 'MOZ_NO_REMOTE': '1', 11:06:09 INFO - 'NO_EM_RESTART': '1', 11:06:09 INFO - 'PAGER': '/bin/cat', 11:06:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:09 INFO - 'PWD': '/builds/slave/test', 11:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:09 INFO - 'SHELL': '/bin/bash', 11:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:09 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:09 INFO - 'USER': 'cltbld', 11:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:09 INFO - 'XPC_FLAGS': '0x0', 11:06:09 INFO - 'XPC_SERVICE_NAME': '0', 11:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-54r0uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4D9TPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-L1diCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-C6R8dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-8e6PSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-KZNhce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-PgB2No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Ql8Vy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:10 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-FCQ0GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-O94ghn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-bT8mLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-a3maBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-xMw_i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-UC8snN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-i9TkzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-4HObOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:11 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-k4DoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:06:11 INFO - Running setup.py install for manifestparser 11:06:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:06:12 INFO - Running setup.py install for mozcrash 11:06:12 INFO - Running setup.py install for mozdebug 11:06:12 INFO - Running setup.py install for mozdevice 11:06:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:06:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:06:12 INFO - Running setup.py install for mozfile 11:06:12 INFO - Running setup.py install for mozhttpd 11:06:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:06:12 INFO - Running setup.py install for mozinfo 11:06:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:06:12 INFO - Running setup.py install for mozInstall 11:06:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Running setup.py install for mozleak 11:06:13 INFO - Running setup.py install for mozlog 11:06:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Running setup.py install for moznetwork 11:06:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Running setup.py install for mozprocess 11:06:13 INFO - Running setup.py install for mozprofile 11:06:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:06:13 INFO - Running setup.py install for mozrunner 11:06:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:06:14 INFO - Running setup.py install for mozscreenshot 11:06:14 INFO - Running setup.py install for moztest 11:06:14 INFO - Running setup.py install for mozversion 11:06:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:06:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:06:14 INFO - Cleaning up... 11:06:14 INFO - Return code: 0 11:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06: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 11:06: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 11:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:14 INFO - 'HOME': '/Users/cltbld', 11:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:14 INFO - 'LOGNAME': 'cltbld', 11:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:14 INFO - 'MOZ_NO_REMOTE': '1', 11:06:14 INFO - 'NO_EM_RESTART': '1', 11:06:14 INFO - 'PAGER': '/bin/cat', 11:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:14 INFO - 'PWD': '/builds/slave/test', 11:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:14 INFO - 'SHELL': '/bin/bash', 11:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:14 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:14 INFO - 'USER': 'cltbld', 11:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:14 INFO - 'XPC_FLAGS': '0x0', 11:06:14 INFO - 'XPC_SERVICE_NAME': '0', 11:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:06:14 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Dsa6nT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:06: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)) 11:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:06:14 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-NGP1Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-5iX0wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:06:15 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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-3rzP5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-H6QJWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:06:15 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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-fTnzrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:06:15 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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-vRWDHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:06: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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-DLyemv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:06: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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-1OvtKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:06: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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-ahMC3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:06: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)) 11:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:06:15 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-hqJbeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:06: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)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-qJh0yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-NZ3fEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:06:16 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)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-bBOrkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-lXvnTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:06:16 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)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-Spt9V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:06:16 INFO - Running setup.py (path:/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/pip-NIuuLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:06: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)) 11:06: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:06: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)) 11:06: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:06:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06: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 11:06:19 INFO - Downloading blessings-1.6.tar.gz 11:06:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:06:19 INFO - Installing collected packages: blessings 11:06:19 INFO - Running setup.py install for blessings 11:06:19 INFO - Successfully installed blessings 11:06:19 INFO - Cleaning up... 11:06:19 INFO - Return code: 0 11:06:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:19 INFO - Reading from file tmpfile_stdout 11:06:19 INFO - Current package versions: 11:06:19 INFO - blessings == 1.6 11:06:19 INFO - blobuploader == 1.2.4 11:06:19 INFO - docopt == 0.6.1 11:06:19 INFO - functools32 == 3.2.3-2 11:06:19 INFO - jsonschema == 2.5.1 11:06:19 INFO - manifestparser == 1.1 11:06:19 INFO - mozInstall == 1.12 11:06:19 INFO - mozcrash == 0.17 11:06:19 INFO - mozdebug == 0.1 11:06:19 INFO - mozdevice == 0.48 11:06:19 INFO - mozfile == 1.2 11:06:19 INFO - mozhttpd == 0.7 11:06:19 INFO - mozinfo == 0.9 11:06:19 INFO - mozleak == 0.1 11:06:19 INFO - mozlog == 3.4 11:06:19 INFO - moznetwork == 0.27 11:06:19 INFO - mozprocess == 0.23 11:06:19 INFO - mozprofile == 0.28 11:06:19 INFO - mozrunner == 6.12 11:06:19 INFO - mozscreenshot == 0.1 11:06:19 INFO - mozsystemmonitor == 0.3 11:06:19 INFO - moztest == 0.7 11:06:19 INFO - mozversion == 1.4 11:06:19 INFO - psutil == 3.1.1 11:06:19 INFO - requests == 1.2.3 11:06:19 INFO - wsgiref == 0.1.2 11:06:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06:19 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 11:06:19 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 11:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:19 INFO - 'HOME': '/Users/cltbld', 11:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:19 INFO - 'LOGNAME': 'cltbld', 11:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:19 INFO - 'MOZ_NO_REMOTE': '1', 11:06:19 INFO - 'NO_EM_RESTART': '1', 11:06:19 INFO - 'PAGER': '/bin/cat', 11:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:19 INFO - 'PWD': '/builds/slave/test', 11:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:19 INFO - 'SHELL': '/bin/bash', 11:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:19 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:19 INFO - 'USER': 'cltbld', 11:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:19 INFO - 'XPC_FLAGS': '0x0', 11:06:19 INFO - 'XPC_SERVICE_NAME': '0', 11:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 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)) 11:06:19 INFO - Cleaning up... 11:06:19 INFO - Return code: 0 11:06:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:06: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')]} 11:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06: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')]} 11:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:06:19 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 0x11048b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110401570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6ea4c8550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, '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.SvYoPepBri/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.gwLHOsUSVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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 11:06:19 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 11:06:19 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 11:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:19 INFO - 'HOME': '/Users/cltbld', 11:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:19 INFO - 'LOGNAME': 'cltbld', 11:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:19 INFO - 'MOZ_NO_REMOTE': '1', 11:06:19 INFO - 'NO_EM_RESTART': '1', 11:06:19 INFO - 'PAGER': '/bin/cat', 11:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:19 INFO - 'PWD': '/builds/slave/test', 11:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:19 INFO - 'SHELL': '/bin/bash', 11:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:19 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:19 INFO - 'USER': 'cltbld', 11:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:19 INFO - 'XPC_FLAGS': '0x0', 11:06:19 INFO - 'XPC_SERVICE_NAME': '0', 11:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:06:20 INFO - Cleaning up... 11:06:20 INFO - Return code: 0 11:06:20 INFO - Running post-action listener: _resource_record_post_action 11:06:20 INFO - Running post-action listener: _start_resource_monitoring 11:06:20 INFO - Starting resource monitoring. 11:06:20 INFO - [mozharness: 2016-09-23 18:06:20.278919Z] Finished create-virtualenv step (success) 11:06:20 INFO - [mozharness: 2016-09-23 18:06:20.279961Z] Running install step. 11:06:20 INFO - Running pre-action listener: _resource_record_pre_action 11:06:20 INFO - Running main action method: install 11:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:20 INFO - Reading from file tmpfile_stdout 11:06:20 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:20 INFO - Reading from file tmpfile_stdout 11:06:20 INFO - Output received: 11:06:20 INFO - Usage: mozinstall [options] installer 11:06:20 INFO - Options: 11:06:20 INFO - -h, --help show this help message and exit 11:06:20 INFO - -d DEST, --destination=DEST 11:06:20 INFO - Directory to install application into. [default: 11:06:20 INFO - "/builds/slave/test"] 11:06:20 INFO - --app=APP Application being installed. [default: firefox] 11:06:20 INFO - mkdir: /builds/slave/test/build/application 11:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:06:54 INFO - Reading from file tmpfile_stdout 11:06:54 INFO - Output received: 11:06:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:06:54 INFO - Running post-action listener: _resource_record_post_action 11:06:54 INFO - [mozharness: 2016-09-23 18:06:54.559266Z] Finished install step (success) 11:06:54 INFO - [mozharness: 2016-09-23 18:06:54.559401Z] Running run-tests step. 11:06:54 INFO - Running pre-action listener: _resource_record_pre_action 11:06:54 INFO - Running main action method: run_tests 11:06:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:06:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:06:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:06:54 INFO - 2016-09-23 11:06:54.574 screenresolution[1643:8158] starting screenresolution argv=screenresolution get 11:06:54 INFO - 2016-09-23 11:06:54.576 screenresolution[1643:8158] Display 0: 1600x1200x32@60 11:06:54 INFO - 2016-09-23 11:06:54.582 screenresolution[1644:8160] starting screenresolution argv=screenresolution list 11:06:54 INFO - Available Modes on Display 0 11:06:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:06:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:06:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:06:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:06:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:06:54 INFO - Intel Iris: 11:06:54 INFO - Chipset Model: Intel Iris 11:06:54 INFO - Type: GPU 11:06:54 INFO - Bus: Built-In 11:06:54 INFO - VRAM (Dynamic, Max): 1536 MB 11:06:54 INFO - Vendor: Intel (0x8086) 11:06:54 INFO - Device ID: 0x0a2e 11:06:54 INFO - Revision ID: 0x0009 11:06:54 INFO - Displays: 11:06:54 INFO - Display: 11:06:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:06:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:06:54 INFO - Display Serial Number: 1600x1200 60 11:06:54 INFO - Main Display: Yes 11:06:54 INFO - Mirror: Off 11:06:54 INFO - Online: Yes 11:06:54 INFO - Rotation: Supported 11:06:54 INFO - Return code: 0 11:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:54 INFO - Python 2.7.3 11:06:54 INFO - Return code: 0 11:06:54 INFO - grabbing minidump binary from tooltool 11:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:06:54 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 0x11029fd30>, '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 0x1100c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110297b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:54 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 11:06:54 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 11:06:54 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 11:06:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:54 INFO - Return code: 0 11:06:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:06:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:06:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 11:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0189 --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 11:06:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SvYoPepBri/Render', 11:06:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:06:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:06:54 INFO - 'HOME': '/Users/cltbld', 11:06:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:06:54 INFO - 'LOGNAME': 'cltbld', 11:06:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:54 INFO - 'MOZ_NO_REMOTE': '1', 11:06:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:54 INFO - 'NO_EM_RESTART': '1', 11:06:54 INFO - 'PAGER': '/bin/cat', 11:06:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:54 INFO - 'PWD': '/builds/slave/test', 11:06:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:06:54 INFO - 'SHELL': '/bin/bash', 11:06:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gwLHOsUSVM/Listeners', 11:06:54 INFO - 'TMPDIR': '/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/', 11:06:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:06:54 INFO - 'USER': 'cltbld', 11:06:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:06:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:54 INFO - 'XPC_FLAGS': '0x0', 11:06:54 INFO - 'XPC_SERVICE_NAME': '0', 11:06:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:06:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0189', '--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 11:06:55 INFO - mozversion application_buildid: 20160923084600 11:06:55 INFO - mozversion application_changeset: a18668c1ff8da7e0b6b6945a4186448762064d7c 11:06:55 INFO - mozversion application_display_name: Nightly 11:06:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:55 INFO - mozversion application_name: Firefox 11:06:55 INFO - mozversion application_remotingname: firefox 11:06:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:06:55 INFO - mozversion application_vendor: Mozilla 11:06:55 INFO - mozversion application_version: 52.0a1 11:06:55 INFO - mozversion platform_buildid: 20160923084600 11:06:55 INFO - mozversion platform_changeset: a18668c1ff8da7e0b6b6945a4186448762064d7c 11:06:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:06:55 INFO - mozversion platform_version: 52.0a1 11:06:55 INFO - using testdate: 1474654015 11:06:55 INFO - actual date: 1474654015 11:06:55 INFO - starting webserver on 'localhost:49272' 11:06:55 INFO - SUITE-START | Running 2 tests 11:06:55 INFO - TEST-START | dromaeo_css 11:06:55 INFO - operating with platform_type : mac_ 11:06:55 INFO - Initialising browser for dromaeo_css test... 11:06:55 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpz1puB2/profile http://localhost:49272/getInfo.html) 11:06:57 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 11:06:57 INFO - PROCESS | 1654 | colorDepth:24 11:06:57 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 11:06:57 INFO - PROCESS | 1654 | __metrics 11:06:57 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:06:57 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:58 INFO - TEST-INFO | 1654: exit 0 11:06:58 INFO - Browser initialized. 11:06:58 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:58 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmpz1puB2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:07:10 INFO - PROCESS | 1657 | RSS: Main: 235724800 11:07:10 INFO - PROCESS | 1657 | 11:08:01 INFO - PROCESS | 1657 | 1474654081907 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:10:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 11:10:14 INFO - PROCESS | 1657 | RSS: Main: 363819008 11:10:14 INFO - PROCESS | 1657 | 11:13:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 11:13:18 INFO - PROCESS | 1657 | RSS: Main: 372961280 11:13:18 INFO - PROCESS | 1657 | 11:16:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 11:16:21 INFO - PROCESS | 1657 | RSS: Main: 337121280 11:16:21 INFO - PROCESS | 1657 | 11:19:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 11:19:24 INFO - PROCESS | 1657 | RSS: Main: 338612224 11:19:24 INFO - PROCESS | 1657 | 11:22:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 11:22:28 INFO - PROCESS | 1657 | RSS: Main: 328384512 11:22:28 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 11:25:32 INFO - PROCESS | 1657 | RSS: Main: 375394304 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | __start_tp_report 11:25:32 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 11:25:32 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 11:25:32 INFO - PROCESS | 1657 | |i|pagename|runs| 11:25:32 INFO - PROCESS | 1657 | |0;dojo.html;3288.6546912574177;3291.753118516111;3314.966850331496;3333.6499667534895;3375.7130643895266;5431.972840135803;5514.393416724167;5576.358718747345;5639.802606908759;5670.149477578365;5509.696966666832;5592.273004509419;5694.601377903548;5705.457981491762;5707.086866101425;4630.513796051417;5062.873428164288;5072.771725272353;5122.334096567441;5139.9720055988955;5134.25553294772;5199.402068762084;5202.635815492917;5206.947930520703;5258.1849813279005;5041.2438134280155;5178.5857131429775;5180.248863914749;5202.193659982709;5231.032259032091;5086.669366491166;5087.592992560586;5143.228515722634;5145.99653067652;5148.948510514884;5078.64449488536;5136.922946155811;5145.897082058375;5150.819721309774;5167.0957582422925;5622.746976386073;5632.04255276604;5641.5204707599905;5660.122680984454;5674.886502269973;5969.194158788551;5976.671283079429;6005.729742161613;6156.353582873823;6167.074938759177;6108.190302030417;6151.907721384183;6154.938450615481;6181.041938499539;6221.097940798559;5649.0396632572565;5656.9151462728505;5668.433156684381;5669.914951275693;5683.318001839764;6188.257409110845;6200;6255.093011513305;6269;6279.717412716439;5880.176775251468;5894.823155305347;5909.025010873243;6001.819945401645;6064.969675151596;6135.987562052212;6138.294096178996;6148.815535533851;6190.628562286187;6213.937860621426;6091.746053960063;6121.051237058263;6131.601445906091;6133;6143.170671959318;6003.489703375175;6078.939210607838;6081.695915204222;6138.425628698416;6173.197484327098;4779.402574678165;4837.177679794443;4839.661223714376;4842.958763865786;4848.321235027099;4335.82656693735;4341.044970106572;4365.257906155897;4367.67242456817;4381.123775244963;5506.614536982453;5625.38120806711;5635.492805647429;5651.463111004448;5660.575456840754;6096.798833414304;6140.969295153495;6145.8156255312415;6146.877062458726;6187.226596675416;5649.576281778883;5658.688772117491;5658.971705141448;5665.49010589049;5700.287464066992;5240.973795131;5249.370075590953;5259.158534634516;5276.894462110813;5316.3354580677415;6152.323244443108;6199.256089269316;6199.318075011655;6203.8138855834395;6223.066540019034;6193.977993631001;6203.937960620336;6221.3156552780065;6221.595596286227;6232.470240029648;6250.781222657185;6254.687265636791;6260.530460215411;6272.466840318624;6281.874362512633;5960.642361458326;5995.520358371407;6013.669248191217;6037.335893051849;6109.450149486567;6109.34393638171;6194.225721784777;6197.504199663926;6198.535109866868;6199.597026193283;5954.518103744152;6018.127371531191;6025.427584379477;6036.788712395045;6077.696115194134;5737.139429085671;5908.940910591011;5989.460948514655;5993.430624090704;5997.370276120944;5777.62445441045;5804.6807425590305;5810.6513609183585;5850.473457388855;5903.409659034062;5992.64044157352;5995.940040599713;5997.280326360865;6001.159837622649;6027.849303767441;5691.601587888808;5723.998300297515;5738.282714660668;5744.167095771173;5817.854553636193 11:25:32 INFO - PROCESS | 1657 | |1;ext.html;450.6552487347179;486.57667828988787;535.3415299182006;545.5335687986772;573.8307199376184;30381.08856734296;40143.39784903225;41362.58637413633;41392.586074139246;43743;42503.937401564974;42635.573644263546;42715;42952.785236073774;42976.57023429765;8611;9583.329166958298;9750;9761.609535618567;9775.804483910317;8644.308455323559;11729.941350293278;12020.278783272988;12039.157258991874;12313.322767247797;11870.52517899283;11937.820932686016;11944.7611047779;11961.401929903514;12065.155439119266;11852.525898964032;11925.403729813475;11969.700757481132;11973.102017348647;11976.341301228429;11751.001164900994;11830.763384732258;11844.40777961107;11844.644660660195;11851.288922664582;39939.60060399388;40054.799726001474;40294.992625184605;40309.99225019369;40393.79803100995;3243.2378391078078;3392.694657480814;3421.1447138215444;3644.599094099647;4008.178323443716;29529.557056644167;31007.534886976715;31088.844555777076;31100.8444957776;31187.84406077978;3175.3649270145834;3303.96696033039;3337.0989832745267;3354.463285874273;3384.187794929224;378049;379039;379658.10170949245;380589;381142;57494.7125264371;57917;57971.420285797445;58009.70995144997;58091.70954145202;59039.70480147572;59192;59193.70403147957;59216;59419.40580594139;15231.619209519851;15417.997830141005;15429.614259643598;15439.150846703315;15442.768358474406;10831.458427078614;11065;11935.701607459883;11986.340751258764;12023.338716370508;13583.796243056164;14742.18917959501;14946.878984076238;15096.320665569856;15140.318685659171;5484.044246379124;6486.643234622046;6550.7707230246715;6567.310432404529;6611.933880661228;851.7402192331399;941.580996456584;998.7553049502773;1035.808375450544;1109.9944500277609;29248.268793279913;29462.263443414085;29635.192599408238;29784.553231701542;29838;892;1039.262123892045;1046.706922061824;1109.9556017759198;1122.820348744197;14844.92577537127;15289.541313760605;15345.30946107428;15652.4521641742;15656;643380.0478978457;646339.5245356523;647496;647607;651629;56443.71778141083;56838.7158064207;56840.578985524866;57072.14391784126;57097;1234.0682784497826;1270.2568997136593;1341.4701193028504;1370.6093763277418;1388.3266615691584;29653.555196671634;30386.392272154877;30618.15824252603;31073.68926310708;31309.53035704421;48023.5197648033;48524.757376212896;48605;48606.513934860195;49033.50966490289;541898;542372;544598;546345;607699.9615001896;19882.403527894185;24759.62860557057;25009.49981000406;25031;25136.62295065539;43328.56671433245;43541.78229108961;43941;44058.77970610127;45007.77496112498;36677.449838251916;36728.81635591805;37299.254014920094;37882.43176352302;38092.80953595325;35553.95582750887;36630.26739465249;36968.44547331846;37393.813030934674;37781.86654400372;35574.82212588921;35681.36866595884;36267.91196264116;36382.8180859094;36469.817650912635;31889.043328700176;33451.665483344856;33458.832705836314;33557.83221083879;33559.83220083884;25062.37344066413;25484.362890927874;25639.871800641624;25663.615045773953;25931.611025835005 11:25:32 INFO - PROCESS | 1657 | |2;jquery.html;353.0890303018213;359.90462527430225;374.66093185666966;384.7922122054091;404.8684177642267;14803.703925921474;15148.318325675344;16005.43980960665;20356.88037157956;21109.472263193427;19819;20179.596408071866;20751.584968300624;20945;21167.894160529177;4778.54603812639;5894.174815525819;6132.662703551303;6150.723217455203;6161.630302181861;4226.936595951048;4449.976505403759;4458.910821783563;6048.274207095154;6050.727717252734;6360.618362898218;6391.936080639204;6435.452986496153;6765.695543700521;6775;5824.621399609033;6151.87696246077;6187;6188.628682279078;6819.556728812611;5214.8174813881715;6026.397360263983;6031.487323577501;6039.849003774897;6053.848653783647;11891.345975971319;12203.267803931793;12232.449539770732;12246.44890979908;12273.815892761615;2097.6329142400173;2105.5262565922544;2298.310506847939;2911.097559756461;2922.991567909068;9777.168940640055;9865.260105492045;10389.688309350731;11151.442427878656;15908.602284942854;1657.6021754778887;1812.610288787917;1874.3312181162125;1879.1543805287674;1891.1678861300984;85336;107112.46443767809;108996.45501772441;111026.44486777595;113020.43754749483;11204.271722338022;11280.887191128148;11289.209755317213;11439.542418303341;11511.884881151249;14384.424623014962;14434.855651443351;14444.494442694455;14457;14478.045463862243;8056.758297251092;8324.791880203044;8340.749777506684;8472.568609713077;8480.703175388831;8106.310963568045;8117.228863257981;8161.224683655043;8278.8344233115;8318.168183181633;4466.151431228056;4490.216066039076;4497.123061003138;4497.415336006364;4575.862724118282;1537.5541093083104;1771.973420398695;1810.7012048429394;1878.1454438230571;1963.7545306836646;766.5860435364953;904.5612877754284;910.3945875992391;921.6083164654995;1005.5123265216364;20296.188152473736;20446.897765511374;20623.175072996914;20789.480262993548;20824.210431600815;904.4302089683457;906.7370462565914;911.5214512381053;917.5274733512247;946.9147776699992;10062.345947513388;10408.895911040943;10863.45682715861;10883.401412922365;10979.396133212591;455818;468949;477612;586189;590811.0567284818;94415;108859;121136.39431802784;144470.27764861108;149803;965.8068386322623;974.8245315843217;1039.589362201926;1039.8128336899279;1045.0385645206277;13428.261445620585;18863.6227275451;19032.33386831454;19067.523311917314;19073.618527629646;51884.48115518797;52342;53348.73325633347;55003.724981376436;56051.71974140103;79675;79787;81808.93193811277;82360.64655797594;82412.58793705993;10792;10892.237543371888;11543.191976561897;11898.464569094238;12475.812862806884;11296.548138074713;13557.426296280019;13615.79576306376;13876.028677992444;14079.507217247346;5481.3970463248215;5638.746256418389;11567.537298508301;11583.189176757545;11890.34603096838;11285.379304138023;11388.886111139114;11540.422978850856;11567.710807229887;11754.823677645014;11505.712357191138;11679.824802628138;11813.527458901548;12055.69860753453;12070.517179312728;12311.507539698312;12398.25610463375;12554.372281385711;12576.245425274512;12697.492100316253;11503.654890353302;11735.154127937674;11781.234219775688;11898.881011189776;11993.580224692094 11:25:32 INFO - PROCESS | 1657 | |3;mootools.html;1470.1913947328967;1531.6630341324908;1672.5233308507063;1745.5112568480822;1931.4978105692524;8312.958435207831;8856.38005339625;8873.955630221848;8880.91119088809;8917.420367676104;7692.730754423596;7965.123836377994;7987.161348058443;8307.709230176944;8592.398532102756;1993.8903360315142;2362.574736547421;2371.774681405264;2373.8575685458927;2376.3465047112095;2317.756635553268;2331.4171457135717;2372.9406764830846;2373.2524254859663;2373.537160253751;2340.9180678676166;2351.200591798788;2366.337425520857;2371.2293504610984;2372.28831350595;2332.9650055249185;2338.7193536775526;2351.71779386473;2351.870647114408;2352.8588284702973;2335.6846825678485;2338.298510446859;2339.6841426407386;2341.1922886604093;2341.4029422497324;8667.003294621136;8681.696140635111;8743.562821858945;8786.472811631322;8806.691765788166;5106.872328191787;5143.974280128613;5256.316678831766;5285.4450282720145;5287.841364759063;3337.1323455901397;3431.9142021449416;3500.2824420993634;3511.9648803511895;3514.6309637488207;1046.989654982945;1080.2654195147297;1091.2852081886376;1103.5034234594464;1107.0424083168082;11460.426978651034;11607.013403860597;11607.4196290186;11608.245464044894;11615.825762613567;4421.137878113737;4521.389612402284;4679.508651591534;4716.151092803259;4725.929111063337;9819.803603927881;9879.259055570717;9895.307328486937;9901.603935842486;9910.45492497905;5221.347331583552;5245.580353571705;5255.894882102337;5266;5269.209618557171;4301.849435269751;4333.869983900425;4461.10777844426;4762.809487620457;4804.06320767447;3780.8298626561873;3817.8047622617105;3836.0985168485386;3928.1161738609158;3940.6847452203756;1218.9085818563465;1222.1689251309194;1222.1872454817624;1231.8398608181058;1233.4326209943526;798.2496453333847;898.3442087276325;910.900374636456;920.921721653667;949.2168960607527;4367.519572846984;4795.568398844121;5663.971680141655;5837.737301821428;5994.6403215807195;423.84502231419754;434.58931309911827;441.46141707117266;451.474032751847;453.5283305362452;3680.5399325084363;3780.243951209769;3998.4002399639703;4007.218592374459;4042.555318914917;10137.898621013843;10475.371477711209;10646.467676616137;10657.89342106569;10660.520276587573;10325.793484130276;10340.37957722539;10393.428361440194;10608.734781630521;10618.946905265424;8019.639116239783;8081.151479094728;8117.553534555656;8134.877976830352;8145.045189154679;5726.255586773693;5735.4551317624755;5780.5953583248765;5844.327902291291;5885.588008839341;9817.852732209165;9818.950905245429;9826.459544724823;9853.556589953327;9888.752781180528;9445.197158241352;9859.161971232526;9915.851262230928;10003.34978226413;10018.39889606626;6824.249332573314;7051.048108505492;7052.0479735235085;7306.707731690885;7479.065116860393;7602.809929751579;7767.3786097113225;7836.608169591384;8056.7180148694515;8182.713605024033;7319.780406587811;7475.738349157753;7482.438817088849;7559.924400756142;7579.469437139568;7099.148102227766;7258.237885021997;7264.89102663471;7311.41508679315;7348.595827229554;6804.081449004321;6855.794326170223;6866.34769696878;6942.6181560012665;6960.965195173992;3935.803209839439;4247.87256382309;4740.360051393156;4924.778384972757;5108.055009823194;4145.419641250167;4925.753712314442;5048.7475626219275;5122.950819672161;5185.792568297225 11:25:32 INFO - PROCESS | 1657 | |4;prototype.html;302.5658180510967;310.5543545012907;315.05954725145443;320.41844053043724;323.05506393798134;5096.369161868203;5168.922466163006;5181.92227116593;5182.11903976324;5211.348581427322;4718.834840780573;5149.459306772791;5156.871078223046;5162.277281180638;5188.740562971846;3133.52997050442;3629.9637003629955;3863.9806800965957;3879.650831425171;3879.8060096995177;2932.5747766573836;3908.335582950905;3937.5274967003998;3952.6245006724316;3976.633902827827;3308.2721801203697;3905.824237909301;3920.5883382244883;3924.3721004639265;3951.2097580483874;3638.2905333459985;3869.7097717671286;3914.158455931988;3941.3890846918775;3942.5860284670125;2886.4124731397646;3301.4057469655454;3371.7639765216445;3378.2061215614312;3381.4420620597816;4950.504949505057;4962.230854217602;4970.353853998993;4972.378452693413;5014.974925125351;3847.057470919615;4125.97937010316;4272.850450234227;4420;4442.97811503356;4626.7223966562115;5143.254228136937;5291.1798671206025;5337.439568845254;5375.543078838304;3242.983785081083;3681.5582130144553;3690.5017822593873;3708.9814550927344;3718.4236443351324;5255.137473956639;5574.536953785273;5625.46558076982;5639.68981706006;5647.548196144298;3221.017589635137;3505.9298814023578;3726.552813662324;3728.776273423549;3771.7548359356556;3275.4431746603136;3806.600306967784;3824.904377390532;3833.4824798652385;3840.9615903841163;4393.494748104009;4397.472303323621;4425.35832304314;4425.468943726773;4443.155800397914;4799.832005879777;5117.1322467299915;5137.6660517066275;5393.7303134843105;5438.537724293479;1155.485808815086;1283.608499407671;1305.5626365167775;1307.013205030196;1308.5812539987303;687.5015613680042;793.4802704228739;805.8025783682918;809.1908091908092;818.9672413103409;4460.397846290774;4843.104025755247;4875.95124048762;4883.316335713003;4894.339264199288;4625.722456652612;5494.917576236359;5537.418571050062;5559.415566563591;5595.804146854841;4152.778263628944;5022.242215224715;5062.797488100435;5126.846194614168;5126.948730512721;2564.8845801938955;2841.886324546995;2876.4390943765766;2927.516959701668;2940.8235505869716;4339.414179085846;5449.3460784706085;5713.14322845077;5735.053716136791;5748.971255143698;4142.896427589274;5282.3661160660195;5655.773769049192;5711.828645140569;5726.971365143231;4770.522947705271;4993.675411098267;5375.354957405137;5688.687122208318;5706.4864162225595;4903.5586797187;4985.027919555652;5220.425753167073;5554.472325129106;5631.943680563306;4991.176455884738;5036.607611384563;5108.61685373591;5444.26502422168;5457.317835270591;4684.976575117103;5039.992001599621;5318.9044435785;5716.714164291852;5748.396418376177;2897.391547774991;2976.3213108201926;3269.591301087364;3295.6652555714973;3332.416827055304;4516.954830451785;4594.880018774553;4678.953210467852;4701.132309291261;4797.75258432803;3932.115274063313;4054.4729185205733;4227.471566054243;4335.2745507397085;4505.797239124182;3718.8698395556025;3959.366501359769;3999.0002499375155;4292.570742925807;4346.67399944999;3672.412414013745;3956.7823769692945;4009.939850902297;4273.508546517191;4479.70881892689;4321.623107290915;5040.092783298895;5157.871053223699;5299.880047980839;5314.946850531445;4818.807247710192;4865.270209468608;5269.1832765921345;5269.4730526947;5291.312129423304 11:25:32 INFO - PROCESS | 1657 | |5;yui.html;552.3151292397428;754.0009487429154;774.8062984253936;798.8002999250187;801.6392623319508;15104.622384440394;15880.920595397036;15883.761743573841;15887.920560397197;16194.595135121599;14239.92880035601;14359.497417590386;14365.569032929028;14405.567832965002;14407.27963601821;695.9860802783942;717.2504732554467;721.1094298541298;855.6106971328046;862.9956850215772;853.4495250563383;893.4103491695482;895.8566629339307;912.63494602159;914.9451032938046;957.2437774158407;958.2669258017622;960.9375390599623;963.4412041016229;966.9081437263449;702.1749444402857;722.6170129831145;944.8110377924409;944.9622015119421;949.8860136783561;678.6504949950779;698.0227681246245;702.4626160986849;702.5152644675157;703.4056222491986;15139.697206055927;15181.544553663407;15187.936844420896;15211;15221.61945951349;13729.107608005448;14084.85915140856;14115.435382584685;14169.220692861889;14414.783778243334;12795;12961.287129207889;12996.610101696964;13298.268595227259;13617.455301787917;4568.931466028012;4596.218642830727;4622.046269949276;4791.760411979387;4802.471728109905;117573;118053.819461806;118528;118709.40645296805;120948;10822.621208257673;11007.834882476769;11327.433628318551;11435;11602.593909213138;22495.32514024582;22505.887470562542;22524;22525.774742252695;22546.774532254796;7378.003969464054;7806.648700808477;8131.9186808132345;8154.469959452616;8286.875696864552;4264.275073237557;4499.437570303712;4597.563231493003;4689.60138388234;4728.88177795551;3069.2326918270433;3469.7397695172963;3527.8236088195486;3594.0835087052633;3597.0827439002887;648.7340190521863;658.2200092889941;660.4089340040733;674.9898751518731;676.7157793726647;540.4811381074213;571.6370104983365;583.8948989181988;614.6508414031248;647.8704259148095;8333.8333233335;9088.318376121817;9535.47554884474;9829.4102353859;9860.06329398706;556.5742207211487;627.231641239478;637.445422482434;667.9223341500169;671.9462443004547;4295.4201182839915;4656.906861862812;4750.334953106568;4754.5007774183905;4809.702845393202;107180.46409768057;118942;154932;164260;165344.17327913284;97107.51446242724;99695.00304997002;102246.48876755718;136570;143109.28445357707;103707;104833.47583262034;105302;105453.47273263584;107143.39284910733;9454.574544145393;9665;9675.70972870815;9676.322657414195;9776.9022309776;55550;56145;57387;57545;57844.71077644585;55657.165142522084;55844;74742.62628687039;83571;86859.13140868764;12403.441845117171;12717.618471445872;12780.297083660487;13005.544805931748;13398.26309552984;13120.73758524805;14164.150150990974;14329;14786.778198327249;15112.450914283412;13376.264305463294;14069.437222511395;14243.359048843035;14243.430262789372;14376.712465750836;13281.933590331986;13636.318194087342;13797.310134493437;14120.082194657314;14128.222947737562;12949.870501294867;13439.529616463376;13598.059117690667;13598.184108953494;14052.718945621235;10447.320924139907;11243.943780281046;11373.20387572862;11800.586979455678;11846.21993985469;11288.774224515299;11418.657440276806;11427.485763140512;11524;11558.884411156117 11:25:32 INFO - PROCESS | 1657 | __end_tp_report 11:25:32 INFO - PROCESS | 1657 | __start_cc_report 11:25:32 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1163 11:25:32 INFO - PROCESS | 1657 | __end_cc_report 11:25:32 INFO - PROCESS | 1657 | __startTimestamp1474655132456__endTimestamp 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | ------- Summary: start ------- 11:25:32 INFO - PROCESS | 1657 | Number of tests: 6 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5652.94 Median:5810.65 stddev:629.77 (10.8%) stddev-sans-first:603.77 11:25:32 INFO - PROCESS | 1657 | Values: 3288.7 3291.8 3315.0 3333.6 3375.7 5432.0 5514.4 5576.4 5639.8 5670.1 5509.7 5592.3 5694.6 5705.5 5707.1 4630.5 5062.9 5072.8 5122.3 5140.0 5134.3 5199.4 5202.6 5206.9 5258.2 5041.2 5178.6 5180.2 5202.2 5231.0 5086.7 5087.6 5143.2 5146.0 5148.9 5078.6 5136.9 5145.9 5150.8 5167.1 5622.7 5632.0 5641.5 5660.1 5674.9 5969.2 5976.7 6005.7 6156.4 6167.1 6108.2 6151.9 6154.9 6181.0 6221.1 5649.0 5656.9 5668.4 5669.9 5683.3 6188.3 6200.0 6255.1 6269.0 6279.7 5880.2 5894.8 5909.0 6001.8 6065.0 6136.0 6138.3 6148.8 6190.6 6213.9 6091.7 6121.1 6131.6 6133.0 6143.2 6003.5 6078.9 6081.7 6138.4 6173.2 4779.4 4837.2 4839.7 4843.0 4848.3 4335.8 4341.0 4365.3 4367.7 4381.1 5506.6 5625.4 5635.5 5651.5 5660.6 6096.8 6141.0 6145.8 6146.9 6187.2 5649.6 5658.7 5659.0 5665.5 5700.3 5241.0 5249.4 5259.2 5276.9 5316.3 6152.3 6199.3 6199.3 6203.8 6223.1 6194.0 6203.9 6221.3 6221.6 6232.5 6250.8 6254.7 6260.5 6272.5 6281.9 5960.6 5995.5 6013.7 6037.3 6109.5 6109.3 6194.2 6197.5 6198.5 6199.6 5954.5 6018.1 6025.4 6036.8 6077.7 5737.1 5908.9 5989.5 5993.4 5997.4 5777.6 5804.7 5810.7 5850.5 5903.4 5992.6 5995.9 5997.3 6001.2 6027.8 5691.6 5724.0 5738.3 5744.2 5817.9 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:66306.76 Median:35628.10 stddev:144296.99 (405.0%) stddev-sans-first:144617.06 11:25:32 INFO - PROCESS | 1657 | Values: 450.7 486.6 535.3 545.5 573.8 30381.1 40143.4 41362.6 41392.6 43743.0 42503.9 42635.6 42715.0 42952.8 42976.6 8611.0 9583.3 9750.0 9761.6 9775.8 8644.3 11729.9 12020.3 12039.2 12313.3 11870.5 11937.8 11944.8 11961.4 12065.2 11852.5 11925.4 11969.7 11973.1 11976.3 11751.0 11830.8 11844.4 11844.6 11851.3 39939.6 40054.8 40295.0 40310.0 40393.8 3243.2 3392.7 3421.1 3644.6 4008.2 29529.6 31007.5 31088.8 31100.8 31187.8 3175.4 3304.0 3337.1 3354.5 3384.2 378049.0 379039.0 379658.1 380589.0 381142.0 57494.7 57917.0 57971.4 58009.7 58091.7 59039.7 59192.0 59193.7 59216.0 59419.4 15231.6 15418.0 15429.6 15439.2 15442.8 10831.5 11065.0 11935.7 11986.3 12023.3 13583.8 14742.2 14946.9 15096.3 15140.3 5484.0 6486.6 6550.8 6567.3 6611.9 851.7 941.6 998.8 1035.8 1110.0 29248.3 29462.3 29635.2 29784.6 29838.0 892.0 1039.3 1046.7 1110.0 1122.8 14844.9 15289.5 15345.3 15652.5 15656.0 643380.0 646339.5 647496.0 647607.0 651629.0 56443.7 56838.7 56840.6 57072.1 57097.0 1234.1 1270.3 1341.5 1370.6 1388.3 29653.6 30386.4 30618.2 31073.7 31309.5 48023.5 48524.8 48605.0 48606.5 49033.5 541898.0 542372.0 544598.0 546345.0 607700.0 19882.4 24759.6 25009.5 25031.0 25136.6 43328.6 43541.8 43941.0 44058.8 45007.8 36677.4 36728.8 37299.3 37882.4 38092.8 35554.0 36630.3 36968.4 37393.8 37781.9 35574.8 35681.4 36267.9 36382.8 36469.8 31889.0 33451.7 33458.8 33557.8 33559.8 25062.4 25484.4 25639.9 25663.6 25931.6 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:32158.77 Median:20535.04 stddev:87227.39 (424.8%) stddev-sans-first:87439.39 11:25:32 INFO - PROCESS | 1657 | Values: 353.1 359.9 374.7 384.8 404.9 14803.7 15148.3 16005.4 20356.9 21109.5 19819.0 20179.6 20751.6 20945.0 21167.9 4778.5 5894.2 6132.7 6150.7 6161.6 4226.9 4450.0 4458.9 6048.3 6050.7 6360.6 6391.9 6435.5 6765.7 6775.0 5824.6 6151.9 6187.0 6188.6 6819.6 5214.8 6026.4 6031.5 6039.8 6053.8 11891.3 12203.3 12232.4 12246.4 12273.8 2097.6 2105.5 2298.3 2911.1 2923.0 9777.2 9865.3 10389.7 11151.4 15908.6 1657.6 1812.6 1874.3 1879.2 1891.2 85336.0 107112.5 108996.5 111026.4 113020.4 11204.3 11280.9 11289.2 11439.5 11511.9 14384.4 14434.9 14444.5 14457.0 14478.0 8056.8 8324.8 8340.7 8472.6 8480.7 8106.3 8117.2 8161.2 8278.8 8318.2 4466.2 4490.2 4497.1 4497.4 4575.9 1537.6 1772.0 1810.7 1878.1 1963.8 766.6 904.6 910.4 921.6 1005.5 20296.2 20446.9 20623.2 20789.5 20824.2 904.4 906.7 911.5 917.5 946.9 10062.3 10408.9 10863.5 10883.4 10979.4 455818.0 468949.0 477612.0 586189.0 590811.1 94415.0 108859.0 121136.4 144470.3 149803.0 965.8 974.8 1039.6 1039.8 1045.0 13428.3 18863.6 19032.3 19067.5 19073.6 51884.5 52342.0 53348.7 55003.7 56051.7 79675.0 79787.0 81808.9 82360.6 82412.6 10792.0 10892.2 11543.2 11898.5 12475.8 11296.5 13557.4 13615.8 13876.0 14079.5 5481.4 5638.7 11567.5 11583.2 11890.3 11285.4 11388.9 11540.4 11567.7 11754.8 11505.7 11679.8 11813.5 12055.7 12070.5 12311.5 12398.3 12554.4 12576.2 12697.5 11503.7 11735.2 11781.2 11898.9 11993.6 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5581.86 Median:4779.19 stddev:3164.54 (66.2%) stddev-sans-first:3158.33 11:25:32 INFO - PROCESS | 1657 | Values: 1470.2 1531.7 1672.5 1745.5 1931.5 8313.0 8856.4 8874.0 8880.9 8917.4 7692.7 7965.1 7987.2 8307.7 8592.4 1993.9 2362.6 2371.8 2373.9 2376.3 2317.8 2331.4 2372.9 2373.3 2373.5 2340.9 2351.2 2366.3 2371.2 2372.3 2333.0 2338.7 2351.7 2351.9 2352.9 2335.7 2338.3 2339.7 2341.2 2341.4 8667.0 8681.7 8743.6 8786.5 8806.7 5106.9 5144.0 5256.3 5285.4 5287.8 3337.1 3431.9 3500.3 3512.0 3514.6 1047.0 1080.3 1091.3 1103.5 1107.0 11460.4 11607.0 11607.4 11608.2 11615.8 4421.1 4521.4 4679.5 4716.2 4725.9 9819.8 9879.3 9895.3 9901.6 9910.5 5221.3 5245.6 5255.9 5266.0 5269.2 4301.8 4333.9 4461.1 4762.8 4804.1 3780.8 3817.8 3836.1 3928.1 3940.7 1218.9 1222.2 1222.2 1231.8 1233.4 798.2 898.3 910.9 920.9 949.2 4367.5 4795.6 5664.0 5837.7 5994.6 423.8 434.6 441.5 451.5 453.5 3680.5 3780.2 3998.4 4007.2 4042.6 10137.9 10475.4 10646.5 10657.9 10660.5 10325.8 10340.4 10393.4 10608.7 10618.9 8019.6 8081.2 8117.6 8134.9 8145.0 5726.3 5735.5 5780.6 5844.3 5885.6 9817.9 9819.0 9826.5 9853.6 9888.8 9445.2 9859.2 9915.9 10003.3 10018.4 6824.2 7051.0 7052.0 7306.7 7479.1 7602.8 7767.4 7836.6 8056.7 8182.7 7319.8 7475.7 7482.4 7559.9 7579.5 7099.1 7258.2 7264.9 7311.4 7348.6 6804.1 6855.8 6866.3 6942.6 6961.0 3935.8 4247.9 4740.4 4924.8 5108.1 4145.4 4925.8 5048.7 5123.0 5185.8 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4203.39 Median:4555.92 stddev:1301.30 (28.6%) stddev-sans-first:1271.59 11:25:32 INFO - PROCESS | 1657 | Values: 302.6 310.6 315.1 320.4 323.1 5096.4 5168.9 5181.9 5182.1 5211.3 4718.8 5149.5 5156.9 5162.3 5188.7 3133.5 3630.0 3864.0 3879.7 3879.8 2932.6 3908.3 3937.5 3952.6 3976.6 3308.3 3905.8 3920.6 3924.4 3951.2 3638.3 3869.7 3914.2 3941.4 3942.6 2886.4 3301.4 3371.8 3378.2 3381.4 4950.5 4962.2 4970.4 4972.4 5015.0 3847.1 4126.0 4272.9 4420.0 4443.0 4626.7 5143.3 5291.2 5337.4 5375.5 3243.0 3681.6 3690.5 3709.0 3718.4 5255.1 5574.5 5625.5 5639.7 5647.5 3221.0 3505.9 3726.6 3728.8 3771.8 3275.4 3806.6 3824.9 3833.5 3841.0 4393.5 4397.5 4425.4 4425.5 4443.2 4799.8 5117.1 5137.7 5393.7 5438.5 1155.5 1283.6 1305.6 1307.0 1308.6 687.5 793.5 805.8 809.2 819.0 4460.4 4843.1 4876.0 4883.3 4894.3 4625.7 5494.9 5537.4 5559.4 5595.8 4152.8 5022.2 5062.8 5126.8 5126.9 2564.9 2841.9 2876.4 2927.5 2940.8 4339.4 5449.3 5713.1 5735.1 5749.0 4142.9 5282.4 5655.8 5711.8 5727.0 4770.5 4993.7 5375.4 5688.7 5706.5 4903.6 4985.0 5220.4 5554.5 5631.9 4991.2 5036.6 5108.6 5444.3 5457.3 4685.0 5040.0 5318.9 5716.7 5748.4 2897.4 2976.3 3269.6 3295.7 3332.4 4517.0 4594.9 4679.0 4701.1 4797.8 3932.1 4054.5 4227.5 4335.3 4505.8 3718.9 3959.4 3999.0 4292.6 4346.7 3672.4 3956.8 4009.9 4273.5 4479.7 4321.6 5040.1 5157.9 5299.9 5314.9 4818.8 4865.3 5269.2 5269.5 5291.3 11:25:32 INFO - PROCESS | 1657 | 11:25:32 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:23857.94 Median:3560.95 stddev:37746.07 (1060.0%) stddev-sans-first:37811.39 11:25:32 INFO - PROCESS | 1657 | Values: 552.3 754.0 774.8 798.8 801.6 15104.6 15880.9 15883.8 15887.9 16194.6 14239.9 14359.5 14365.6 14405.6 14407.3 696.0 717.3 721.1 855.6 863.0 853.4 893.4 895.9 912.6 914.9 957.2 958.3 960.9 963.4 966.9 702.2 722.6 944.8 945.0 949.9 678.7 698.0 702.5 702.5 703.4 15139.7 15181.5 15187.9 15211.0 15221.6 13729.1 14084.9 14115.4 14169.2 14414.8 12795.0 12961.3 12996.6 13298.3 13617.5 4568.9 4596.2 4622.0 4791.8 4802.5 117573.0 118053.8 118528.0 118709.4 120948.0 10822.6 11007.8 11327.4 11435.0 11602.6 22495.3 22505.9 22524.0 22525.8 22546.8 7378.0 7806.6 8131.9 8154.5 8286.9 4264.3 4499.4 4597.6 4689.6 4728.9 3069.2 3469.7 3527.8 3594.1 3597.1 648.7 658.2 660.4 675.0 676.7 540.5 571.6 583.9 614.7 647.9 8333.8 9088.3 9535.5 9829.4 9860.1 556.6 627.2 637.4 667.9 671.9 4295.4 4656.9 4750.3 4754.5 4809.7 107180.5 118942.0 154932.0 164260.0 165344.2 97107.5 99695.0 102246.5 136570.0 143109.3 103707.0 104833.5 105302.0 105453.5 107143.4 9454.6 9665.0 9675.7 9676.3 9776.9 55550.0 56145.0 57387.0 57545.0 57844.7 55657.2 55844.0 74742.6 83571.0 86859.1 12403.4 12717.6 12780.3 13005.5 13398.3 13120.7 14164.2 14329.0 14786.8 15112.5 13376.3 14069.4 14243.4 14243.4 14376.7 13281.9 13636.3 13797.3 14120.1 14128.2 12949.9 13439.5 13598.1 13598.2 14052.7 10447.3 11243.9 11373.2 11800.6 11846.2 11288.8 11418.7 11427.5 11524.0 11558.9 11:25:32 INFO - PROCESS | 1657 | -------- Summary: end -------- 11:25:32 INFO - PROCESS | 1657 | 11:25:33 INFO - TEST-INFO | 1657: exit 0 11:25:33 INFO - TEST-OK | dromaeo_css | took 1117901ms 11:25:33 INFO - TEST-START | kraken 11:25:33 INFO - operating with platform_type : mac_ 11:25:33 INFO - Initialising browser for kraken test... 11:25:33 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmp9MBoQ5/profile http://localhost:49272/getInfo.html) 11:25:35 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 11:25:35 INFO - PROCESS | 1662 | colorDepth:24 11:25:35 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 11:25:35 INFO - PROCESS | 1662 | __metrics 11:25:35 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:35 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:25:36 INFO - TEST-INFO | 1662: exit 0 11:25:36 INFO - Browser initialized. 11:25:36 INFO - Running cycle 1/1 for kraken test... 11:25:36 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/tmp9MBoQ5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:48 INFO - PROCESS | 1663 | RSS: Main: 235671552 11:25:48 INFO - PROCESS | 1663 | 11:25:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:52 INFO - PROCESS | 1663 | RSS: Main: 293937152 11:25:52 INFO - PROCESS | 1663 | 11:25:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 11:25:55 INFO - PROCESS | 1663 | RSS: Main: 293736448 11:25:55 INFO - PROCESS | 1663 | 11:25:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 11:25:59 INFO - PROCESS | 1663 | RSS: Main: 384286720 11:25:59 INFO - PROCESS | 1663 | 11:26:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 11:26:02 INFO - PROCESS | 1663 | RSS: Main: 286720000 11:26:02 INFO - PROCESS | 1663 | 11:26:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:26:04 INFO - PROCESS | 1663 | RSS: Main: 290705408 11:26:04 INFO - PROCESS | 1663 | 11:26:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 11:26:08 INFO - PROCESS | 1663 | RSS: Main: 329003008 11:26:08 INFO - PROCESS | 1663 | 11:26:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 11:26:11 INFO - PROCESS | 1663 | RSS: Main: 328564736 11:26:11 INFO - PROCESS | 1663 | 11:26:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 11:26:15 INFO - PROCESS | 1663 | RSS: Main: 325885952 11:26:15 INFO - PROCESS | 1663 | 11:26:16 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:26:17 INFO - PROCESS | 1663 | RSS: Main: 300109824 11:26:17 INFO - PROCESS | 1663 | 11:26:19 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:26:19 INFO - PROCESS | 1663 | RSS: Main: 303980544 11:26:19 INFO - PROCESS | 1663 | 11:26:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:26:22 INFO - PROCESS | 1663 | RSS: Main: 307986432 11:26:22 INFO - PROCESS | 1663 | 11:26:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:26:26 INFO - PROCESS | 1663 | RSS: Main: 317108224 11:26:26 INFO - PROCESS | 1663 | 11:26:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:26:29 INFO - PROCESS | 1663 | RSS: Main: 319057920 11:26:29 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 11:26:31 INFO - PROCESS | 1663 | RSS: Main: 362733568 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | __start_tp_report 11:26:31 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 11:26:31 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 11:26:31 INFO - PROCESS | 1663 | |i|pagename|runs| 11:26:31 INFO - PROCESS | 1663 | |0;ai-astar;113;115;115;115;114;115;112;114;113;115 11:26:31 INFO - PROCESS | 1663 | |1;audio-beat-detection;146;110;108;145;108;110;108;111;173;120 11:26:31 INFO - PROCESS | 1663 | |2;audio-dft;183;182;181;183;184;185;180;194;206;185 11:26:31 INFO - PROCESS | 1663 | |3;audio-fft;82;60;77;111;86;58;58;58;81;56 11:26:31 INFO - PROCESS | 1663 | |4;audio-oscillator;89;71;91;70;68;70;91;67;70;89 11:26:31 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;85;87;87;89;85;88;85;88;84 11:26:31 INFO - PROCESS | 1663 | |6;imaging-darkroom;105;147;92;94;93;93;92;94;93;92 11:26:31 INFO - PROCESS | 1663 | |7;imaging-desaturate;84;85;84;84;83;86;85;84;86;84 11:26:31 INFO - PROCESS | 1663 | |8;json-parse-financial;57;53;53;53;53;54;55;54;53;54 11:26:31 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;74;99;110;93;69;70;70;70;69 11:26:31 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;84;85;85;86;88;89;94;101;89;88 11:26:31 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;156;152;139;137;137;139;138;168;136 11:26:31 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;168;168;169;168;167;167;167;170;169;168 11:26:31 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;69;68;68;68;67;67;66;68;68;67 11:26:31 INFO - PROCESS | 1663 | __end_tp_report 11:26:31 INFO - PROCESS | 1663 | __start_cc_report 11:26:31 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1910 11:26:31 INFO - PROCESS | 1663 | __end_cc_report 11:26:31 INFO - PROCESS | 1663 | __startTimestamp1474655191683__endTimestamp 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | ------- Summary: start ------- 11:26:31 INFO - PROCESS | 1663 | Number of tests: 14 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 11:26:31 INFO - PROCESS | 1663 | Values: 113.0 115.0 115.0 115.0 114.0 115.0 112.0 114.0 113.0 115.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:115.50 stddev:22.78 (19.7%) stddev-sans-first:22.72 11:26:31 INFO - PROCESS | 1663 | Values: 146.0 110.0 108.0 145.0 108.0 110.0 108.0 111.0 173.0 120.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:186.30 Median:184.50 stddev:7.92 (4.3%) stddev-sans-first:8.31 11:26:31 INFO - PROCESS | 1663 | Values: 183.0 182.0 181.0 183.0 184.0 185.0 180.0 194.0 206.0 185.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:72.70 Median:68.50 stddev:17.97 (26.2%) stddev-sans-first:18.74 11:26:31 INFO - PROCESS | 1663 | Values: 82.0 60.0 77.0 111.0 86.0 58.0 58.0 58.0 81.0 56.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:80.00 stddev:10.75 (13.4%) stddev-sans-first:10.58 11:26:31 INFO - PROCESS | 1663 | Values: 89.0 71.0 91.0 70.0 68.0 70.0 91.0 67.0 70.0 89.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.50 stddev:1.71 (2.0%) stddev-sans-first:1.74 11:26:31 INFO - PROCESS | 1663 | Values: 88.0 85.0 87.0 87.0 89.0 85.0 88.0 85.0 88.0 84.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.00 stddev:17.14 (18.4%) stddev-sans-first:18.06 11:26:31 INFO - PROCESS | 1663 | Values: 105.0 147.0 92.0 94.0 93.0 93.0 92.0 94.0 93.0 92.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 11:26:31 INFO - PROCESS | 1663 | Values: 84.0 85.0 84.0 84.0 83.0 86.0 85.0 84.0 86.0 84.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:0.73 11:26:31 INFO - PROCESS | 1663 | Values: 57.0 53.0 53.0 53.0 53.0 54.0 55.0 54.0 53.0 54.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:78.90 Median:70.00 stddev:15.71 (22.4%) stddev-sans-first:15.84 11:26:31 INFO - PROCESS | 1663 | Values: 65.0 74.0 99.0 110.0 93.0 69.0 70.0 70.0 70.0 69.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.00 stddev:5.13 (5.8%) stddev-sans-first:5.13 11:26:31 INFO - PROCESS | 1663 | Values: 84.0 85.0 85.0 86.0 88.0 89.0 94.0 101.0 89.0 88.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:139.00 stddev:10.84 (7.8%) stddev-sans-first:11.34 11:26:31 INFO - PROCESS | 1663 | Values: 139.0 156.0 152.0 139.0 137.0 137.0 139.0 138.0 168.0 136.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 11:26:31 INFO - PROCESS | 1663 | Values: 168.0 168.0 169.0 168.0 167.0 167.0 167.0 170.0 169.0 168.0 11:26:31 INFO - PROCESS | 1663 | 11:26:31 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.84 (1.2%) stddev-sans-first:0.73 11:26:31 INFO - PROCESS | 1663 | Values: 69.0 68.0 68.0 68.0 67.0 67.0 66.0 68.0 68.0 67.0 11:26:31 INFO - PROCESS | 1663 | -------- Summary: end -------- 11:26:31 INFO - PROCESS | 1663 | 11:26:32 INFO - TEST-INFO | 1663: exit 0 11:26:32 INFO - TEST-OK | kraken | took 59468ms 11:26:32 INFO - SUITE-END | took 1177s 11:26:32 INFO - Completed test suite (00:19:37) 11:26:32 INFO - javascript benchmark 11:26:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3288.6546912574177, 3291.753118516111, 3314.966850331496, 3333.6499667534895, 3375.7130643895266, 5431.972840135803, 5514.393416724167, 5576.358718747345, 5639.802606908759, 5670.149477578365, 5509.696966666832, 5592.273004509419, 5694.601377903548, 5705.457981491762, 5707.086866101425, 4630.513796051417, 5062.873428164288, 5072.771725272353, 5122.334096567441, 5139.9720055988955, 5134.25553294772, 5199.402068762084, 5202.635815492917, 5206.947930520703, 5258.1849813279005, 5041.2438134280155, 5178.5857131429775, 5180.248863914749, 5202.193659982709, 5231.032259032091, 5086.669366491166, 5087.592992560586, 5143.228515722634, 5145.99653067652, 5148.948510514884, 5078.64449488536, 5136.922946155811, 5145.897082058375, 5150.819721309774, 5167.0957582422925, 5622.746976386073, 5632.04255276604, 5641.5204707599905, 5660.122680984454, 5674.886502269973, 5969.194158788551, 5976.671283079429, 6005.729742161613, 6156.353582873823, 6167.074938759177, 6108.190302030417, 6151.907721384183, 6154.938450615481, 6181.041938499539, 6221.097940798559, 5649.0396632572565, 5656.9151462728505, 5668.433156684381, 5669.914951275693, 5683.318001839764, 6188.257409110845, 6200.0, 6255.093011513305, 6269.0, 6279.717412716439, 5880.176775251468, 5894.823155305347, 5909.025010873243, 6001.819945401645, 6064.969675151596, 6135.987562052212, 6138.294096178996, 6148.815535533851, 6190.628562286187, 6213.937860621426, 6091.746053960063, 6121.051237058263, 6131.601445906091, 6133.0, 6143.170671959318, 6003.489703375175, 6078.939210607838, 6081.695915204222, 6138.425628698416, 6173.197484327098, 4779.402574678165, 4837.177679794443, 4839.661223714376, 4842.958763865786, 4848.321235027099, 4335.82656693735, 4341.044970106572, 4365.257906155897, 4367.67242456817, 4381.123775244963, 5506.614536982453, 5625.38120806711, 5635.492805647429, 5651.463111004448, 5660.575456840754, 6096.798833414304, 6140.969295153495, 6145.8156255312415, 6146.877062458726, 6187.226596675416, 5649.576281778883, 5658.688772117491, 5658.971705141448, 5665.49010589049, 5700.287464066992, 5240.973795131, 5249.370075590953, 5259.158534634516, 5276.894462110813, 5316.3354580677415, 6152.323244443108, 6199.256089269316, 6199.318075011655, 6203.8138855834395, 6223.066540019034, 6193.977993631001, 6203.937960620336, 6221.3156552780065, 6221.595596286227, 6232.470240029648, 6250.781222657185, 6254.687265636791, 6260.530460215411, 6272.466840318624, 6281.874362512633, 5960.642361458326, 5995.520358371407, 6013.669248191217, 6037.335893051849, 6109.450149486567, 6109.34393638171, 6194.225721784777, 6197.504199663926, 6198.535109866868, 6199.597026193283, 5954.518103744152, 6018.127371531191, 6025.427584379477, 6036.788712395045, 6077.696115194134, 5737.139429085671, 5908.940910591011, 5989.460948514655, 5993.430624090704, 5997.370276120944, 5777.62445441045, 5804.6807425590305, 5810.6513609183585, 5850.473457388855, 5903.409659034062, 5992.64044157352, 5995.940040599713, 5997.280326360865, 6001.159837622649, 6027.849303767441, 5691.601587888808, 5723.998300297515, 5738.282714660668, 5744.167095771173, 5817.854553636193], "value": 5611.842115679122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.6552487347179, 486.57667828988787, 535.3415299182006, 545.5335687986772, 573.8307199376184, 30381.08856734296, 40143.39784903225, 41362.58637413633, 41392.586074139246, 43743.0, 42503.937401564974, 42635.573644263546, 42715.0, 42952.785236073774, 42976.57023429765, 8611.0, 9583.329166958298, 9750.0, 9761.609535618567, 9775.804483910317, 8644.308455323559, 11729.941350293278, 12020.278783272988, 12039.157258991874, 12313.322767247797, 11870.52517899283, 11937.820932686016, 11944.7611047779, 11961.401929903514, 12065.155439119266, 11852.525898964032, 11925.403729813475, 11969.700757481132, 11973.102017348647, 11976.341301228429, 11751.001164900994, 11830.763384732258, 11844.40777961107, 11844.644660660195, 11851.288922664582, 39939.60060399388, 40054.799726001474, 40294.992625184605, 40309.99225019369, 40393.79803100995, 3243.2378391078078, 3392.694657480814, 3421.1447138215444, 3644.599094099647, 4008.178323443716, 29529.557056644167, 31007.534886976715, 31088.844555777076, 31100.8444957776, 31187.84406077978, 3175.3649270145834, 3303.96696033039, 3337.0989832745267, 3354.463285874273, 3384.187794929224, 378049.0, 379039.0, 379658.10170949245, 380589.0, 381142.0, 57494.7125264371, 57917.0, 57971.420285797445, 58009.70995144997, 58091.70954145202, 59039.70480147572, 59192.0, 59193.70403147957, 59216.0, 59419.40580594139, 15231.619209519851, 15417.997830141005, 15429.614259643598, 15439.150846703315, 15442.768358474406, 10831.458427078614, 11065.0, 11935.701607459883, 11986.340751258764, 12023.338716370508, 13583.796243056164, 14742.18917959501, 14946.878984076238, 15096.320665569856, 15140.318685659171, 5484.044246379124, 6486.643234622046, 6550.7707230246715, 6567.310432404529, 6611.933880661228, 851.7402192331399, 941.580996456584, 998.7553049502773, 1035.808375450544, 1109.9944500277609, 29248.268793279913, 29462.263443414085, 29635.192599408238, 29784.553231701542, 29838.0, 892.0, 1039.262123892045, 1046.706922061824, 1109.9556017759198, 1122.820348744197, 14844.92577537127, 15289.541313760605, 15345.30946107428, 15652.4521641742, 15656.0, 643380.0478978457, 646339.5245356523, 647496.0, 647607.0, 651629.0, 56443.71778141083, 56838.7158064207, 56840.578985524866, 57072.14391784126, 57097.0, 1234.0682784497826, 1270.2568997136593, 1341.4701193028504, 1370.6093763277418, 1388.3266615691584, 29653.555196671634, 30386.392272154877, 30618.15824252603, 31073.68926310708, 31309.53035704421, 48023.5197648033, 48524.757376212896, 48605.0, 48606.513934860195, 49033.50966490289, 541898.0, 542372.0, 544598.0, 546345.0, 607699.9615001896, 19882.403527894185, 24759.62860557057, 25009.49981000406, 25031.0, 25136.62295065539, 43328.56671433245, 43541.78229108961, 43941.0, 44058.77970610127, 45007.77496112498, 36677.449838251916, 36728.81635591805, 37299.254014920094, 37882.43176352302, 38092.80953595325, 35553.95582750887, 36630.26739465249, 36968.44547331846, 37393.813030934674, 37781.86654400372, 35574.82212588921, 35681.36866595884, 36267.91196264116, 36382.8180859094, 36469.817650912635, 31889.043328700176, 33451.665483344856, 33458.832705836314, 33557.83221083879, 33559.83220083884, 25062.37344066413, 25484.362890927874, 25639.871800641624, 25663.615045773953, 25931.611025835005], "value": 19725.509157623263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.0890303018213, 359.90462527430225, 374.66093185666966, 384.7922122054091, 404.8684177642267, 14803.703925921474, 15148.318325675344, 16005.43980960665, 20356.88037157956, 21109.472263193427, 19819.0, 20179.596408071866, 20751.584968300624, 20945.0, 21167.894160529177, 4778.54603812639, 5894.174815525819, 6132.662703551303, 6150.723217455203, 6161.630302181861, 4226.936595951048, 4449.976505403759, 4458.910821783563, 6048.274207095154, 6050.727717252734, 6360.618362898218, 6391.936080639204, 6435.452986496153, 6765.695543700521, 6775.0, 5824.621399609033, 6151.87696246077, 6187.0, 6188.628682279078, 6819.556728812611, 5214.8174813881715, 6026.397360263983, 6031.487323577501, 6039.849003774897, 6053.848653783647, 11891.345975971319, 12203.267803931793, 12232.449539770732, 12246.44890979908, 12273.815892761615, 2097.6329142400173, 2105.5262565922544, 2298.310506847939, 2911.097559756461, 2922.991567909068, 9777.168940640055, 9865.260105492045, 10389.688309350731, 11151.442427878656, 15908.602284942854, 1657.6021754778887, 1812.610288787917, 1874.3312181162125, 1879.1543805287674, 1891.1678861300984, 85336.0, 107112.46443767809, 108996.45501772441, 111026.44486777595, 113020.43754749483, 11204.271722338022, 11280.887191128148, 11289.209755317213, 11439.542418303341, 11511.884881151249, 14384.424623014962, 14434.855651443351, 14444.494442694455, 14457.0, 14478.045463862243, 8056.758297251092, 8324.791880203044, 8340.749777506684, 8472.568609713077, 8480.703175388831, 8106.310963568045, 8117.228863257981, 8161.224683655043, 8278.8344233115, 8318.168183181633, 4466.151431228056, 4490.216066039076, 4497.123061003138, 4497.415336006364, 4575.862724118282, 1537.5541093083104, 1771.973420398695, 1810.7012048429394, 1878.1454438230571, 1963.7545306836646, 766.5860435364953, 904.5612877754284, 910.3945875992391, 921.6083164654995, 1005.5123265216364, 20296.188152473736, 20446.897765511374, 20623.175072996914, 20789.480262993548, 20824.210431600815, 904.4302089683457, 906.7370462565914, 911.5214512381053, 917.5274733512247, 946.9147776699992, 10062.345947513388, 10408.895911040943, 10863.45682715861, 10883.401412922365, 10979.396133212591, 455818.0, 468949.0, 477612.0, 586189.0, 590811.0567284818, 94415.0, 108859.0, 121136.39431802784, 144470.27764861108, 149803.0, 965.8068386322623, 974.8245315843217, 1039.589362201926, 1039.8128336899279, 1045.0385645206277, 13428.261445620585, 18863.6227275451, 19032.33386831454, 19067.523311917314, 19073.618527629646, 51884.48115518797, 52342.0, 53348.73325633347, 55003.724981376436, 56051.71974140103, 79675.0, 79787.0, 81808.93193811277, 82360.64655797594, 82412.58793705993, 10792.0, 10892.237543371888, 11543.191976561897, 11898.464569094238, 12475.812862806884, 11296.548138074713, 13557.426296280019, 13615.79576306376, 13876.028677992444, 14079.507217247346, 5481.3970463248215, 5638.746256418389, 11567.537298508301, 11583.189176757545, 11890.34603096838, 11285.379304138023, 11388.886111139114, 11540.422978850856, 11567.710807229887, 11754.823677645014, 11505.712357191138, 11679.824802628138, 11813.527458901548, 12055.69860753453, 12070.517179312728, 12311.507539698312, 12398.25610463375, 12554.372281385711, 12576.245425274512, 12697.492100316253, 11503.654890353302, 11735.154127937674, 11781.234219775688, 11898.881011189776, 11993.580224692094], "value": 9481.984241426166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.1913947328967, 1531.6630341324908, 1672.5233308507063, 1745.5112568480822, 1931.4978105692524, 8312.958435207831, 8856.38005339625, 8873.955630221848, 8880.91119088809, 8917.420367676104, 7692.730754423596, 7965.123836377994, 7987.161348058443, 8307.709230176944, 8592.398532102756, 1993.8903360315142, 2362.574736547421, 2371.774681405264, 2373.8575685458927, 2376.3465047112095, 2317.756635553268, 2331.4171457135717, 2372.9406764830846, 2373.2524254859663, 2373.537160253751, 2340.9180678676166, 2351.200591798788, 2366.337425520857, 2371.2293504610984, 2372.28831350595, 2332.9650055249185, 2338.7193536775526, 2351.71779386473, 2351.870647114408, 2352.8588284702973, 2335.6846825678485, 2338.298510446859, 2339.6841426407386, 2341.1922886604093, 2341.4029422497324, 8667.003294621136, 8681.696140635111, 8743.562821858945, 8786.472811631322, 8806.691765788166, 5106.872328191787, 5143.974280128613, 5256.316678831766, 5285.4450282720145, 5287.841364759063, 3337.1323455901397, 3431.9142021449416, 3500.2824420993634, 3511.9648803511895, 3514.6309637488207, 1046.989654982945, 1080.2654195147297, 1091.2852081886376, 1103.5034234594464, 1107.0424083168082, 11460.426978651034, 11607.013403860597, 11607.4196290186, 11608.245464044894, 11615.825762613567, 4421.137878113737, 4521.389612402284, 4679.508651591534, 4716.151092803259, 4725.929111063337, 9819.803603927881, 9879.259055570717, 9895.307328486937, 9901.603935842486, 9910.45492497905, 5221.347331583552, 5245.580353571705, 5255.894882102337, 5266.0, 5269.209618557171, 4301.849435269751, 4333.869983900425, 4461.10777844426, 4762.809487620457, 4804.06320767447, 3780.8298626561873, 3817.8047622617105, 3836.0985168485386, 3928.1161738609158, 3940.6847452203756, 1218.9085818563465, 1222.1689251309194, 1222.1872454817624, 1231.8398608181058, 1233.4326209943526, 798.2496453333847, 898.3442087276325, 910.900374636456, 920.921721653667, 949.2168960607527, 4367.519572846984, 4795.568398844121, 5663.971680141655, 5837.737301821428, 5994.6403215807195, 423.84502231419754, 434.58931309911827, 441.46141707117266, 451.474032751847, 453.5283305362452, 3680.5399325084363, 3780.243951209769, 3998.4002399639703, 4007.218592374459, 4042.555318914917, 10137.898621013843, 10475.371477711209, 10646.467676616137, 10657.89342106569, 10660.520276587573, 10325.793484130276, 10340.37957722539, 10393.428361440194, 10608.734781630521, 10618.946905265424, 8019.639116239783, 8081.151479094728, 8117.553534555656, 8134.877976830352, 8145.045189154679, 5726.255586773693, 5735.4551317624755, 5780.5953583248765, 5844.327902291291, 5885.588008839341, 9817.852732209165, 9818.950905245429, 9826.459544724823, 9853.556589953327, 9888.752781180528, 9445.197158241352, 9859.161971232526, 9915.851262230928, 10003.34978226413, 10018.39889606626, 6824.249332573314, 7051.048108505492, 7052.0479735235085, 7306.707731690885, 7479.065116860393, 7602.809929751579, 7767.3786097113225, 7836.608169591384, 8056.7180148694515, 8182.713605024033, 7319.780406587811, 7475.738349157753, 7482.438817088849, 7559.924400756142, 7579.469437139568, 7099.148102227766, 7258.237885021997, 7264.89102663471, 7311.41508679315, 7348.595827229554, 6804.081449004321, 6855.794326170223, 6866.34769696878, 6942.6181560012665, 6960.965195173992, 3935.803209839439, 4247.87256382309, 4740.360051393156, 4924.778384972757, 5108.055009823194, 4145.419641250167, 4925.753712314442, 5048.7475626219275, 5122.950819672161, 5185.792568297225], "value": 4414.948374740377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5658180510967, 310.5543545012907, 315.05954725145443, 320.41844053043724, 323.05506393798134, 5096.369161868203, 5168.922466163006, 5181.92227116593, 5182.11903976324, 5211.348581427322, 4718.834840780573, 5149.459306772791, 5156.871078223046, 5162.277281180638, 5188.740562971846, 3133.52997050442, 3629.9637003629955, 3863.9806800965957, 3879.650831425171, 3879.8060096995177, 2932.5747766573836, 3908.335582950905, 3937.5274967003998, 3952.6245006724316, 3976.633902827827, 3308.2721801203697, 3905.824237909301, 3920.5883382244883, 3924.3721004639265, 3951.2097580483874, 3638.2905333459985, 3869.7097717671286, 3914.158455931988, 3941.3890846918775, 3942.5860284670125, 2886.4124731397646, 3301.4057469655454, 3371.7639765216445, 3378.2061215614312, 3381.4420620597816, 4950.504949505057, 4962.230854217602, 4970.353853998993, 4972.378452693413, 5014.974925125351, 3847.057470919615, 4125.97937010316, 4272.850450234227, 4420.0, 4442.97811503356, 4626.7223966562115, 5143.254228136937, 5291.1798671206025, 5337.439568845254, 5375.543078838304, 3242.983785081083, 3681.5582130144553, 3690.5017822593873, 3708.9814550927344, 3718.4236443351324, 5255.137473956639, 5574.536953785273, 5625.46558076982, 5639.68981706006, 5647.548196144298, 3221.017589635137, 3505.9298814023578, 3726.552813662324, 3728.776273423549, 3771.7548359356556, 3275.4431746603136, 3806.600306967784, 3824.904377390532, 3833.4824798652385, 3840.9615903841163, 4393.494748104009, 4397.472303323621, 4425.35832304314, 4425.468943726773, 4443.155800397914, 4799.832005879777, 5117.1322467299915, 5137.6660517066275, 5393.7303134843105, 5438.537724293479, 1155.485808815086, 1283.608499407671, 1305.5626365167775, 1307.013205030196, 1308.5812539987303, 687.5015613680042, 793.4802704228739, 805.8025783682918, 809.1908091908092, 818.9672413103409, 4460.397846290774, 4843.104025755247, 4875.95124048762, 4883.316335713003, 4894.339264199288, 4625.722456652612, 5494.917576236359, 5537.418571050062, 5559.415566563591, 5595.804146854841, 4152.778263628944, 5022.242215224715, 5062.797488100435, 5126.846194614168, 5126.948730512721, 2564.8845801938955, 2841.886324546995, 2876.4390943765766, 2927.516959701668, 2940.8235505869716, 4339.414179085846, 5449.3460784706085, 5713.14322845077, 5735.053716136791, 5748.971255143698, 4142.896427589274, 5282.3661160660195, 5655.773769049192, 5711.828645140569, 5726.971365143231, 4770.522947705271, 4993.675411098267, 5375.354957405137, 5688.687122208318, 5706.4864162225595, 4903.5586797187, 4985.027919555652, 5220.425753167073, 5554.472325129106, 5631.943680563306, 4991.176455884738, 5036.607611384563, 5108.61685373591, 5444.26502422168, 5457.317835270591, 4684.976575117103, 5039.992001599621, 5318.9044435785, 5716.714164291852, 5748.396418376177, 2897.391547774991, 2976.3213108201926, 3269.591301087364, 3295.6652555714973, 3332.416827055304, 4516.954830451785, 4594.880018774553, 4678.953210467852, 4701.132309291261, 4797.75258432803, 3932.115274063313, 4054.4729185205733, 4227.471566054243, 4335.2745507397085, 4505.797239124182, 3718.8698395556025, 3959.366501359769, 3999.0002499375155, 4292.570742925807, 4346.67399944999, 3672.412414013745, 3956.7823769692945, 4009.939850902297, 4273.508546517191, 4479.70881892689, 4321.623107290915, 5040.092783298895, 5157.871053223699, 5299.880047980839, 5314.946850531445, 4818.807247710192, 4865.270209468608, 5269.1832765921345, 5269.4730526947, 5291.312129423304], "value": 3799.6267698590714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.3151292397428, 754.0009487429154, 774.8062984253936, 798.8002999250187, 801.6392623319508, 15104.622384440394, 15880.920595397036, 15883.761743573841, 15887.920560397197, 16194.595135121599, 14239.92880035601, 14359.497417590386, 14365.569032929028, 14405.567832965002, 14407.27963601821, 695.9860802783942, 717.2504732554467, 721.1094298541298, 855.6106971328046, 862.9956850215772, 853.4495250563383, 893.4103491695482, 895.8566629339307, 912.63494602159, 914.9451032938046, 957.2437774158407, 958.2669258017622, 960.9375390599623, 963.4412041016229, 966.9081437263449, 702.1749444402857, 722.6170129831145, 944.8110377924409, 944.9622015119421, 949.8860136783561, 678.6504949950779, 698.0227681246245, 702.4626160986849, 702.5152644675157, 703.4056222491986, 15139.697206055927, 15181.544553663407, 15187.936844420896, 15211.0, 15221.61945951349, 13729.107608005448, 14084.85915140856, 14115.435382584685, 14169.220692861889, 14414.783778243334, 12795.0, 12961.287129207889, 12996.610101696964, 13298.268595227259, 13617.455301787917, 4568.931466028012, 4596.218642830727, 4622.046269949276, 4791.760411979387, 4802.471728109905, 117573.0, 118053.819461806, 118528.0, 118709.40645296805, 120948.0, 10822.621208257673, 11007.834882476769, 11327.433628318551, 11435.0, 11602.593909213138, 22495.32514024582, 22505.887470562542, 22524.0, 22525.774742252695, 22546.774532254796, 7378.003969464054, 7806.648700808477, 8131.9186808132345, 8154.469959452616, 8286.875696864552, 4264.275073237557, 4499.437570303712, 4597.563231493003, 4689.60138388234, 4728.88177795551, 3069.2326918270433, 3469.7397695172963, 3527.8236088195486, 3594.0835087052633, 3597.0827439002887, 648.7340190521863, 658.2200092889941, 660.4089340040733, 674.9898751518731, 676.7157793726647, 540.4811381074213, 571.6370104983365, 583.8948989181988, 614.6508414031248, 647.8704259148095, 8333.8333233335, 9088.318376121817, 9535.47554884474, 9829.4102353859, 9860.06329398706, 556.5742207211487, 627.231641239478, 637.445422482434, 667.9223341500169, 671.9462443004547, 4295.4201182839915, 4656.906861862812, 4750.334953106568, 4754.5007774183905, 4809.702845393202, 107180.46409768057, 118942.0, 154932.0, 164260.0, 165344.17327913284, 97107.51446242724, 99695.00304997002, 102246.48876755718, 136570.0, 143109.28445357707, 103707.0, 104833.47583262034, 105302.0, 105453.47273263584, 107143.39284910733, 9454.574544145393, 9665.0, 9675.70972870815, 9676.322657414195, 9776.9022309776, 55550.0, 56145.0, 57387.0, 57545.0, 57844.71077644585, 55657.165142522084, 55844.0, 74742.62628687039, 83571.0, 86859.13140868764, 12403.441845117171, 12717.618471445872, 12780.297083660487, 13005.544805931748, 13398.26309552984, 13120.73758524805, 14164.150150990974, 14329.0, 14786.778198327249, 15112.450914283412, 13376.264305463294, 14069.437222511395, 14243.359048843035, 14243.430262789372, 14376.712465750836, 13281.933590331986, 13636.318194087342, 13797.310134493437, 14120.082194657314, 14128.222947737562, 12949.870501294867, 13439.529616463376, 13598.059117690667, 13598.184108953494, 14052.718945621235, 10447.320924139907, 11243.943780281046, 11373.20387572862, 11800.586979455678, 11846.21993985469, 11288.774224515299, 11418.657440276806, 11427.485763140512, 11524.0, 11558.884411156117], "value": 7830.841795118981, "unit": "score"}], "name": "dromaeo_css", "value": 7187.75255557138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 115.0, 114.0, 115.0, 112.0, 114.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 108.0, 145.0, 108.0, 110.0, 108.0, 111.0, 173.0, 120.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 183.0, 184.0, 185.0, 180.0, 194.0, 206.0, 185.0], "value": 186.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 77.0, 111.0, 86.0, 58.0, 58.0, 58.0, 81.0, 56.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 91.0, 70.0, 68.0, 70.0, 91.0, 67.0, 70.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 87.0, 89.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 147.0, 92.0, 94.0, 93.0, 93.0, 92.0, 94.0, 93.0, 92.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 83.0, 86.0, 85.0, 84.0, 86.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 53.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 99.0, 110.0, 93.0, 69.0, 70.0, 70.0, 70.0, 69.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 88.0, 89.0, 94.0, 101.0, 89.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 156.0, 152.0, 139.0, 137.0, 137.0, 139.0, 138.0, 168.0, 136.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 168.0, 167.0, 167.0, 167.0, 170.0, 169.0, 168.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 68.0, 67.0, 67.0, 66.0, 68.0, 68.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1446.6999999999998, "alertThreshold": 2.0}]} 11:26:32 INFO - Return code: 0 11:26:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:32 INFO - # TBPL SUCCESS # 11:26:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:26:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:26:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:26:32 INFO - 2016-09-23 11:26:32.993 screenresolution[1667:10376] starting screenresolution argv=screenresolution get 11:26:32 INFO - 2016-09-23 11:26:32.996 screenresolution[1667:10376] Display 0: 1600x1200x32@60 11:26:33 INFO - 2016-09-23 11:26:33.002 screenresolution[1668:10379] starting screenresolution argv=screenresolution list 11:26:33 INFO - Available Modes on Display 0 11:26:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:26:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:26:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:26:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:26:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:26:33 INFO - Intel Iris: 11:26:33 INFO - Chipset Model: Intel Iris 11:26:33 INFO - Type: GPU 11:26:33 INFO - Bus: Built-In 11:26:33 INFO - VRAM (Dynamic, Max): 1536 MB 11:26:33 INFO - Vendor: Intel (0x8086) 11:26:33 INFO - Device ID: 0x0a2e 11:26:33 INFO - Revision ID: 0x0009 11:26:33 INFO - Displays: 11:26:33 INFO - Display: 11:26:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:26:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:26:33 INFO - Display Serial Number: 1600x1200 60 11:26:33 INFO - Main Display: Yes 11:26:33 INFO - Mirror: Off 11:26:33 INFO - Online: Yes 11:26:33 INFO - Rotation: Supported 11:26:33 INFO - Return code: 0 11:26:33 INFO - Running post-action listener: _resource_record_post_action 11:26:33 INFO - [mozharness: 2016-09-23 18:26:33.237963Z] Finished run-tests step (success) 11:26:33 INFO - Running post-run listener: _resource_record_post_run 11:26:33 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32422912; Write bytes: 707845632; Read time: 319; Write time: 1912 11:26:33 INFO - TinderboxPrint: CPU usage
53.5% 11:26:33 INFO - TinderboxPrint: I/O read bytes / time
32,422,912 / 319 11:26:33 INFO - TinderboxPrint: I/O write bytes / time
707,845,632 / 1,912 11:26:33 INFO - TinderboxPrint: CPU idle
2,254.9 (46.5%) 11:26:33 INFO - TinderboxPrint: CPU system
967.8 (20.0%) 11:26:33 INFO - TinderboxPrint: CPU user
1,627.1 (33.5%) 11:26:33 INFO - TinderboxPrint: Swap in / out
434,659,328 / 0 11:26:33 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403556864; Write bytes: 397202944; Read time: 29900; Write time: 684 11:26:33 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30219264; Write bytes: 297711616; Read time: 294; Write time: 1192 11:26:33 INFO - Running post-run listener: _upload_blobber_files 11:26:33 INFO - Blob upload gear active. 11:26:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:33 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 11:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:34 INFO - (blobuploader) - INFO - Done attempting. 11:26:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:35 INFO - (blobuploader) - INFO - Done attempting. 11:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:38 INFO - (blobuploader) - INFO - Done attempting. 11:26:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:38 INFO - Return code: 0 11:26:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e8f2fce22c0c36165bc2ec848055d0e8f39095a459b960187d7753774c0872aae347f8af50352dbd24fb5bbb7e47a3555f433b990e180f921df0693ecd82abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95c784f0884ad95605c879a050907590b58dc0e4d01e7ec96ef18aecfbe3c5d1f91c01a08a31a0a0a97165c755a0905a852fc766bb54fb95a6ddd0975d9e1b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/687250037aa4a7fffc25727f0911cce12f4d74459e6971e0f4ad20a06b877f4f01a342c085b34725992c0fe2c606acfdc2bee4daddf0ce8f35b884df3285ad97"} 11:26:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:38 INFO - Contents: 11:26:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e8f2fce22c0c36165bc2ec848055d0e8f39095a459b960187d7753774c0872aae347f8af50352dbd24fb5bbb7e47a3555f433b990e180f921df0693ecd82abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95c784f0884ad95605c879a050907590b58dc0e4d01e7ec96ef18aecfbe3c5d1f91c01a08a31a0a0a97165c755a0905a852fc766bb54fb95a6ddd0975d9e1b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/687250037aa4a7fffc25727f0911cce12f4d74459e6971e0f4ad20a06b877f4f01a342c085b34725992c0fe2c606acfdc2bee4daddf0ce8f35b884df3285ad97"} 11:26:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:38 INFO - Copying logs to upload dir... 11:26:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.515308 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-23 11:26:38.453841) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:26:38.456962) ========= 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.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e8f2fce22c0c36165bc2ec848055d0e8f39095a459b960187d7753774c0872aae347f8af50352dbd24fb5bbb7e47a3555f433b990e180f921df0693ecd82abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95c784f0884ad95605c879a050907590b58dc0e4d01e7ec96ef18aecfbe3c5d1f91c01a08a31a0a0a97165c755a0905a852fc766bb54fb95a6ddd0975d9e1b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/687250037aa4a7fffc25727f0911cce12f4d74459e6971e0f4ad20a06b877f4f01a342c085b34725992c0fe2c606acfdc2bee4daddf0ce8f35b884df3285ad97"} build_url:https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010904 build_url: 'https://queue.taskcluster.net/v1/task/OLS5AKpDSTyKWceKlTmHbw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e8f2fce22c0c36165bc2ec848055d0e8f39095a459b960187d7753774c0872aae347f8af50352dbd24fb5bbb7e47a3555f433b990e180f921df0693ecd82abf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95c784f0884ad95605c879a050907590b58dc0e4d01e7ec96ef18aecfbe3c5d1f91c01a08a31a0a0a97165c755a0905a852fc766bb54fb95a6ddd0975d9e1b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/687250037aa4a7fffc25727f0911cce12f4d74459e6971e0f4ad20a06b877f4f01a342c085b34725992c0fe2c606acfdc2bee4daddf0ce8f35b884df3285ad97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 11:26:38.489856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:26:38.490162) ========= 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.SvYoPepBri/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.gwLHOsUSVM/Listeners TMPDIR=/var/folders/4q/f46rsfvj2c19v5lxnyttyfz000000w/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.005124 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:26:38.538226) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:26:38.538551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 11:26:38.538862) ========= ========= Total master_lag: 8.38 =========