builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0093 starttime: 1474941222.98 results: success (0) buildid: 20160926041252 builduid: 557bab29aaeb4c3b9de51a813111fc0c revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:42.982141) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:42.982546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:42.982819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:43.048757) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:43.049014) ========= 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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-26 18:53:43-- 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% 9.41M=0.001s 2016-09-26 18:53:43 (9.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.573599 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:43.714593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:43.715998) ========= 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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.029210 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:43.877638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 18:53:43.878002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --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 c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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-26 18:53:43,966 truncating revision to first 12 chars 2016-09-26 18:53:43,966 Setting DEBUG logging. 2016-09-26 18:53:43,966 attempt 1/10 2016-09-26 18:53:43,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 18:53:45,229 unpacking tar archive at: fx-team-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517696 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 18:53:45.420996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:45.421266) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:45.421653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:45.421970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 18:53:45.440457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-26 18:53:45.440770) ========= /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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:53:45 INFO - MultiFileLogger online at 20160926 18:53:45 in /builds/slave/test 18:53:45 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 18:53:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:53:45 INFO - {'append_to_log': False, 18:53:45 INFO - 'base_work_dir': '/builds/slave/test', 18:53:45 INFO - 'blob_upload_branch': 'Fx-Team', 18:53:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:53:45 INFO - 'branch': 'Fx-Team', 18:53:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:45 INFO - 'config_files': ('talos/mac_config.py',), 18:53:45 INFO - 'default_actions': ('clobber', 18:53:45 INFO - 'read-buildbot-config', 18:53:45 INFO - 'download-and-extract', 18:53:45 INFO - 'populate-webroot', 18:53:45 INFO - 'create-virtualenv', 18:53:45 INFO - 'install', 18:53:45 INFO - 'run-tests'), 18:53:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:45 INFO - 'download_minidump_stackwalk': True, 18:53:45 INFO - 'download_symbols': 'ondemand', 18:53:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:45 INFO - 'installer_path': 'installer.exe', 18:53:45 INFO - 'log_level': 'info', 18:53:45 INFO - 'log_name': 'talos', 18:53:45 INFO - 'log_to_console': True, 18:53:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:53:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:53:45 INFO - 'opt_config_files': (), 18:53:45 INFO - 'pip_index': False, 18:53:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:53:45 INFO - 'cmd': ('bash', 18:53:45 INFO - '-c', 18:53:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:53:45 INFO - 'enabled': True, 18:53:45 INFO - 'halt_on_failure': False, 18:53:45 INFO - 'name': 'check_screen_resolution'},), 18:53:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:53:45 INFO - 'cmd': ('bash', 18:53:45 INFO - '-c', 18:53:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:53:45 INFO - 'enabled': True, 18:53:45 INFO - 'halt_on_failure': False, 18:53:45 INFO - 'name': 'check_screen_resolution'},), 18:53:45 INFO - 'run_cmd_checks_enabled': True, 18:53:45 INFO - 'sps_profile': False, 18:53:45 INFO - 'sps_profile_interval': 0, 18:53:45 INFO - 'suite': 'dromaeojs', 18:53:45 INFO - 'system_bits': '32', 18:53:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:45 INFO - 'title': 't-yosemite-r7-0093', 18:53:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:45 INFO - 'use_talos_json': True, 18:53:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:53:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:45 INFO - 'work_dir': 'build'} 18:53:45 INFO - [mozharness: 2016-09-27 01:53:45.656559Z] Running clobber step. 18:53:45 INFO - Running pre-action listener: _resource_record_pre_action 18:53:45 INFO - Running main action method: clobber 18:53:45 INFO - rmtree: /builds/slave/test/build 18:53:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:53:47 INFO - Running post-action listener: _resource_record_post_action 18:53:47 INFO - [mozharness: 2016-09-27 01:53:47.824894Z] Finished clobber step (success) 18:53:47 INFO - [mozharness: 2016-09-27 01:53:47.825033Z] Running read-buildbot-config step. 18:53:47 INFO - Running pre-action listener: _resource_record_pre_action 18:53:47 INFO - Running main action method: read_buildbot_config 18:53:47 INFO - Using buildbot properties: 18:53:47 INFO - { 18:53:47 INFO - "project": "", 18:53:47 INFO - "product": "firefox", 18:53:47 INFO - "script_repo_revision": "production", 18:53:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:53:47 INFO - "repository": "", 18:53:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:53:47 INFO - "buildid": "20160926041252", 18:53:47 INFO - "pgo_build": "False", 18:53:47 INFO - "basedir": "/builds/slave/test", 18:53:47 INFO - "buildnumber": 0, 18:53:47 INFO - "slavename": "t-yosemite-r7-0093", 18:53:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 18:53:47 INFO - "platform": "yosemite_r7", 18:53:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:53:47 INFO - "branch": "fx-team", 18:53:47 INFO - "repo_path": "integration/fx-team", 18:53:47 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 18:53:47 INFO - "stage_platform": "macosx64", 18:53:47 INFO - "builduid": "557bab29aaeb4c3b9de51a813111fc0c", 18:53:47 INFO - "slavebuilddir": "test" 18:53:47 INFO - } 18:53:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 18:53:47 INFO - Running post-action listener: _resource_record_post_action 18:53:47 INFO - [mozharness: 2016-09-27 01:53:47.828449Z] Finished read-buildbot-config step (success) 18:53:47 INFO - [mozharness: 2016-09-27 01:53:47.828562Z] Running download-and-extract step. 18:53:47 INFO - Running pre-action listener: _resource_record_pre_action 18:53:47 INFO - Running main action method: download_and_extract 18:53:47 INFO - mkdir: /builds/slave/test/build/tests 18:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:53:47 INFO - trying https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 18:53:47 INFO - Downloading https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/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 18:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/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 18:53:48 INFO - Downloaded 1199 bytes. 18:53:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 18:53:48 INFO - Using the following test package requirements: 18:53:48 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:53:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 18:53:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 18:53:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'jsshell-mac.zip'], 18:53:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 18:53:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 18:53:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 18:53:48 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 18:53:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 18:53:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 18:53:48 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 18:53:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:53:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:53:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:53:48 INFO - Fetch https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:53:49 INFO - Expected file size: 16468973 18:53:56 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 18:53:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 18:53:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:53:56 INFO - Fetch https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 18:53:56 INFO - Expected file size: 16468973 18:54:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 18:54:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:54:03 INFO - Fetch https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 18:54:04 INFO - Expected file size: 14414057 18:54:05 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')]} 18:54:05 INFO - trying https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:54:05 INFO - Downloading https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 18:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/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 18:54:07 INFO - Downloaded 111577688 bytes. 18:54:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:54:07 INFO - mkdir: /builds/slave/test/properties 18:54:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:54:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:54:07 INFO - Contents: 18:54:07 INFO - build_url:https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 18:54:08 INFO - Running post-action listener: _resource_record_post_action 18:54:08 INFO - Running post-action listener: set_extra_try_arguments 18:54:08 INFO - [mozharness: 2016-09-27 01:54:08.582234Z] Finished download-and-extract step (success) 18:54:08 INFO - [mozharness: 2016-09-27 01:54:08.582377Z] Running populate-webroot step. 18:54:08 INFO - Running pre-action listener: _resource_record_pre_action 18:54:08 INFO - Running main action method: populate_webroot 18:54:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:54:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:54:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:54:08 INFO - '--tppagecycles', 18:54:08 INFO - '7'], 18:54:08 INFO - 'tests': ['tsvgm']}}, 18:54:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:54:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:54:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:54:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:54:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:54:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['damp', 'tps']}, 18:54:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'tests': ['damp', 'tps']}, 18:54:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['dromaeo_dom']}, 18:54:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:54:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['basic_compositor_video']}, 18:54:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:54:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['a11yr', 18:54:08 INFO - 'ts_paint', 18:54:08 INFO - 'tpaint', 18:54:08 INFO - 'sessionrestore', 18:54:08 INFO - 'sessionrestore_no_auto_restore', 18:54:08 INFO - 'tabpaint']}, 18:54:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['tsvgx', 18:54:08 INFO - 'tsvgr_opacity', 18:54:08 INFO - 'tart', 18:54:08 INFO - 'tscrollx', 18:54:08 INFO - 'cart']}, 18:54:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:54:08 INFO - 'tsvgr_opacity', 18:54:08 INFO - 'tart', 18:54:08 INFO - 'tscrollx', 18:54:08 INFO - 'cart']}, 18:54:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'talos_options': ['--disable-e10s'], 18:54:08 INFO - 'tests': ['tp5o']}, 18:54:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'tests': ['tp5o']}, 18:54:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'talos_options': ['--disable-e10s', 18:54:08 INFO - '--xperf_path', 18:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:08 INFO - 'tests': ['tp5n']}, 18:54:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:54:08 INFO - 'talos_options': ['--xperf_path', 18:54:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:54:08 INFO - 'tests': ['tp5n']}}, 18:54:08 INFO - 'talos.zip': {'path': '', 18:54:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:54:08 INFO - Running post-action listener: _resource_record_post_action 18:54:08 INFO - [mozharness: 2016-09-27 01:54:08.601177Z] Finished populate-webroot step (success) 18:54:08 INFO - [mozharness: 2016-09-27 01:54:08.601281Z] Running create-virtualenv step. 18:54:08 INFO - Running pre-action listener: _resource_record_pre_action 18:54:08 INFO - Running main action method: create_virtualenv 18:54:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:54:08 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 18:54:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:54:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:54:08 INFO - Using real prefix '/tools/python27' 18:54:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:54:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:54:12 INFO - Installing pip.................done. 18:54:12 INFO - Return code: 0 18:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:54:12 INFO - Reading from file tmpfile_stdout 18:54:12 INFO - Output received: 18:54:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:54:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:54:12 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')]} 18:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:12 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')]} 18:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:12 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:12 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 18:54:12 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 18:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:12 INFO - 'HOME': '/Users/cltbld', 18:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:12 INFO - 'LOGNAME': 'cltbld', 18:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:12 INFO - 'MOZ_NO_REMOTE': '1', 18:54:12 INFO - 'NO_EM_RESTART': '1', 18:54:12 INFO - 'PAGER': '/bin/cat', 18:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:12 INFO - 'PWD': '/builds/slave/test', 18:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:12 INFO - 'SHELL': '/bin/bash', 18:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:12 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:12 INFO - 'USER': 'cltbld', 18:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:12 INFO - 'XPC_FLAGS': '0x0', 18:54:12 INFO - 'XPC_SERVICE_NAME': '0', 18:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:12 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 18:54:12 INFO - Cleaning up... 18:54:12 INFO - Return code: 0 18:54:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:54:12 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')]} 18:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:12 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')]} 18:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:12 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:12 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 18:54:12 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 18:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:12 INFO - 'HOME': '/Users/cltbld', 18:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:12 INFO - 'LOGNAME': 'cltbld', 18:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:12 INFO - 'MOZ_NO_REMOTE': '1', 18:54:12 INFO - 'NO_EM_RESTART': '1', 18:54:12 INFO - 'PAGER': '/bin/cat', 18:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:12 INFO - 'PWD': '/builds/slave/test', 18:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:12 INFO - 'SHELL': '/bin/bash', 18:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:12 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:12 INFO - 'USER': 'cltbld', 18:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:12 INFO - 'XPC_FLAGS': '0x0', 18:54:12 INFO - 'XPC_SERVICE_NAME': '0', 18:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:13 INFO - Downloading/unpacking psutil>=3.1.1 18:54:13 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 18:54:13 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 18:54:13 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 18:54:13 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 18:54:13 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 18:54:13 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 18:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:16 INFO - Installing collected packages: psutil 18:54:16 INFO - Running setup.py install for psutil 18:54:16 INFO - building 'psutil._psutil_osx' extension 18:54:16 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 18:54:17 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 18:54:17 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 18:54:17 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 18:54:17 INFO - building 'psutil._psutil_posix' extension 18:54:17 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 18:54:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:54:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:54:17 INFO - ^ 18:54:17 INFO - 1 warning generated. 18:54:17 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 18:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:54:17 INFO - Successfully installed psutil 18:54:17 INFO - Cleaning up... 18:54:17 INFO - Return code: 0 18:54:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:17 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:17 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 18:54:17 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 18:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:17 INFO - 'HOME': '/Users/cltbld', 18:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:17 INFO - 'LOGNAME': 'cltbld', 18:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:17 INFO - 'MOZ_NO_REMOTE': '1', 18:54:17 INFO - 'NO_EM_RESTART': '1', 18:54:17 INFO - 'PAGER': '/bin/cat', 18:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:17 INFO - 'PWD': '/builds/slave/test', 18:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:17 INFO - 'SHELL': '/bin/bash', 18:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:17 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:17 INFO - 'USER': 'cltbld', 18:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:17 INFO - 'XPC_FLAGS': '0x0', 18:54:17 INFO - 'XPC_SERVICE_NAME': '0', 18:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:54:18 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 18:54:18 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 18:54:18 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 18:54:18 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 18:54:18 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 18:54:18 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 18:54:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:54:20 INFO - Installing collected packages: mozsystemmonitor 18:54:20 INFO - Running setup.py install for mozsystemmonitor 18:54:20 INFO - Successfully installed mozsystemmonitor 18:54:20 INFO - Cleaning up... 18:54:20 INFO - Return code: 0 18:54:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:20 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:20 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 18:54:20 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 18:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:20 INFO - 'HOME': '/Users/cltbld', 18:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:20 INFO - 'LOGNAME': 'cltbld', 18:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:20 INFO - 'MOZ_NO_REMOTE': '1', 18:54:20 INFO - 'NO_EM_RESTART': '1', 18:54:20 INFO - 'PAGER': '/bin/cat', 18:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:20 INFO - 'PWD': '/builds/slave/test', 18:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:20 INFO - 'SHELL': '/bin/bash', 18:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:20 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:20 INFO - 'USER': 'cltbld', 18:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:20 INFO - 'XPC_FLAGS': '0x0', 18:54:20 INFO - 'XPC_SERVICE_NAME': '0', 18:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:21 INFO - Downloading/unpacking jsonschema==2.5.1 18:54:21 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 18:54:21 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 18:54:21 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 18:54:21 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 18:54:21 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 18:54:21 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 18:54:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:54:23 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 18:54:23 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 18:54:23 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 18:54:23 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 18:54:23 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 18:54:23 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 18:54:24 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:24 INFO - warning: no files found matching '*.txt' 18:54:24 INFO - no previously-included directories found matching 'build' 18:54:24 INFO - no previously-included directories found matching 'dist' 18:54:24 INFO - no previously-included directories found matching '.git*' 18:54:24 INFO - Installing collected packages: jsonschema, functools32 18:54:24 INFO - Running setup.py install for functools32 18:54:24 INFO - warning: no files found matching '*.txt' 18:54:24 INFO - no previously-included directories found matching 'build' 18:54:24 INFO - no previously-included directories found matching 'dist' 18:54:24 INFO - no previously-included directories found matching '.git*' 18:54:24 INFO - Successfully installed jsonschema functools32 18:54:24 INFO - Cleaning up... 18:54:24 INFO - Return code: 0 18:54:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:54:24 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')]} 18:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:24 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')]} 18:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:24 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:24 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 18:54:24 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 18:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:24 INFO - 'HOME': '/Users/cltbld', 18:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:24 INFO - 'LOGNAME': 'cltbld', 18:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:24 INFO - 'MOZ_NO_REMOTE': '1', 18:54:24 INFO - 'NO_EM_RESTART': '1', 18:54:24 INFO - 'PAGER': '/bin/cat', 18:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:24 INFO - 'PWD': '/builds/slave/test', 18:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:24 INFO - 'SHELL': '/bin/bash', 18:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:24 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:24 INFO - 'USER': 'cltbld', 18:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:24 INFO - 'XPC_FLAGS': '0x0', 18:54:24 INFO - 'XPC_SERVICE_NAME': '0', 18:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:54:24 INFO - Cleaning up... 18:54:24 INFO - Return code: 0 18:54:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:54:24 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')]} 18:54:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:24 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')]} 18:54:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:24 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:24 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 18:54:24 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 18:54:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:24 INFO - 'HOME': '/Users/cltbld', 18:54:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:24 INFO - 'LOGNAME': 'cltbld', 18:54:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:24 INFO - 'MOZ_NO_REMOTE': '1', 18:54:24 INFO - 'NO_EM_RESTART': '1', 18:54:24 INFO - 'PAGER': '/bin/cat', 18:54:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:24 INFO - 'PWD': '/builds/slave/test', 18:54:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:24 INFO - 'SHELL': '/bin/bash', 18:54:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:24 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:24 INFO - 'USER': 'cltbld', 18:54:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:24 INFO - 'XPC_FLAGS': '0x0', 18:54:24 INFO - 'XPC_SERVICE_NAME': '0', 18:54:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:54:24 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 18:54:24 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 18:54:24 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 18:54:24 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 18:54:24 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 18:54:24 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 18:54:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:54:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:54:27 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 18:54:27 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 18:54:27 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 18:54:27 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 18:54:27 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 18:54:27 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 18:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:54:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:54:28 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 18:54:28 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 18:54:28 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 18:54:28 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 18:54:28 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 18:54:28 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 18:54:28 INFO - Downloading docopt-0.6.1.tar.gz 18:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:54:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:54:28 INFO - Running setup.py install for blobuploader 18:54:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:54:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:54:28 INFO - Running setup.py install for requests 18:54:29 INFO - Running setup.py install for docopt 18:54:29 INFO - Successfully installed blobuploader requests docopt 18:54:29 INFO - Cleaning up... 18:54:29 INFO - Return code: 0 18:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:29 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')]} 18:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:29 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')]} 18:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:29 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:29 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 18:54:29 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 18:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:29 INFO - 'HOME': '/Users/cltbld', 18:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:29 INFO - 'LOGNAME': 'cltbld', 18:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:29 INFO - 'MOZ_NO_REMOTE': '1', 18:54:29 INFO - 'NO_EM_RESTART': '1', 18:54:29 INFO - 'PAGER': '/bin/cat', 18:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:29 INFO - 'PWD': '/builds/slave/test', 18:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:29 INFO - 'SHELL': '/bin/bash', 18:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:29 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:29 INFO - 'USER': 'cltbld', 18:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:29 INFO - 'XPC_FLAGS': '0x0', 18:54:29 INFO - 'XPC_SERVICE_NAME': '0', 18:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-b3xgQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:29 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-vw8enT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-nuOfVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-gGm1Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-naDIy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-IbCWGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-elW3s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-H15wCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-c_ESB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-H4Jnib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-puHpUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:30 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wpBegr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:31 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-L7HQEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:31 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-sLb4hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:31 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-lrTq2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:31 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-cG_f0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:31 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-i42YwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:54:31 INFO - Running setup.py install for manifestparser 18:54:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:54:31 INFO - Running setup.py install for mozcrash 18:54:31 INFO - Running setup.py install for mozdebug 18:54:31 INFO - Running setup.py install for mozdevice 18:54:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Running setup.py install for mozfile 18:54:32 INFO - Running setup.py install for mozhttpd 18:54:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Running setup.py install for mozinfo 18:54:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Running setup.py install for mozInstall 18:54:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:54:32 INFO - Running setup.py install for mozleak 18:54:32 INFO - Running setup.py install for mozlog 18:54:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Running setup.py install for moznetwork 18:54:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Running setup.py install for mozprocess 18:54:33 INFO - Running setup.py install for mozprofile 18:54:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Running setup.py install for mozrunner 18:54:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:54:33 INFO - Running setup.py install for mozscreenshot 18:54:33 INFO - Running setup.py install for moztest 18:54:33 INFO - Running setup.py install for mozversion 18:54:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:54:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:54:34 INFO - Cleaning up... 18:54:34 INFO - Return code: 0 18:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:34 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:34 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 18:54:34 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 18:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:34 INFO - 'HOME': '/Users/cltbld', 18:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:34 INFO - 'LOGNAME': 'cltbld', 18:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:34 INFO - 'MOZ_NO_REMOTE': '1', 18:54:34 INFO - 'NO_EM_RESTART': '1', 18:54:34 INFO - 'PAGER': '/bin/cat', 18:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:34 INFO - 'PWD': '/builds/slave/test', 18:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:34 INFO - 'SHELL': '/bin/bash', 18:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:34 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:34 INFO - 'USER': 'cltbld', 18:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:34 INFO - 'XPC_FLAGS': '0x0', 18:54:34 INFO - 'XPC_SERVICE_NAME': '0', 18:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-SjHL7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:54:34 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)) 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-kSbuAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:54:34 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)) 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-35EmAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:54:34 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)) 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Pd6Rwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:54:34 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)) 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-f8OF7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:54:34 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)) 18:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:54:34 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-fVmPAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Xk_ln3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BLkqkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-tVyoXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-SbDLgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-5kWw9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BqjtUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-xGQPET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-zAwvhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-nrTKp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:54:35 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)) 18:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:54:35 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wqGMnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:54:36 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)) 18:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:54:36 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-AYlMB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:54:36 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)) 18:54:36 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)) 18:54:36 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)) 18:54:36 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)) 18:54:36 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)) 18:54:36 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)) 18:54:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:54:36 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 18:54:36 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 18:54:36 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 18:54:36 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 18:54:36 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 18:54:36 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 18:54:38 INFO - Downloading blessings-1.6.tar.gz 18:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:38 INFO - Installing collected packages: blessings 18:54:38 INFO - Running setup.py install for blessings 18:54:38 INFO - Successfully installed blessings 18:54:38 INFO - Cleaning up... 18:54:39 INFO - Return code: 0 18:54:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:39 INFO - Reading from file tmpfile_stdout 18:54:39 INFO - Current package versions: 18:54:39 INFO - blessings == 1.6 18:54:39 INFO - blobuploader == 1.2.4 18:54:39 INFO - docopt == 0.6.1 18:54:39 INFO - functools32 == 3.2.3-2 18:54:39 INFO - jsonschema == 2.5.1 18:54:39 INFO - manifestparser == 1.1 18:54:39 INFO - mozInstall == 1.12 18:54:39 INFO - mozcrash == 0.17 18:54:39 INFO - mozdebug == 0.1 18:54:39 INFO - mozdevice == 0.48 18:54:39 INFO - mozfile == 1.2 18:54:39 INFO - mozhttpd == 0.7 18:54:39 INFO - mozinfo == 0.9 18:54:39 INFO - mozleak == 0.1 18:54:39 INFO - mozlog == 3.4 18:54:39 INFO - moznetwork == 0.27 18:54:39 INFO - mozprocess == 0.23 18:54:39 INFO - mozprofile == 0.28 18:54:39 INFO - mozrunner == 6.12 18:54:39 INFO - mozscreenshot == 0.1 18:54:39 INFO - mozsystemmonitor == 0.3 18:54:39 INFO - moztest == 0.7 18:54:39 INFO - mozversion == 1.4 18:54:39 INFO - psutil == 3.1.1 18:54:39 INFO - requests == 1.2.3 18:54:39 INFO - wsgiref == 0.1.2 18:54:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:39 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')]} 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:39 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')]} 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:39 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:39 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 18:54:39 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 18:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:39 INFO - 'HOME': '/Users/cltbld', 18:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:39 INFO - 'LOGNAME': 'cltbld', 18:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:39 INFO - 'MOZ_NO_REMOTE': '1', 18:54:39 INFO - 'NO_EM_RESTART': '1', 18:54:39 INFO - 'PAGER': '/bin/cat', 18:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:39 INFO - 'PWD': '/builds/slave/test', 18:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:39 INFO - 'SHELL': '/bin/bash', 18:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:39 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:39 INFO - 'USER': 'cltbld', 18:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:39 INFO - 'XPC_FLAGS': '0x0', 18:54:39 INFO - 'XPC_SERVICE_NAME': '0', 18:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 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)) 18:54:39 INFO - Cleaning up... 18:54:39 INFO - Return code: 0 18:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:54:39 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')]} 18:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:39 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')]} 18:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:39 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 0x101f9f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f15570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a1dbd3a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, '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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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 18:54:39 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 18:54:39 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 18:54:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:54:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:54:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:54:39 INFO - 'HOME': '/Users/cltbld', 18:54:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:54:39 INFO - 'LOGNAME': 'cltbld', 18:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:39 INFO - 'MOZ_NO_REMOTE': '1', 18:54:39 INFO - 'NO_EM_RESTART': '1', 18:54:39 INFO - 'PAGER': '/bin/cat', 18:54:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:39 INFO - 'PWD': '/builds/slave/test', 18:54:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:54:39 INFO - 'SHELL': '/bin/bash', 18:54:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:54:39 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:54:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:54:39 INFO - 'USER': 'cltbld', 18:54:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:54:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:39 INFO - 'XPC_FLAGS': '0x0', 18:54:39 INFO - 'XPC_SERVICE_NAME': '0', 18:54:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:54:39 INFO - Cleaning up... 18:54:39 INFO - Return code: 0 18:54:39 INFO - Running post-action listener: _resource_record_post_action 18:54:39 INFO - Running post-action listener: _start_resource_monitoring 18:54:39 INFO - Starting resource monitoring. 18:54:39 INFO - [mozharness: 2016-09-27 01:54:39.877411Z] Finished create-virtualenv step (success) 18:54:39 INFO - [mozharness: 2016-09-27 01:54:39.878462Z] Running install step. 18:54:39 INFO - Running pre-action listener: _resource_record_pre_action 18:54:39 INFO - Running main action method: install 18:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:40 INFO - Reading from file tmpfile_stdout 18:54:40 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:54:40 INFO - Reading from file tmpfile_stdout 18:54:40 INFO - Output received: 18:54:40 INFO - Usage: mozinstall [options] installer 18:54:40 INFO - Options: 18:54:40 INFO - -h, --help show this help message and exit 18:54:40 INFO - -d DEST, --destination=DEST 18:54:40 INFO - Directory to install application into. [default: 18:54:40 INFO - "/builds/slave/test"] 18:54:40 INFO - --app=APP Application being installed. [default: firefox] 18:54:40 INFO - mkdir: /builds/slave/test/build/application 18:54:40 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'] 18:54:40 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 18:55:14 INFO - Reading from file tmpfile_stdout 18:55:14 INFO - Output received: 18:55:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:55:14 INFO - Running post-action listener: _resource_record_post_action 18:55:14 INFO - [mozharness: 2016-09-27 01:55:14.636083Z] Finished install step (success) 18:55:14 INFO - [mozharness: 2016-09-27 01:55:14.636210Z] Running run-tests step. 18:55:14 INFO - Running pre-action listener: _resource_record_pre_action 18:55:14 INFO - Running main action method: run_tests 18:55:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:55:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:55:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:55:14 INFO - 2016-09-26 18:55:14.650 screenresolution[1650:8525] starting screenresolution argv=screenresolution get 18:55:14 INFO - 2016-09-26 18:55:14.653 screenresolution[1650:8525] Display 0: 1600x1200x32@60 18:55:14 INFO - 2016-09-26 18:55:14.659 screenresolution[1651:8527] starting screenresolution argv=screenresolution list 18:55:14 INFO - Available Modes on Display 0 18:55:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:55:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:55:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:55:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:55:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:55:14 INFO - Intel Iris: 18:55:14 INFO - Chipset Model: Intel Iris 18:55:14 INFO - Type: GPU 18:55:14 INFO - Bus: Built-In 18:55:14 INFO - VRAM (Dynamic, Max): 1536 MB 18:55:14 INFO - Vendor: Intel (0x8086) 18:55:14 INFO - Device ID: 0x0a2e 18:55:14 INFO - Revision ID: 0x0009 18:55:14 INFO - Displays: 18:55:14 INFO - Display: 18:55:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:55:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:55:14 INFO - Display Serial Number: 1600x1200 60 18:55:14 INFO - Main Display: Yes 18:55:14 INFO - Mirror: Off 18:55:14 INFO - Online: Yes 18:55:14 INFO - Rotation: Supported 18:55:14 INFO - Return code: 0 18:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:55:14 INFO - Python 2.7.3 18:55:14 INFO - Return code: 0 18:55:14 INFO - grabbing minidump binary from tooltool 18:55: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')]} 18:55:14 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 0x101db3d30>, '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 0x101bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101dabb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:55:14 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 18:55:14 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 18:55:14 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 18:55:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:55:15 INFO - Return code: 0 18:55:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:55:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:55:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:55:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:55:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:55:15 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/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 18:55:15 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/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --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 18:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sZAyDSOhPg/Render', 18:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:55:15 INFO - 'HOME': '/Users/cltbld', 18:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:55:15 INFO - 'LOGNAME': 'cltbld', 18:55:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:55:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:55:15 INFO - 'MOZ_NO_REMOTE': '1', 18:55:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:55:15 INFO - 'NO_EM_RESTART': '1', 18:55:15 INFO - 'PAGER': '/bin/cat', 18:55:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:55:15 INFO - 'PWD': '/builds/slave/test', 18:55:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:55:15 INFO - 'SHELL': '/bin/bash', 18:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0UMg3Q4LZv/Listeners', 18:55:15 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 18:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:55:15 INFO - 'USER': 'cltbld', 18:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:55:15 INFO - 'XPC_FLAGS': '0x0', 18:55:15 INFO - 'XPC_SERVICE_NAME': '0', 18:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:55:15 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/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--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 18:55:15 INFO - mozversion application_buildid: 20160926041252 18:55:15 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 18:55:15 INFO - mozversion application_display_name: Nightly 18:55:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:55:15 INFO - mozversion application_name: Firefox 18:55:15 INFO - mozversion application_remotingname: firefox 18:55:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:55:15 INFO - mozversion application_vendor: Mozilla 18:55:15 INFO - mozversion application_version: 52.0a1 18:55:15 INFO - mozversion platform_buildid: 20160926041252 18:55:15 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 18:55:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:55:15 INFO - mozversion platform_version: 52.0a1 18:55:15 INFO - using testdate: 1474941315 18:55:15 INFO - actual date: 1474941315 18:55:15 INFO - starting webserver on 'localhost:49278' 18:55:15 INFO - SUITE-START | Running 2 tests 18:55:15 INFO - TEST-START | dromaeo_css 18:55:15 INFO - operating with platform_type : mac_ 18:55:15 INFO - Initialising browser for dromaeo_css test... 18:55:15 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpGkfYhR/profile http://localhost:49278/getInfo.html) 18:55:17 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 18:55:17 INFO - PROCESS | 1661 | colorDepth:24 18:55:17 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 18:55:17 INFO - PROCESS | 1661 | __metrics 18:55:17 INFO - PROCESS | 1661 | 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" 18:55:17 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:55:18 INFO - TEST-INFO | 1661: exit 0 18:55:18 INFO - Browser initialized. 18:55:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:55:18 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpGkfYhR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:30 INFO - PROCESS | 1664 | RSS: Main: 236003328 18:55:30 INFO - PROCESS | 1664 | 18:56:21 INFO - PROCESS | 1664 | 1474941381974 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] 18:58:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 18:58:35 INFO - PROCESS | 1664 | RSS: Main: 395194368 18:58:35 INFO - PROCESS | 1664 | 19:01:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 19:01:38 INFO - PROCESS | 1664 | RSS: Main: 375209984 19:01:38 INFO - PROCESS | 1664 | 19:04:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 19:04:41 INFO - PROCESS | 1664 | RSS: Main: 343318528 19:04:41 INFO - PROCESS | 1664 | 19:07:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 19:07:44 INFO - PROCESS | 1664 | RSS: Main: 342409216 19:07:44 INFO - PROCESS | 1664 | 19:10:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 19:10:48 INFO - PROCESS | 1664 | RSS: Main: 330104832 19:10:48 INFO - PROCESS | 1664 | 19:13:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 19:13:52 INFO - PROCESS | 1664 | RSS: Main: 598032384 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | __start_tp_report 19:13:52 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 19:13:52 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 19:13:52 INFO - PROCESS | 1664 | |i|pagename|runs| 19:13:52 INFO - PROCESS | 1664 | |0;dojo.html;3229;3283.1463819406945;3298.7361011119115;3325.6674332566763;3341.9331613367735;4552.544745525446;5353.741870660392;5411.269478620395;5463.2078348639425;5480.287562616859;4613.6539759518;5491.093969495038;5514;5517.779288828442;5520.696361700105;5029.773660185291;5034.320366750479;5037.647364684455;5051.0150520648485;5127.487251274862;4964.801407943678;5024.648274620778;5034.82378116766;5045.596352291826;5053.292539044537;5055.772490237948;5064.366954130734;5097.464766199551;5119.846404607868;5134.9229761553415;5147.305113809644;5159.2003239497935;5160.122779127557;5161.27742116104;5190.273361729361;4931.778069986859;5002.674826136289;5005.199168133081;5060;5088.720120393377;5382.138857782736;5396.055690254189;5430.70131142787;5449.155380915925;5503.229547863302;5263.526282634543;5547.583931205136;5875.970620146872;5894.705264736746;5940.732667029994;5893.970530147365;6016.75932962681;6069.059295809113;6085.208922840046;6098.817035488943;5498.697571633518;5515.062439385314;5552.5280351169795;5554.166874968787;5565;6173.722182501798;6203.31763506014;6209.037599172136;6217.844553886189;6219.284782250009;5787.971060144757;5799.3040835100055;5802.042662960649;5807.041838096751;5847.912281315784;5040.571551418097;5891.351951285355;5946;5951.226340575784;5961.135635332853;5901.793437229677;5930.822075337746;5957.642541447441;5977.970110149421;5996.700164991733;5919.4080591940465;5920.585559010828;5999.1901093351835;5999.340072592011;6009.819705408845;4694.81220751173;4754.952450475451;4757.714537127784;4772.164871147535;4781.737004464788;4189.664826813909;4293.592108749664;4295.892602684896;4326.329418940069;4366.825326986948;5528.75120619573;5534.225208470817;5540.722963851791;5546.334439867242;5552.750126244328;5989.850253743604;6000.759969601254;6012.819615411545;6013.579049466583;6016.977113890649;5358.866028349323;5453.045716999509;5465.808696695596;5508.118701007819;5554.972225138848;5168.8449346519665;5208.244804503402;5212.530872221519;5237.816676416307;5241.475852414805;6259.1550140730415;6279.7488100476385;6285.962816135287;6290.905636415366;6295.874082518232;5794.2177805997335;5817.331006934088;5901.173835663097;5950.702464876826;5961.433663801932;6178.351273116258;6247;6270.310265870842;6294.213223347082;6322.841928951813;5902.911456328073;5924.31870334917;5934.643921364732;5935.169076329231;6002.129691194839;5657.12314591239;5990.940090599212;6008.969955150196;6033.487153591994;6047.395260473917;4601.9185491408825;5493.890122197454;5747.5401967841635;5755.165501002415;5775.451332123442;5715.114157305624;5824.504917082096;5831.271091113611;5843.532517398513;5848.619839710405;5613.831585052455;5689.487946084872;5696.458836410535;5708.429157084258;5710.942890571041;5644.548436125182;5748.856278592902;5768.50967667753;5789.247397838254;5824.388439213991;5657.038303488499;5669;5675.602707810413;5726.226959360433;5731.19763233156 19:13:52 INFO - PROCESS | 1664 | |1;ext.html;473.5714178668304;524.8163142899986;529.9284596579462;541.6912359954828;550.0731267813732;30823;31365.84317078414;32469.188270293256;32604.184895377628;40258.19483610326;35281.11797205065;40340.79829600855;43112;43183.56816431835;43222.56777432225;9747.756306092333;9915.058069483424;9920.603175872993;9925.90074099257;9942.751431214205;8763;8935.687250946217;9729.659461918834;9854.310198286123;9859.408435493857;12030.879691203107;12269.631911042683;12270.877291227063;12542.178009947735;12557.932575731074;11989.460474278678;12006.399680016051;12026.278423294587;12142.028637708961;12144.757104857854;8667.913320866774;8857.86713199296;11057.50241239146;11089.667309980632;11164.274322169114;39296.41055384171;40099.7995010026;40211.59788402108;41925.58074419247;41982.95042623928;3272.149241197282;3289.276359200972;3326.534285200074;3463.619001909788;3750.924981500382;30114.54828177579;30488.69511304881;31830.522542161885;31910.521342179887;32291.51562726561;3217.3404452087266;3318.7013168814683;3355.6644335566493;3394.439917413624;3398.8130652814084;405002;408282.2131897465;409376;412659.9367003146;416631;59109.70445147747;59470.70264648649;59557;59595;59596.126251793496;63342;63538.68230658909;63570;63586.72826543443;63602.0459693105;16232.75650865238;16493.6701265974;16494.587635308973;16502.587435313973;16545.007299562065;12755.489780408865;12796.744065118646;12806.103572749818;12810.42353094113;12820.038497112753;12971.027172962065;13886.375113119933;16200.51398458048;16937.745933811002;18125.728114078298;5711.343195532484;6563.704633291513;6740.4270636995425;6810.795676129724;6813.705395974749;834.7078522517191;861.3927181337267;972.2027937091517;1006.2302338710892;1009.742515658517;28188.85905570459;29494.705052949197;29695.42134046564;30086.946956856842;30128.84935575352;1014.761531040205;1036.7926414717087;1057.8730552333768;1068.0974576482859;1096.331237944853;14521.636959076108;15402.537923862303;15512.457064002705;15828.050316980787;16423.343066277215;376054;468672;499830;501852;507770;57955;58314;58380.4161958375;58456.830863383344;58523;1301.7591745526918;1333.6599167212298;1361.884239839605;1362.8194888178834;1363.6863521390135;25985.740142598333;30298;30824.229394265323;30918;31668.841655791573;50931;51101.744491277306;51263.487365125875;51264;51333.23000154926;458299;463548;464378;467777;468196;25466.618000730374;25890.352741180868;26160.60759088577;26358.341041474116;26463.147579670007;38566.80716596399;39277.41083883687;39838;40287.1942561153;48070.27894581514;30740.077797666105;32238.516422253215;33368.33263334768;40243.99390015273;40672.79663601781;37853.242935141694;38596.22807543777;38646.806765967114;39965.80017099896;39996.60003399929;37138.44292335671;37580;38004.61995380011;38424.42363364496;38812.223755525294;32696.855610054485;34024.48963265603;34099;34106;34450;22483;25271;25585.87207063953;26101.608475873258;26156.34609134787 19:13:52 INFO - PROCESS | 1664 | |2;jquery.html;353.48744320734943;365.81343514807446;371.75278439837507;382.40917782026776;400.7375169264131;15178.62053448663;15315.617109572266;16446.917765411185;20546.69179962302;21291;20067.899660501713;20527.384178474633;21162.047707853144;21235.256766013194;21448.356549303546;5769.971150144243;6033.306169790487;6066.332703402622;6310.116583678288;6334.461570766491;5686.573506986972;6247.562670613059;6257.9374206258035;6284.183056202687;6290.654014029226;4034.435179074932;4496.7751612419415;6611.537192396534;6913.101296831405;6984;6747.662616869186;6829.795106146824;6931.09895713559;7051.717931282743;7073.221945586007;5894;5894.381089985575;5916.201312822757;5960.225170727821;6086.939130608682;23497.530049398916;24409.877950610135;26025.869870650717;26513;26699.866500667566;2542.5169217848547;2559.820812543123;2576.9226923192336;3020.1845501714633;3108.0675797260733;10014.64948726791;10386.584536618526;10398.896011039868;12836.486540538368;14914.17972011539;1820.2718912435;1867.2344338821154;1895.469268604793;1922.5001499610203;1985.8411327093797;103641;110151.44924275327;112228.87771122348;112811;114381.428092859;11299.3785341807;11372.019793072359;11386.772264554662;11532.654020379403;11714.765704685859;14211.715765684628;14531.709365812625;14555;14557.708845823236;14575.85424145745;6943.79168624942;8368.874466883002;8498.787530311793;8633.91366086331;8656.826863462695;8428.704995325133;8441.788955276044;8458.619362128718;8638.438501497509;8687.522186279815;4426.945407668698;4509.7970591323465;4519.864404067883;4602.562756538124;4603.309503574491;1863.6179583185415;1927.267638297438;1932.4009557037364;1955.8728682635583;1977.4660841572982;837.7151768398774;901.1664210605164;943.0428115462811;975.1662328708852;1011.812814629296;19268;21609;21719.56560868774;21730.022149003333;21737.130514779547;808.2826713890778;932.5150921520772;953.9379940303996;965.1940629574244;971.9271054670928;9126.634934602542;10079.143272821892;10378.948105259426;11349.765316884648;11400.657980260605;397366;397502;471007;475537;479516;104992;122498;122639;125660.37169814092;127240;963.3641796414473;983.9065288797552;1025.1388833379997;1031.0256807317014;1034.1416624201895;18898.7165192525;19214.943178124777;19316;19330.226790928205;19358;46997;47936.760316199594;48343.27485087797;52066.73966630142;52647.73676131595;74693.87959180726;75041.24463819669;75611;76176.23823761691;76749.61625191839;7489.588072656056;7624.580648064188;8293.83412331762;8294.668213271401;8376.87434688468;11907.940460297643;13064.21614703121;13167.2757998311;13251.867481325064;13374.598762037154;11388;11499.655010349703;11543.76912461763;11612.6516204514;11631.069514438655;11192.552297907992;11348.716282093013;11375.033122184375;11629.185956983269;11802.291862488279;11226.5120922677;11718.765624687629;11839.822402663794;11863.288202707865;11918.642440726791;7954.880676789737;8088.312493438124;8137.511749295061;8227.095019547965;8406.411551191359;8333.916660833314;10509.842352364567;10664.786704265716;11050.889491105308;11128.109751220045 19:13:52 INFO - PROCESS | 1664 | |3;mootools.html;1354.3160703844558;1497.99251003745;1523.314508471188;1733.4799560131958;1928.296171897257;7852.1755215702315;8321.791955201115;8529.573521323931;8805.383623146383;8832.558372081403;8722.60748266328;8801.383903126783;8820.823583528325;8832.160944710258;8835.734927952155;2325.1280769711316;2348.412896775806;2349.600567903452;2355.199232261031;2356.9175078872245;2228.6099932511747;2256.379495638696;2271.5343354612264;2273.6703178039174;2275;2321.257197696738;2342.2856028911174;2361.8346715729904;2366.7633236676365;2366.7869891709743;1991.7709463411747;2307.9423014424606;2333.439974406139;2339.146211632759;2346.9413264668433;2293.323469576479;2326.174208156097;2328.2084091409;2330.1727886600183;2332.7084114485688;8681.82636347276;8734.301255899512;8739.213470787596;8744.169303916118;8764.25503832175;5092.872678183038;5332.253484512172;5335.1997200419855;5336.91994620081;5341.893162136775;3495.493153492729;3665.3585622515952;3733.5146430964073;3737.9813100934593;3740.775553466801;834.8664213725835;921.5668635741258;959.3764053365369;966.7389804752678;978.4325091447015;11689.590864319707;11720.355380454072;11818.995385392165;11824.704382390422;11825.763484730343;3857.746232474457;4374.912501749947;4403.339499075164;4590.495045544987;4592.104539614743;9096.727098186933;9112.95443522778;9124.361294709306;9124.58939347731;9129.817403652023;5203.687778733288;5206.140986737221;5211.530962213419;5217.686938783685;5218.2955301034635;4108.589141085868;4374.62815660666;4520.118576877478;4546.909061818811;4889.315495830587;3720.479132921393;3730.198007428416;3774.9056273592832;3775.7734535927934;3782.149016471327;1033;1034.3535290443472;1041.6198087698087;1042.5777560088177;1051.6319288249204;898.7169041751828;917.9495127767904;925.5464822237055;935.2704890185666;951.7477868364889;5451.209574611659;5763.87604417143;5831.125331200354;5836.941630583639;6253.165311168649;739.563657442101;819.3076850061689;929.2612373163352;965.2037069417759;975.1272611013245;3778.508793856836;3919.2755187717885;3940.6847452203756;4052.696047796368;4135.421041054255;10622.46887655614;10908.945455272673;10999.065079468175;11001.779964400666;11006.009459148716;10499.370037797757;10967.451627418597;10968.835467467834;10969.506372213269;10992.835107473395;8087.514749115072;8095.461862246154;8247.876281855777;8258.298044666271;8264.21489958453;5757.596968212185;5801.912971305349;5856.41435856428;5891.204687367151;5934.228550288435;9976.002399759966;9983.500824958577;10042.397456152654;10049.849252261076;10052.396856188652;8557.700480483154;9129;9840.852387214341;10027.849582256418;10183.949080254848;6687.531872768859;7085.468589855885;7114.039604653305;7197.640117993975;7209.783706488814;8284.751457456287;8312.6674933002;8358.164183581594;8383.496990180609;8387.07742148351;7477.92522074794;7501.362384197186;7548.1697013329585;7569.545827250383;7573.431992600466;7072.611006394698;7256.7097316106765;7325.560466372035;7386.446016548673;7494.5503269803985;6688.004300711209;6990.720371185095;7098.3256590623805;7115.430765538848;7124.536905101152;4588.931166032579;4868;5010.098182327216;5118.334616499831;5245.475452454724;5036.949630503795;5057.165567681292;5089.338386009795;5091.1854103343285;5232.1628539433505 19:13:52 INFO - PROCESS | 1664 | |4;prototype.html;292.0799481632856;295.2162009863812;304.8658590220303;306.3383092520157;308.8532946850245;4719.197736384815;4955.578775804056;5263.473472773241;5277.1556550951855;5314.256004159416;4290.4636920384955;4890.31284206948;4954.430240522341;5030.170021946384;5116.616253780972;3986.5614782373987;4005;4006.83972641094;4012.816219215324;4016.9355120892988;3315.668433156689;4020.517537895457;4031.254217969685;4037.4347591337237;4044.6338891748364;3634.7637403568683;3732.514773079496;3986.66113380363;3995.9221204973396;4015.1768887378016;2980.7764417668545;3603.5135256740527;3984.780837053961;3994.204057159985;4014.9799251003706;3448.586169659657;3480.912977175591;3495.2485215678753;3496.35317466267;3500.334936362083;4905.803011916384;5083.720395378253;5094.541491265803;5095.31213286209;5127.410347810012;3817.3701339279264;4508.752018638974;4568.611668008223;4576.610988066019;4610.815567377301;5170.5346518813485;5451.138152469945;5456.162795346438;5521.4478552144865;5537.972310138463;3195.121341631047;3711.2391959648207;3828.37756137047;3851.595582463829;3864.3430616795213;5687.800926967537;5753.490370873806;5764.394738552433;5773.711314434261;5798.565107616945;3050.8474576271096;3862.1889403225637;3880.708946828999;3891.1633998690418;3892.4355968384425;3935.6064393560414;3952.110775075585;3969.325214713506;3972.64246217836;3991.960080399217;3837.9808100959317;3926.6466018058513;4086.570910054461;4535.7732113394195;4591.770411479412;5026.949730502648;5518.227448157261;5528.728392469755;5545.528630066409;5570.888582228333;1307.4312673986847;1325.6288239293012;1334.2061473423298;1336.6791969927342;1337.3714354253486;823.6952327638692;834.7853872615331;847.1951645936385;855.4567849415541;857.7469646454311;5171.793128274902;5182.2639415795375;5237.292965449616;5246.635874672536;5264.973675131677;4202.558731333227;4873.439554451213;5426.906663201937;5522.723863806794;5650.604457687922;4052.392141178847;4960.603151747851;5175.696814917401;5190;5227.843164705065;2920.532714765627;2930.531115021586;2933.31067199208;2939.1182645206354;2946.734793868562;5483.479069488392;5756.65460072397;5760.423957604206;5809.331926828469;5891.584450375325;5291.497307755757;5500.669959802424;5652.943470565242;5698.715064246854;5781.884362312814;5336.306280183551;5734.9390362783015;5890.293164820163;5897.970510147422;5907.645541267538;5203.869903252297;5555.000099982042;5569.303837020372;5576.33084029919;5616.269884915098;4813.4729267135035;5518.586106041983;5549.278593782944;5552.889422115674;5577.358603760619;4876.463589005278;5791.276090488689;5811.27359080115;5831.533477321719;5862.472377486047;3585.4442561403025;3743.2326373092906;3747.231817477356;3775.5091838060875;3776.263628592398;4589.449266088091;4609.7181894962205;5477.534409575231;5485.204645326326;5624.634398764068;4812.542808433193;5454.963556924172;5466.512736704869;5496.780128794963;5612.074007788669;5254.422013578427;5324.1747529133045;5382.811601594082;5417.2642815377985;5461.972690136524;4439.8668039957565;4565.885852853705;5125.384953805567;5352.073253628769;5356.437574054668;5351.759170837244;5355.839324820262;5369.597280203922;5373.811916583058;5377.435369286169;4972;5019.774110164978;5371.758270877898;5375.274337964324;5424.125213636778 19:13:52 INFO - PROCESS | 1664 | |5;yui.html;675.618275674244;720.8522252938149;723.6707298179325;767.2059418501851;787.767608555476;13091.869081309183;15023.023503472266;15656.843431565681;15714.371425142996;15787.842121578795;14181;14320;14330.92834535826;14692.412303507846;15294.617634559141;862.2670729879615;883.4125306671056;892.1346294094718;892.335210268351;894.1460904835899;883.593546968392;883.6244596046687;887.1306120002401;888.4491615198586;888.4935586715575;934.9018353072931;936.7704912296497;937.8921424036221;938.1556599060832;939.4457270210575;927.0775578299567;927.9489628070453;929.6049179098924;930.6370515498927;932.4871320773548;577.2524580668045;674.689642764329;684.9589024658486;687.6836655138642;688.1570076656056;15670.451534196249;15712.135832529206;15717.21413929299;15728.213589320603;15736;13588.796168057388;14039.859601403958;14090.436382544685;14092.084014539125;14201.91171945565;11623.302601843916;11963.820542691867;12133.514659413613;12162.027037836951;12315.93842030793;3635.0389005055285;3667.7982710950887;3812.275667623143;3815.065308999285;3887.4168874668744;105874;108082.37876431938;108783;108807;108808;10316.381017138996;10447.634332798316;11056.391898445501;11062.336259824275;11227.550897964153;21873.453163670718;21982.45043873884;21989.010494527785;21992.78007219939;22028.669569956463;7705.537667739954;7981.241782030698;8002.119766825645;8110.63502142405;8113.0669972953865;4232.8518501852905;4383.189110014658;4458.398116254264;4496.168208881302;4638.930416043762;3491.546099007113;3580.6598373154507;3659.780413175218;3659.908502287464;3664.8167591620313;647.9740810367532;654.5876098058193;656.0880376276979;683.2859661653584;684.7706018483764;586.3872253495108;617.7405489694339;623.3081279779441;626.3830127324582;637.5600835423636;8479;8679.52262625549;8930.629924796209;8956.507392093366;9117.726468205965;587.6973358720262;617.7483863303398;621.3910367839543;637.7225906730587;639.7760783725658;3309.7683162178896;4056.7971601419813;4205.833995492324;4285.114549598166;4443.577860103285;123184.38407807903;128942.71057289308;131062.34468827595;139726;142363;114508;116437;116784;119280;123654;98565.5071724651;99561;101812.49093754483;102577.48711256396;106621;6958.886578147472;8069.354451643737;8508.61711222984;8808.779780505281;8897.73306800797;53030.469695302556;58497;58929.70535147297;60705;61061;78777;79512;82950.17049829425;83897.58051209705;84918;12668.556600518938;13065.150765200231;13137.934310328386;13262.403191856196;13553.59339219825;14623.634409139431;14670.63323416923;14717.92641036788;15198.620034499227;15254.542363729106;13104.309311243554;13527.458901643824;13775;13781.310934453437;14053.578392648236;13714.725705486035;14043.297835108;14188;14227.64430889236;14341.92829035848;12890.548830790878;13456.327183640584;13468.326583670581;13484.460621575026;13621.978351623866;11026.614068507564;11356.488957997075;11401.81217545998;11843.703907402383;11909.880901190878;9399.496080627341;10451.738706532093;10621.760363089332;11644.35956022393;11681 19:13:52 INFO - PROCESS | 1664 | __end_tp_report 19:13:52 INFO - PROCESS | 1664 | __start_cc_report 19:13:52 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1506 19:13:52 INFO - PROCESS | 1664 | __end_cc_report 19:13:52 INFO - PROCESS | 1664 | __startTimestamp1474942432169__endTimestamp 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | ------- Summary: start ------- 19:13:52 INFO - PROCESS | 1664 | Number of tests: 6 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5504.49 Median:5657.04 stddev:613.36 (10.8%) stddev-sans-first:588.69 19:13:52 INFO - PROCESS | 1664 | Values: 3229.0 3283.1 3298.7 3325.7 3341.9 4552.5 5353.7 5411.3 5463.2 5480.3 4613.7 5491.1 5514.0 5517.8 5520.7 5029.8 5034.3 5037.6 5051.0 5127.5 4964.8 5024.6 5034.8 5045.6 5053.3 5055.8 5064.4 5097.5 5119.8 5134.9 5147.3 5159.2 5160.1 5161.3 5190.3 4931.8 5002.7 5005.2 5060.0 5088.7 5382.1 5396.1 5430.7 5449.2 5503.2 5263.5 5547.6 5876.0 5894.7 5940.7 5894.0 6016.8 6069.1 6085.2 6098.8 5498.7 5515.1 5552.5 5554.2 5565.0 6173.7 6203.3 6209.0 6217.8 6219.3 5788.0 5799.3 5802.0 5807.0 5847.9 5040.6 5891.4 5946.0 5951.2 5961.1 5901.8 5930.8 5957.6 5978.0 5996.7 5919.4 5920.6 5999.2 5999.3 6009.8 4694.8 4755.0 4757.7 4772.2 4781.7 4189.7 4293.6 4295.9 4326.3 4366.8 5528.8 5534.2 5540.7 5546.3 5552.8 5989.9 6000.8 6012.8 6013.6 6017.0 5358.9 5453.0 5465.8 5508.1 5555.0 5168.8 5208.2 5212.5 5237.8 5241.5 6259.2 6279.7 6286.0 6290.9 6295.9 5794.2 5817.3 5901.2 5950.7 5961.4 6178.4 6247.0 6270.3 6294.2 6322.8 5902.9 5924.3 5934.6 5935.2 6002.1 5657.1 5990.9 6009.0 6033.5 6047.4 4601.9 5493.9 5747.5 5755.2 5775.5 5715.1 5824.5 5831.3 5843.5 5848.6 5613.8 5689.5 5696.5 5708.4 5710.9 5644.5 5748.9 5768.5 5789.2 5824.4 5657.0 5669.0 5675.6 5726.2 5731.2 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:59843.13 Median:19372.37 stddev:119376.16 (616.2%) stddev-sans-first:119627.82 19:13:52 INFO - PROCESS | 1664 | Values: 473.6 524.8 529.9 541.7 550.1 30823.0 31365.8 32469.2 32604.2 40258.2 35281.1 40340.8 43112.0 43183.6 43222.6 9747.8 9915.1 9920.6 9925.9 9942.8 8763.0 8935.7 9729.7 9854.3 9859.4 12030.9 12269.6 12270.9 12542.2 12557.9 11989.5 12006.4 12026.3 12142.0 12144.8 8667.9 8857.9 11057.5 11089.7 11164.3 39296.4 40099.8 40211.6 41925.6 41983.0 3272.1 3289.3 3326.5 3463.6 3750.9 30114.5 30488.7 31830.5 31910.5 32291.5 3217.3 3318.7 3355.7 3394.4 3398.8 405002.0 408282.2 409376.0 412659.9 416631.0 59109.7 59470.7 59557.0 59595.0 59596.1 63342.0 63538.7 63570.0 63586.7 63602.0 16232.8 16493.7 16494.6 16502.6 16545.0 12755.5 12796.7 12806.1 12810.4 12820.0 12971.0 13886.4 16200.5 16937.7 18125.7 5711.3 6563.7 6740.4 6810.8 6813.7 834.7 861.4 972.2 1006.2 1009.7 28188.9 29494.7 29695.4 30086.9 30128.8 1014.8 1036.8 1057.9 1068.1 1096.3 14521.6 15402.5 15512.5 15828.1 16423.3 376054.0 468672.0 499830.0 501852.0 507770.0 57955.0 58314.0 58380.4 58456.8 58523.0 1301.8 1333.7 1361.9 1362.8 1363.7 25985.7 30298.0 30824.2 30918.0 31668.8 50931.0 51101.7 51263.5 51264.0 51333.2 458299.0 463548.0 464378.0 467777.0 468196.0 25466.6 25890.4 26160.6 26358.3 26463.1 38566.8 39277.4 39838.0 40287.2 48070.3 30740.1 32238.5 33368.3 40244.0 40672.8 37853.2 38596.2 38646.8 39965.8 39996.6 37138.4 37580.0 38004.6 38424.4 38812.2 32696.9 34024.5 34099.0 34106.0 34450.0 22483.0 25271.0 25585.9 26101.6 26156.3 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:30265.76 Median:2568.37 stddev:75643.59 (2945.2%) stddev-sans-first:75822.45 19:13:52 INFO - PROCESS | 1664 | Values: 353.5 365.8 371.8 382.4 400.7 15178.6 15315.6 16446.9 20546.7 21291.0 20067.9 20527.4 21162.0 21235.3 21448.4 5770.0 6033.3 6066.3 6310.1 6334.5 5686.6 6247.6 6257.9 6284.2 6290.7 4034.4 4496.8 6611.5 6913.1 6984.0 6747.7 6829.8 6931.1 7051.7 7073.2 5894.0 5894.4 5916.2 5960.2 6086.9 23497.5 24409.9 26025.9 26513.0 26699.9 2542.5 2559.8 2576.9 3020.2 3108.1 10014.6 10386.6 10398.9 12836.5 14914.2 1820.3 1867.2 1895.5 1922.5 1985.8 103641.0 110151.4 112228.9 112811.0 114381.4 11299.4 11372.0 11386.8 11532.7 11714.8 14211.7 14531.7 14555.0 14557.7 14575.9 6943.8 8368.9 8498.8 8633.9 8656.8 8428.7 8441.8 8458.6 8638.4 8687.5 4426.9 4509.8 4519.9 4602.6 4603.3 1863.6 1927.3 1932.4 1955.9 1977.5 837.7 901.2 943.0 975.2 1011.8 19268.0 21609.0 21719.6 21730.0 21737.1 808.3 932.5 953.9 965.2 971.9 9126.6 10079.1 10378.9 11349.8 11400.7 397366.0 397502.0 471007.0 475537.0 479516.0 104992.0 122498.0 122639.0 125660.4 127240.0 963.4 983.9 1025.1 1031.0 1034.1 18898.7 19214.9 19316.0 19330.2 19358.0 46997.0 47936.8 48343.3 52066.7 52647.7 74693.9 75041.2 75611.0 76176.2 76749.6 7489.6 7624.6 8293.8 8294.7 8376.9 11907.9 13064.2 13167.3 13251.9 13374.6 11388.0 11499.7 11543.8 11612.7 11631.1 11192.6 11348.7 11375.0 11629.2 11802.3 11226.5 11718.8 11839.8 11863.3 11918.6 7954.9 8088.3 8137.5 8227.1 8406.4 8333.9 10509.8 10664.8 11050.9 11128.1 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5642.25 Median:5208.84 stddev:3198.53 (61.4%) stddev-sans-first:3191.27 19:13:52 INFO - PROCESS | 1664 | Values: 1354.3 1498.0 1523.3 1733.5 1928.3 7852.2 8321.8 8529.6 8805.4 8832.6 8722.6 8801.4 8820.8 8832.2 8835.7 2325.1 2348.4 2349.6 2355.2 2356.9 2228.6 2256.4 2271.5 2273.7 2275.0 2321.3 2342.3 2361.8 2366.8 2366.8 1991.8 2307.9 2333.4 2339.1 2346.9 2293.3 2326.2 2328.2 2330.2 2332.7 8681.8 8734.3 8739.2 8744.2 8764.3 5092.9 5332.3 5335.2 5336.9 5341.9 3495.5 3665.4 3733.5 3738.0 3740.8 834.9 921.6 959.4 966.7 978.4 11689.6 11720.4 11819.0 11824.7 11825.8 3857.7 4374.9 4403.3 4590.5 4592.1 9096.7 9113.0 9124.4 9124.6 9129.8 5203.7 5206.1 5211.5 5217.7 5218.3 4108.6 4374.6 4520.1 4546.9 4889.3 3720.5 3730.2 3774.9 3775.8 3782.1 1033.0 1034.4 1041.6 1042.6 1051.6 898.7 917.9 925.5 935.3 951.7 5451.2 5763.9 5831.1 5836.9 6253.2 739.6 819.3 929.3 965.2 975.1 3778.5 3919.3 3940.7 4052.7 4135.4 10622.5 10908.9 10999.1 11001.8 11006.0 10499.4 10967.5 10968.8 10969.5 10992.8 8087.5 8095.5 8247.9 8258.3 8264.2 5757.6 5801.9 5856.4 5891.2 5934.2 9976.0 9983.5 10042.4 10049.8 10052.4 8557.7 9129.0 9840.9 10027.8 10183.9 6687.5 7085.5 7114.0 7197.6 7209.8 8284.8 8312.7 8358.2 8383.5 8387.1 7477.9 7501.4 7548.2 7569.5 7573.4 7072.6 7256.7 7325.6 7386.4 7494.6 6688.0 6990.7 7098.3 7115.4 7124.5 4588.9 4868.0 5010.1 5118.3 5245.5 5036.9 5057.2 5089.3 5091.2 5232.2 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4446.83 Median:5056.95 stddev:1363.48 (27.0%) stddev-sans-first:1331.16 19:13:52 INFO - PROCESS | 1664 | Values: 292.1 295.2 304.9 306.3 308.9 4719.2 4955.6 5263.5 5277.2 5314.3 4290.5 4890.3 4954.4 5030.2 5116.6 3986.6 4005.0 4006.8 4012.8 4016.9 3315.7 4020.5 4031.3 4037.4 4044.6 3634.8 3732.5 3986.7 3995.9 4015.2 2980.8 3603.5 3984.8 3994.2 4015.0 3448.6 3480.9 3495.2 3496.4 3500.3 4905.8 5083.7 5094.5 5095.3 5127.4 3817.4 4508.8 4568.6 4576.6 4610.8 5170.5 5451.1 5456.2 5521.4 5538.0 3195.1 3711.2 3828.4 3851.6 3864.3 5687.8 5753.5 5764.4 5773.7 5798.6 3050.8 3862.2 3880.7 3891.2 3892.4 3935.6 3952.1 3969.3 3972.6 3992.0 3838.0 3926.6 4086.6 4535.8 4591.8 5026.9 5518.2 5528.7 5545.5 5570.9 1307.4 1325.6 1334.2 1336.7 1337.4 823.7 834.8 847.2 855.5 857.7 5171.8 5182.3 5237.3 5246.6 5265.0 4202.6 4873.4 5426.9 5522.7 5650.6 4052.4 4960.6 5175.7 5190.0 5227.8 2920.5 2930.5 2933.3 2939.1 2946.7 5483.5 5756.7 5760.4 5809.3 5891.6 5291.5 5500.7 5652.9 5698.7 5781.9 5336.3 5734.9 5890.3 5898.0 5907.6 5203.9 5555.0 5569.3 5576.3 5616.3 4813.5 5518.6 5549.3 5552.9 5577.4 4876.5 5791.3 5811.3 5831.5 5862.5 3585.4 3743.2 3747.2 3775.5 3776.3 4589.4 4609.7 5477.5 5485.2 5624.6 4812.5 5455.0 5466.5 5496.8 5612.1 5254.4 5324.2 5382.8 5417.3 5462.0 4439.9 4565.9 5125.4 5352.1 5356.4 5351.8 5355.8 5369.6 5373.8 5377.4 4972.0 5019.8 5371.8 5375.3 5424.1 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:23472.95 Median:3647.41 stddev:36315.04 (995.6%) stddev-sans-first:36376.58 19:13:52 INFO - PROCESS | 1664 | Values: 675.6 720.9 723.7 767.2 787.8 13091.9 15023.0 15656.8 15714.4 15787.8 14181.0 14320.0 14330.9 14692.4 15294.6 862.3 883.4 892.1 892.3 894.1 883.6 883.6 887.1 888.4 888.5 934.9 936.8 937.9 938.2 939.4 927.1 927.9 929.6 930.6 932.5 577.3 674.7 685.0 687.7 688.2 15670.5 15712.1 15717.2 15728.2 15736.0 13588.8 14039.9 14090.4 14092.1 14201.9 11623.3 11963.8 12133.5 12162.0 12315.9 3635.0 3667.8 3812.3 3815.1 3887.4 105874.0 108082.4 108783.0 108807.0 108808.0 10316.4 10447.6 11056.4 11062.3 11227.6 21873.5 21982.5 21989.0 21992.8 22028.7 7705.5 7981.2 8002.1 8110.6 8113.1 4232.9 4383.2 4458.4 4496.2 4638.9 3491.5 3580.7 3659.8 3659.9 3664.8 648.0 654.6 656.1 683.3 684.8 586.4 617.7 623.3 626.4 637.6 8479.0 8679.5 8930.6 8956.5 9117.7 587.7 617.7 621.4 637.7 639.8 3309.8 4056.8 4205.8 4285.1 4443.6 123184.4 128942.7 131062.3 139726.0 142363.0 114508.0 116437.0 116784.0 119280.0 123654.0 98565.5 99561.0 101812.5 102577.5 106621.0 6958.9 8069.4 8508.6 8808.8 8897.7 53030.5 58497.0 58929.7 60705.0 61061.0 78777.0 79512.0 82950.2 83897.6 84918.0 12668.6 13065.2 13137.9 13262.4 13553.6 14623.6 14670.6 14717.9 15198.6 15254.5 13104.3 13527.5 13775.0 13781.3 14053.6 13714.7 14043.3 14188.0 14227.6 14341.9 12890.5 13456.3 13468.3 13484.5 13622.0 11026.6 11356.5 11401.8 11843.7 11909.9 9399.5 10451.7 10621.8 11644.4 11681.0 19:13:52 INFO - PROCESS | 1664 | -------- Summary: end -------- 19:13:52 INFO - PROCESS | 1664 | 19:13:52 INFO - TEST-INFO | 1664: exit 0 19:13:52 INFO - TEST-OK | dromaeo_css | took 1117592ms 19:13:52 INFO - TEST-START | kraken 19:13:52 INFO - operating with platform_type : mac_ 19:13:52 INFO - Initialising browser for kraken test... 19:13:52 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpzZ04DD/profile http://localhost:49278/getInfo.html) 19:13:55 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 19:13:55 INFO - PROCESS | 1669 | colorDepth:24 19:13:55 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 19:13:55 INFO - PROCESS | 1669 | __metrics 19:13:55 INFO - PROCESS | 1669 | 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" 19:13:55 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:13:56 INFO - TEST-INFO | 1669: exit 0 19:13:56 INFO - Browser initialized. 19:13:56 INFO - Running cycle 1/1 for kraken test... 19:13:56 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpzZ04DD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:14:08 INFO - PROCESS | 1670 | RSS: Main: 235765760 19:14:08 INFO - PROCESS | 1670 | 19:14:10 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 19:14:11 INFO - PROCESS | 1670 | RSS: Main: 294174720 19:14:11 INFO - PROCESS | 1670 | 19:14:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 19:14:15 INFO - PROCESS | 1670 | RSS: Main: 293621760 19:14:15 INFO - PROCESS | 1670 | 19:14:18 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 19:14:19 INFO - PROCESS | 1670 | RSS: Main: 385622016 19:14:19 INFO - PROCESS | 1670 | 19:14:21 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 19:14:21 INFO - PROCESS | 1670 | RSS: Main: 285933568 19:14:21 INFO - PROCESS | 1670 | 19:14:23 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:14:24 INFO - PROCESS | 1670 | RSS: Main: 289976320 19:14:24 INFO - PROCESS | 1670 | 19:14:27 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 19:14:27 INFO - PROCESS | 1670 | RSS: Main: 329314304 19:14:27 INFO - PROCESS | 1670 | 19:14:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 19:14:31 INFO - PROCESS | 1670 | RSS: Main: 329699328 19:14:31 INFO - PROCESS | 1670 | 19:14:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 19:14:34 INFO - PROCESS | 1670 | RSS: Main: 327892992 19:14:34 INFO - PROCESS | 1670 | 19:14:36 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:14:36 INFO - PROCESS | 1670 | RSS: Main: 299999232 19:14:36 INFO - PROCESS | 1670 | 19:14:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:14:39 INFO - PROCESS | 1670 | RSS: Main: 305508352 19:14:39 INFO - PROCESS | 1670 | 19:14:41 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:14:42 INFO - PROCESS | 1670 | RSS: Main: 310222848 19:14:42 INFO - PROCESS | 1670 | 19:14:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:14:45 INFO - PROCESS | 1670 | RSS: Main: 321306624 19:14:45 INFO - PROCESS | 1670 | 19:14:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:14:49 INFO - PROCESS | 1670 | RSS: Main: 317538304 19:14:49 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 19:14:51 INFO - PROCESS | 1670 | RSS: Main: 361029632 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | __start_tp_report 19:14:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 19:14:51 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 19:14:51 INFO - PROCESS | 1670 | |i|pagename|runs| 19:14:51 INFO - PROCESS | 1670 | |0;ai-astar;112;113;114;112;113;112;112;113;111;112 19:14:51 INFO - PROCESS | 1670 | |1;audio-beat-detection;145;108;108;162;141;141;103;109;140;106 19:14:51 INFO - PROCESS | 1670 | |2;audio-dft;183;184;182;184;185;186;179;181;180;182 19:14:51 INFO - PROCESS | 1670 | |3;audio-fft;80;61;60;87;59;59;60;59;83;59 19:14:51 INFO - PROCESS | 1670 | |4;audio-oscillator;84;72;91;72;68;69;90;68;70;91 19:14:51 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;89;87;89;87;89;85;90;87;89;85 19:14:51 INFO - PROCESS | 1670 | |6;imaging-darkroom;95;93;95;95;94;94;94;94;94;93 19:14:51 INFO - PROCESS | 1670 | |7;imaging-desaturate;83;83;96;135;135;84;83;84;84;84 19:14:51 INFO - PROCESS | 1670 | |8;json-parse-financial;56;55;57;54;53;55;56;54;53;54 19:14:51 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;68;74;74;77;77;69;72;72;73;73 19:14:51 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;84;86;88;89;80;85;87;86;94;85 19:14:51 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;138;137;141;128;159;124;149;141;175;130 19:14:51 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;210;169;166;169;170;167;168;227;225;167 19:14:51 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;83;82;87;87;67;66;67;67;67;65 19:14:51 INFO - PROCESS | 1670 | __end_tp_report 19:14:51 INFO - PROCESS | 1670 | __start_cc_report 19:14:51 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,2030 19:14:51 INFO - PROCESS | 1670 | __end_cc_report 19:14:51 INFO - PROCESS | 1670 | __startTimestamp1474942491605__endTimestamp 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | ------- Summary: start ------- 19:14:51 INFO - PROCESS | 1670 | Number of tests: 14 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 19:14:51 INFO - PROCESS | 1670 | Values: 112.0 113.0 114.0 112.0 113.0 112.0 112.0 113.0 111.0 112.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:140.50 stddev:21.52 (15.3%) stddev-sans-first:21.74 19:14:51 INFO - PROCESS | 1670 | Values: 145.0 108.0 108.0 162.0 141.0 141.0 103.0 109.0 140.0 106.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.50 stddev:2.22 (1.2%) stddev-sans-first:2.35 19:14:51 INFO - PROCESS | 1670 | Values: 183.0 184.0 182.0 184.0 185.0 186.0 179.0 181.0 180.0 182.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:66.70 Median:60.50 stddev:11.61 (19.2%) stddev-sans-first:11.28 19:14:51 INFO - PROCESS | 1670 | Values: 80.0 61.0 60.0 87.0 59.0 59.0 60.0 59.0 83.0 59.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:10.18 (13.0%) stddev-sans-first:10.52 19:14:51 INFO - PROCESS | 1670 | Values: 84.0 72.0 91.0 72.0 68.0 69.0 90.0 68.0 70.0 91.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.77 (2.0%) stddev-sans-first:1.81 19:14:51 INFO - PROCESS | 1670 | Values: 89.0 87.0 89.0 87.0 89.0 85.0 90.0 87.0 89.0 85.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 19:14:51 INFO - PROCESS | 1670 | Values: 95.0 93.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:84.00 stddev:21.39 (25.5%) stddev-sans-first:22.23 19:14:51 INFO - PROCESS | 1670 | Values: 83.0 83.0 96.0 135.0 135.0 84.0 83.0 84.0 84.0 84.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:1.33 19:14:51 INFO - PROCESS | 1670 | Values: 56.0 55.0 57.0 54.0 53.0 55.0 56.0 54.0 53.0 54.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:73.50 stddev:2.92 (4.0%) stddev-sans-first:2.51 19:14:51 INFO - PROCESS | 1670 | Values: 68.0 74.0 74.0 77.0 77.0 69.0 72.0 72.0 73.0 73.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.50 stddev:3.63 (4.2%) stddev-sans-first:3.74 19:14:51 INFO - PROCESS | 1670 | Values: 84.0 86.0 88.0 89.0 80.0 85.0 87.0 86.0 94.0 85.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:141.00 stddev:15.40 (10.9%) stddev-sans-first:16.26 19:14:51 INFO - PROCESS | 1670 | Values: 138.0 137.0 141.0 128.0 159.0 124.0 149.0 141.0 175.0 130.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:169.50 stddev:25.84 (15.2%) stddev-sans-first:25.61 19:14:51 INFO - PROCESS | 1670 | Values: 210.0 169.0 166.0 169.0 170.0 167.0 168.0 227.0 225.0 167.0 19:14:51 INFO - PROCESS | 1670 | 19:14:51 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.50 stddev:9.57 (12.8%) stddev-sans-first:9.55 19:14:51 INFO - PROCESS | 1670 | Values: 83.0 82.0 87.0 87.0 67.0 66.0 67.0 67.0 67.0 65.0 19:14:51 INFO - PROCESS | 1670 | -------- Summary: end -------- 19:14:51 INFO - PROCESS | 1670 | 19:14:52 INFO - TEST-INFO | 1670: exit 0 19:14:52 INFO - TEST-OK | kraken | took 59668ms 19:14:52 INFO - SUITE-END | took 1177s 19:14:52 INFO - Completed test suite (00:19:37) 19:14:52 INFO - javascript benchmark 19:14:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.0, 3283.1463819406945, 3298.7361011119115, 3325.6674332566763, 3341.9331613367735, 4552.544745525446, 5353.741870660392, 5411.269478620395, 5463.2078348639425, 5480.287562616859, 4613.6539759518, 5491.093969495038, 5514.0, 5517.779288828442, 5520.696361700105, 5029.773660185291, 5034.320366750479, 5037.647364684455, 5051.0150520648485, 5127.487251274862, 4964.801407943678, 5024.648274620778, 5034.82378116766, 5045.596352291826, 5053.292539044537, 5055.772490237948, 5064.366954130734, 5097.464766199551, 5119.846404607868, 5134.9229761553415, 5147.305113809644, 5159.2003239497935, 5160.122779127557, 5161.27742116104, 5190.273361729361, 4931.778069986859, 5002.674826136289, 5005.199168133081, 5060.0, 5088.720120393377, 5382.138857782736, 5396.055690254189, 5430.70131142787, 5449.155380915925, 5503.229547863302, 5263.526282634543, 5547.583931205136, 5875.970620146872, 5894.705264736746, 5940.732667029994, 5893.970530147365, 6016.75932962681, 6069.059295809113, 6085.208922840046, 6098.817035488943, 5498.697571633518, 5515.062439385314, 5552.5280351169795, 5554.166874968787, 5565.0, 6173.722182501798, 6203.31763506014, 6209.037599172136, 6217.844553886189, 6219.284782250009, 5787.971060144757, 5799.3040835100055, 5802.042662960649, 5807.041838096751, 5847.912281315784, 5040.571551418097, 5891.351951285355, 5946.0, 5951.226340575784, 5961.135635332853, 5901.793437229677, 5930.822075337746, 5957.642541447441, 5977.970110149421, 5996.700164991733, 5919.4080591940465, 5920.585559010828, 5999.1901093351835, 5999.340072592011, 6009.819705408845, 4694.81220751173, 4754.952450475451, 4757.714537127784, 4772.164871147535, 4781.737004464788, 4189.664826813909, 4293.592108749664, 4295.892602684896, 4326.329418940069, 4366.825326986948, 5528.75120619573, 5534.225208470817, 5540.722963851791, 5546.334439867242, 5552.750126244328, 5989.850253743604, 6000.759969601254, 6012.819615411545, 6013.579049466583, 6016.977113890649, 5358.866028349323, 5453.045716999509, 5465.808696695596, 5508.118701007819, 5554.972225138848, 5168.8449346519665, 5208.244804503402, 5212.530872221519, 5237.816676416307, 5241.475852414805, 6259.1550140730415, 6279.7488100476385, 6285.962816135287, 6290.905636415366, 6295.874082518232, 5794.2177805997335, 5817.331006934088, 5901.173835663097, 5950.702464876826, 5961.433663801932, 6178.351273116258, 6247.0, 6270.310265870842, 6294.213223347082, 6322.841928951813, 5902.911456328073, 5924.31870334917, 5934.643921364732, 5935.169076329231, 6002.129691194839, 5657.12314591239, 5990.940090599212, 6008.969955150196, 6033.487153591994, 6047.395260473917, 4601.9185491408825, 5493.890122197454, 5747.5401967841635, 5755.165501002415, 5775.451332123442, 5715.114157305624, 5824.504917082096, 5831.271091113611, 5843.532517398513, 5848.619839710405, 5613.831585052455, 5689.487946084872, 5696.458836410535, 5708.429157084258, 5710.942890571041, 5644.548436125182, 5748.856278592902, 5768.50967667753, 5789.247397838254, 5824.388439213991, 5657.038303488499, 5669.0, 5675.602707810413, 5726.226959360433, 5731.19763233156], "value": 5467.034160068123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.5714178668304, 524.8163142899986, 529.9284596579462, 541.6912359954828, 550.0731267813732, 30823.0, 31365.84317078414, 32469.188270293256, 32604.184895377628, 40258.19483610326, 35281.11797205065, 40340.79829600855, 43112.0, 43183.56816431835, 43222.56777432225, 9747.756306092333, 9915.058069483424, 9920.603175872993, 9925.90074099257, 9942.751431214205, 8763.0, 8935.687250946217, 9729.659461918834, 9854.310198286123, 9859.408435493857, 12030.879691203107, 12269.631911042683, 12270.877291227063, 12542.178009947735, 12557.932575731074, 11989.460474278678, 12006.399680016051, 12026.278423294587, 12142.028637708961, 12144.757104857854, 8667.913320866774, 8857.86713199296, 11057.50241239146, 11089.667309980632, 11164.274322169114, 39296.41055384171, 40099.7995010026, 40211.59788402108, 41925.58074419247, 41982.95042623928, 3272.149241197282, 3289.276359200972, 3326.534285200074, 3463.619001909788, 3750.924981500382, 30114.54828177579, 30488.69511304881, 31830.522542161885, 31910.521342179887, 32291.51562726561, 3217.3404452087266, 3318.7013168814683, 3355.6644335566493, 3394.439917413624, 3398.8130652814084, 405002.0, 408282.2131897465, 409376.0, 412659.9367003146, 416631.0, 59109.70445147747, 59470.70264648649, 59557.0, 59595.0, 59596.126251793496, 63342.0, 63538.68230658909, 63570.0, 63586.72826543443, 63602.0459693105, 16232.75650865238, 16493.6701265974, 16494.587635308973, 16502.587435313973, 16545.007299562065, 12755.489780408865, 12796.744065118646, 12806.103572749818, 12810.42353094113, 12820.038497112753, 12971.027172962065, 13886.375113119933, 16200.51398458048, 16937.745933811002, 18125.728114078298, 5711.343195532484, 6563.704633291513, 6740.4270636995425, 6810.795676129724, 6813.705395974749, 834.7078522517191, 861.3927181337267, 972.2027937091517, 1006.2302338710892, 1009.742515658517, 28188.85905570459, 29494.705052949197, 29695.42134046564, 30086.946956856842, 30128.84935575352, 1014.761531040205, 1036.7926414717087, 1057.8730552333768, 1068.0974576482859, 1096.331237944853, 14521.636959076108, 15402.537923862303, 15512.457064002705, 15828.050316980787, 16423.343066277215, 376054.0, 468672.0, 499830.0, 501852.0, 507770.0, 57955.0, 58314.0, 58380.4161958375, 58456.830863383344, 58523.0, 1301.7591745526918, 1333.6599167212298, 1361.884239839605, 1362.8194888178834, 1363.6863521390135, 25985.740142598333, 30298.0, 30824.229394265323, 30918.0, 31668.841655791573, 50931.0, 51101.744491277306, 51263.487365125875, 51264.0, 51333.23000154926, 458299.0, 463548.0, 464378.0, 467777.0, 468196.0, 25466.618000730374, 25890.352741180868, 26160.60759088577, 26358.341041474116, 26463.147579670007, 38566.80716596399, 39277.41083883687, 39838.0, 40287.1942561153, 48070.27894581514, 30740.077797666105, 32238.516422253215, 33368.33263334768, 40243.99390015273, 40672.79663601781, 37853.242935141694, 38596.22807543777, 38646.806765967114, 39965.80017099896, 39996.60003399929, 37138.44292335671, 37580.0, 38004.61995380011, 38424.42363364496, 38812.223755525294, 32696.855610054485, 34024.48963265603, 34099.0, 34106.0, 34450.0, 22483.0, 25271.0, 25585.87207063953, 26101.608475873258, 26156.34609134787], "value": 19513.22893547612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.48744320734943, 365.81343514807446, 371.75278439837507, 382.40917782026776, 400.7375169264131, 15178.62053448663, 15315.617109572266, 16446.917765411185, 20546.69179962302, 21291.0, 20067.899660501713, 20527.384178474633, 21162.047707853144, 21235.256766013194, 21448.356549303546, 5769.971150144243, 6033.306169790487, 6066.332703402622, 6310.116583678288, 6334.461570766491, 5686.573506986972, 6247.562670613059, 6257.9374206258035, 6284.183056202687, 6290.654014029226, 4034.435179074932, 4496.7751612419415, 6611.537192396534, 6913.101296831405, 6984.0, 6747.662616869186, 6829.795106146824, 6931.09895713559, 7051.717931282743, 7073.221945586007, 5894.0, 5894.381089985575, 5916.201312822757, 5960.225170727821, 6086.939130608682, 23497.530049398916, 24409.877950610135, 26025.869870650717, 26513.0, 26699.866500667566, 2542.5169217848547, 2559.820812543123, 2576.9226923192336, 3020.1845501714633, 3108.0675797260733, 10014.64948726791, 10386.584536618526, 10398.896011039868, 12836.486540538368, 14914.17972011539, 1820.2718912435, 1867.2344338821154, 1895.469268604793, 1922.5001499610203, 1985.8411327093797, 103641.0, 110151.44924275327, 112228.87771122348, 112811.0, 114381.428092859, 11299.3785341807, 11372.019793072359, 11386.772264554662, 11532.654020379403, 11714.765704685859, 14211.715765684628, 14531.709365812625, 14555.0, 14557.708845823236, 14575.85424145745, 6943.79168624942, 8368.874466883002, 8498.787530311793, 8633.91366086331, 8656.826863462695, 8428.704995325133, 8441.788955276044, 8458.619362128718, 8638.438501497509, 8687.522186279815, 4426.945407668698, 4509.7970591323465, 4519.864404067883, 4602.562756538124, 4603.309503574491, 1863.6179583185415, 1927.267638297438, 1932.4009557037364, 1955.8728682635583, 1977.4660841572982, 837.7151768398774, 901.1664210605164, 943.0428115462811, 975.1662328708852, 1011.812814629296, 19268.0, 21609.0, 21719.56560868774, 21730.022149003333, 21737.130514779547, 808.2826713890778, 932.5150921520772, 953.9379940303996, 965.1940629574244, 971.9271054670928, 9126.634934602542, 10079.143272821892, 10378.948105259426, 11349.765316884648, 11400.657980260605, 397366.0, 397502.0, 471007.0, 475537.0, 479516.0, 104992.0, 122498.0, 122639.0, 125660.37169814092, 127240.0, 963.3641796414473, 983.9065288797552, 1025.1388833379997, 1031.0256807317014, 1034.1416624201895, 18898.7165192525, 19214.943178124777, 19316.0, 19330.226790928205, 19358.0, 46997.0, 47936.760316199594, 48343.27485087797, 52066.73966630142, 52647.73676131595, 74693.87959180726, 75041.24463819669, 75611.0, 76176.23823761691, 76749.61625191839, 7489.588072656056, 7624.580648064188, 8293.83412331762, 8294.668213271401, 8376.87434688468, 11907.940460297643, 13064.21614703121, 13167.2757998311, 13251.867481325064, 13374.598762037154, 11388.0, 11499.655010349703, 11543.76912461763, 11612.6516204514, 11631.069514438655, 11192.552297907992, 11348.716282093013, 11375.033122184375, 11629.185956983269, 11802.291862488279, 11226.5120922677, 11718.765624687629, 11839.822402663794, 11863.288202707865, 11918.642440726791, 7954.880676789737, 8088.312493438124, 8137.511749295061, 8227.095019547965, 8406.411551191359, 8333.916660833314, 10509.842352364567, 10664.786704265716, 11050.889491105308, 11128.109751220045], "value": 9593.792514764844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.3160703844558, 1497.99251003745, 1523.314508471188, 1733.4799560131958, 1928.296171897257, 7852.1755215702315, 8321.791955201115, 8529.573521323931, 8805.383623146383, 8832.558372081403, 8722.60748266328, 8801.383903126783, 8820.823583528325, 8832.160944710258, 8835.734927952155, 2325.1280769711316, 2348.412896775806, 2349.600567903452, 2355.199232261031, 2356.9175078872245, 2228.6099932511747, 2256.379495638696, 2271.5343354612264, 2273.6703178039174, 2275.0, 2321.257197696738, 2342.2856028911174, 2361.8346715729904, 2366.7633236676365, 2366.7869891709743, 1991.7709463411747, 2307.9423014424606, 2333.439974406139, 2339.146211632759, 2346.9413264668433, 2293.323469576479, 2326.174208156097, 2328.2084091409, 2330.1727886600183, 2332.7084114485688, 8681.82636347276, 8734.301255899512, 8739.213470787596, 8744.169303916118, 8764.25503832175, 5092.872678183038, 5332.253484512172, 5335.1997200419855, 5336.91994620081, 5341.893162136775, 3495.493153492729, 3665.3585622515952, 3733.5146430964073, 3737.9813100934593, 3740.775553466801, 834.8664213725835, 921.5668635741258, 959.3764053365369, 966.7389804752678, 978.4325091447015, 11689.590864319707, 11720.355380454072, 11818.995385392165, 11824.704382390422, 11825.763484730343, 3857.746232474457, 4374.912501749947, 4403.339499075164, 4590.495045544987, 4592.104539614743, 9096.727098186933, 9112.95443522778, 9124.361294709306, 9124.58939347731, 9129.817403652023, 5203.687778733288, 5206.140986737221, 5211.530962213419, 5217.686938783685, 5218.2955301034635, 4108.589141085868, 4374.62815660666, 4520.118576877478, 4546.909061818811, 4889.315495830587, 3720.479132921393, 3730.198007428416, 3774.9056273592832, 3775.7734535927934, 3782.149016471327, 1033.0, 1034.3535290443472, 1041.6198087698087, 1042.5777560088177, 1051.6319288249204, 898.7169041751828, 917.9495127767904, 925.5464822237055, 935.2704890185666, 951.7477868364889, 5451.209574611659, 5763.87604417143, 5831.125331200354, 5836.941630583639, 6253.165311168649, 739.563657442101, 819.3076850061689, 929.2612373163352, 965.2037069417759, 975.1272611013245, 3778.508793856836, 3919.2755187717885, 3940.6847452203756, 4052.696047796368, 4135.421041054255, 10622.46887655614, 10908.945455272673, 10999.065079468175, 11001.779964400666, 11006.009459148716, 10499.370037797757, 10967.451627418597, 10968.835467467834, 10969.506372213269, 10992.835107473395, 8087.514749115072, 8095.461862246154, 8247.876281855777, 8258.298044666271, 8264.21489958453, 5757.596968212185, 5801.912971305349, 5856.41435856428, 5891.204687367151, 5934.228550288435, 9976.002399759966, 9983.500824958577, 10042.397456152654, 10049.849252261076, 10052.396856188652, 8557.700480483154, 9129.0, 9840.852387214341, 10027.849582256418, 10183.949080254848, 6687.531872768859, 7085.468589855885, 7114.039604653305, 7197.640117993975, 7209.783706488814, 8284.751457456287, 8312.6674933002, 8358.164183581594, 8383.496990180609, 8387.07742148351, 7477.92522074794, 7501.362384197186, 7548.1697013329585, 7569.545827250383, 7573.431992600466, 7072.611006394698, 7256.7097316106765, 7325.560466372035, 7386.446016548673, 7494.5503269803985, 6688.004300711209, 6990.720371185095, 7098.3256590623805, 7115.430765538848, 7124.536905101152, 4588.931166032579, 4868.0, 5010.098182327216, 5118.334616499831, 5245.475452454724, 5036.949630503795, 5057.165567681292, 5089.338386009795, 5091.1854103343285, 5232.1628539433505], "value": 4495.75410991721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.0799481632856, 295.2162009863812, 304.8658590220303, 306.3383092520157, 308.8532946850245, 4719.197736384815, 4955.578775804056, 5263.473472773241, 5277.1556550951855, 5314.256004159416, 4290.4636920384955, 4890.31284206948, 4954.430240522341, 5030.170021946384, 5116.616253780972, 3986.5614782373987, 4005.0, 4006.83972641094, 4012.816219215324, 4016.9355120892988, 3315.668433156689, 4020.517537895457, 4031.254217969685, 4037.4347591337237, 4044.6338891748364, 3634.7637403568683, 3732.514773079496, 3986.66113380363, 3995.9221204973396, 4015.1768887378016, 2980.7764417668545, 3603.5135256740527, 3984.780837053961, 3994.204057159985, 4014.9799251003706, 3448.586169659657, 3480.912977175591, 3495.2485215678753, 3496.35317466267, 3500.334936362083, 4905.803011916384, 5083.720395378253, 5094.541491265803, 5095.31213286209, 5127.410347810012, 3817.3701339279264, 4508.752018638974, 4568.611668008223, 4576.610988066019, 4610.815567377301, 5170.5346518813485, 5451.138152469945, 5456.162795346438, 5521.4478552144865, 5537.972310138463, 3195.121341631047, 3711.2391959648207, 3828.37756137047, 3851.595582463829, 3864.3430616795213, 5687.800926967537, 5753.490370873806, 5764.394738552433, 5773.711314434261, 5798.565107616945, 3050.8474576271096, 3862.1889403225637, 3880.708946828999, 3891.1633998690418, 3892.4355968384425, 3935.6064393560414, 3952.110775075585, 3969.325214713506, 3972.64246217836, 3991.960080399217, 3837.9808100959317, 3926.6466018058513, 4086.570910054461, 4535.7732113394195, 4591.770411479412, 5026.949730502648, 5518.227448157261, 5528.728392469755, 5545.528630066409, 5570.888582228333, 1307.4312673986847, 1325.6288239293012, 1334.2061473423298, 1336.6791969927342, 1337.3714354253486, 823.6952327638692, 834.7853872615331, 847.1951645936385, 855.4567849415541, 857.7469646454311, 5171.793128274902, 5182.2639415795375, 5237.292965449616, 5246.635874672536, 5264.973675131677, 4202.558731333227, 4873.439554451213, 5426.906663201937, 5522.723863806794, 5650.604457687922, 4052.392141178847, 4960.603151747851, 5175.696814917401, 5190.0, 5227.843164705065, 2920.532714765627, 2930.531115021586, 2933.31067199208, 2939.1182645206354, 2946.734793868562, 5483.479069488392, 5756.65460072397, 5760.423957604206, 5809.331926828469, 5891.584450375325, 5291.497307755757, 5500.669959802424, 5652.943470565242, 5698.715064246854, 5781.884362312814, 5336.306280183551, 5734.9390362783015, 5890.293164820163, 5897.970510147422, 5907.645541267538, 5203.869903252297, 5555.000099982042, 5569.303837020372, 5576.33084029919, 5616.269884915098, 4813.4729267135035, 5518.586106041983, 5549.278593782944, 5552.889422115674, 5577.358603760619, 4876.463589005278, 5791.276090488689, 5811.27359080115, 5831.533477321719, 5862.472377486047, 3585.4442561403025, 3743.2326373092906, 3747.231817477356, 3775.5091838060875, 3776.263628592398, 4589.449266088091, 4609.7181894962205, 5477.534409575231, 5485.204645326326, 5624.634398764068, 4812.542808433193, 5454.963556924172, 5466.512736704869, 5496.780128794963, 5612.074007788669, 5254.422013578427, 5324.1747529133045, 5382.811601594082, 5417.2642815377985, 5461.972690136524, 4439.8668039957565, 4565.885852853705, 5125.384953805567, 5352.073253628769, 5356.437574054668, 5351.759170837244, 5355.839324820262, 5369.597280203922, 5373.811916583058, 5377.435369286169, 4972.0, 5019.774110164978, 5371.758270877898, 5375.274337964324, 5424.125213636778], "value": 4011.900760602464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.618275674244, 720.8522252938149, 723.6707298179325, 767.2059418501851, 787.767608555476, 13091.869081309183, 15023.023503472266, 15656.843431565681, 15714.371425142996, 15787.842121578795, 14181.0, 14320.0, 14330.92834535826, 14692.412303507846, 15294.617634559141, 862.2670729879615, 883.4125306671056, 892.1346294094718, 892.335210268351, 894.1460904835899, 883.593546968392, 883.6244596046687, 887.1306120002401, 888.4491615198586, 888.4935586715575, 934.9018353072931, 936.7704912296497, 937.8921424036221, 938.1556599060832, 939.4457270210575, 927.0775578299567, 927.9489628070453, 929.6049179098924, 930.6370515498927, 932.4871320773548, 577.2524580668045, 674.689642764329, 684.9589024658486, 687.6836655138642, 688.1570076656056, 15670.451534196249, 15712.135832529206, 15717.21413929299, 15728.213589320603, 15736.0, 13588.796168057388, 14039.859601403958, 14090.436382544685, 14092.084014539125, 14201.91171945565, 11623.302601843916, 11963.820542691867, 12133.514659413613, 12162.027037836951, 12315.93842030793, 3635.0389005055285, 3667.7982710950887, 3812.275667623143, 3815.065308999285, 3887.4168874668744, 105874.0, 108082.37876431938, 108783.0, 108807.0, 108808.0, 10316.381017138996, 10447.634332798316, 11056.391898445501, 11062.336259824275, 11227.550897964153, 21873.453163670718, 21982.45043873884, 21989.010494527785, 21992.78007219939, 22028.669569956463, 7705.537667739954, 7981.241782030698, 8002.119766825645, 8110.63502142405, 8113.0669972953865, 4232.8518501852905, 4383.189110014658, 4458.398116254264, 4496.168208881302, 4638.930416043762, 3491.546099007113, 3580.6598373154507, 3659.780413175218, 3659.908502287464, 3664.8167591620313, 647.9740810367532, 654.5876098058193, 656.0880376276979, 683.2859661653584, 684.7706018483764, 586.3872253495108, 617.7405489694339, 623.3081279779441, 626.3830127324582, 637.5600835423636, 8479.0, 8679.52262625549, 8930.629924796209, 8956.507392093366, 9117.726468205965, 587.6973358720262, 617.7483863303398, 621.3910367839543, 637.7225906730587, 639.7760783725658, 3309.7683162178896, 4056.7971601419813, 4205.833995492324, 4285.114549598166, 4443.577860103285, 123184.38407807903, 128942.71057289308, 131062.34468827595, 139726.0, 142363.0, 114508.0, 116437.0, 116784.0, 119280.0, 123654.0, 98565.5071724651, 99561.0, 101812.49093754483, 102577.48711256396, 106621.0, 6958.886578147472, 8069.354451643737, 8508.61711222984, 8808.779780505281, 8897.73306800797, 53030.469695302556, 58497.0, 58929.70535147297, 60705.0, 61061.0, 78777.0, 79512.0, 82950.17049829425, 83897.58051209705, 84918.0, 12668.556600518938, 13065.150765200231, 13137.934310328386, 13262.403191856196, 13553.59339219825, 14623.634409139431, 14670.63323416923, 14717.92641036788, 15198.620034499227, 15254.542363729106, 13104.309311243554, 13527.458901643824, 13775.0, 13781.310934453437, 14053.578392648236, 13714.725705486035, 14043.297835108, 14188.0, 14227.64430889236, 14341.92829035848, 12890.548830790878, 13456.327183640584, 13468.326583670581, 13484.460621575026, 13621.978351623866, 11026.614068507564, 11356.488957997075, 11401.81217545998, 11843.703907402383, 11909.880901190878, 9399.496080627341, 10451.738706532093, 10621.760363089332, 11644.35956022393, 11681.0], "value": 7713.8429757375725, "unit": "score"}], "name": "dromaeo_css", "value": 7226.428582595221, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 114.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 108.0, 162.0, 141.0, 141.0, 103.0, 109.0, 140.0, 106.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 182.0, 184.0, 185.0, 186.0, 179.0, 181.0, 180.0, 182.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 60.0, 87.0, 59.0, 59.0, 60.0, 59.0, 83.0, 59.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 91.0, 72.0, 68.0, 69.0, 90.0, 68.0, 70.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 89.0, 85.0, 90.0, 87.0, 89.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 96.0, 135.0, 135.0, 84.0, 83.0, 84.0, 84.0, 84.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 54.0, 53.0, 55.0, 56.0, 54.0, 53.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 74.0, 77.0, 77.0, 69.0, 72.0, 72.0, 73.0, 73.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 88.0, 89.0, 80.0, 85.0, 87.0, 86.0, 94.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 141.0, 128.0, 159.0, 124.0, 149.0, 141.0, 175.0, 130.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 169.0, 166.0, 169.0, 170.0, 167.0, 168.0, 227.0, 225.0, 167.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 87.0, 87.0, 67.0, 66.0, 67.0, 67.0, 67.0, 65.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1456.2, "alertThreshold": 2.0}]} 19:14:52 INFO - Return code: 0 19:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:14:52 INFO - # TBPL SUCCESS # 19:14:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:14:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:14:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:14:52 INFO - 2016-09-26 19:14:52.934 screenresolution[1674:10685] starting screenresolution argv=screenresolution get 19:14:52 INFO - 2016-09-26 19:14:52.938 screenresolution[1674:10685] Display 0: 1600x1200x32@60 19:14:52 INFO - 2016-09-26 19:14:52.944 screenresolution[1675:10688] starting screenresolution argv=screenresolution list 19:14:52 INFO - Available Modes on Display 0 19:14:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:14:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:14:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:14:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:14:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:14:53 INFO - Intel Iris: 19:14:53 INFO - Chipset Model: Intel Iris 19:14:53 INFO - Type: GPU 19:14:53 INFO - Bus: Built-In 19:14:53 INFO - VRAM (Dynamic, Max): 1536 MB 19:14:53 INFO - Vendor: Intel (0x8086) 19:14:53 INFO - Device ID: 0x0a2e 19:14:53 INFO - Revision ID: 0x0009 19:14:53 INFO - Displays: 19:14:53 INFO - Display: 19:14:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:14:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:14:53 INFO - Display Serial Number: 1600x1200 60 19:14:53 INFO - Main Display: Yes 19:14:53 INFO - Mirror: Off 19:14:53 INFO - Online: Yes 19:14:53 INFO - Rotation: Supported 19:14:53 INFO - Return code: 0 19:14:53 INFO - Running post-action listener: _resource_record_post_action 19:14:53 INFO - [mozharness: 2016-09-27 02:14:53.180785Z] Finished run-tests step (success) 19:14:53 INFO - Running post-run listener: _resource_record_post_run 19:14:53 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 33078272; Write bytes: 707268608; Read time: 314; Write time: 1884 19:14:53 INFO - TinderboxPrint: CPU usage
53.4% 19:14:53 INFO - TinderboxPrint: I/O read bytes / time
33,078,272 / 314 19:14:53 INFO - TinderboxPrint: I/O write bytes / time
707,268,608 / 1,884 19:14:53 INFO - TinderboxPrint: CPU idle
2,260.4 (46.6%) 19:14:53 INFO - TinderboxPrint: CPU system
967.2 (19.9%) 19:14:53 INFO - TinderboxPrint: CPU user
1,622.0 (33.4%) 19:14:53 INFO - TinderboxPrint: Swap in / out
435,744,768 / 0 19:14:53 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391045632; Write bytes: 385804288; Read time: 29253; Write time: 721 19:14:53 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 32148480; Write bytes: 297220096; Read time: 301; Write time: 1114 19:14:53 INFO - Running post-run listener: _upload_blobber_files 19:14:53 INFO - Blob upload gear active. 19:14:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:14:53 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 19:14:53 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'] 19:14:53 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 19:14:54 INFO - (blobuploader) - INFO - Open directory for files ... 19:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:54 INFO - (blobuploader) - INFO - Done attempting. 19:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:55 INFO - (blobuploader) - INFO - Done attempting. 19:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:58 INFO - (blobuploader) - INFO - Done attempting. 19:14:58 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:58 INFO - Return code: 0 19:14:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:14:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3747f0143baff8b308f33d877177ef91476d835656804f9069d70d7f4b4740ff36978449c7558eaedc2bc952c89b9c6ad24dbac65378da38c3e361cfa1eaebc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0e08709aed268e91d0021e2c35b8ea154c1dba04f85461bbf353dea6ab748aaff65606631d3273d2f9328e2ac4792d1ea6adbdfd23446004cea737727557ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96b42e2296cd08fea0680bdeb686df9d802d9683a688ebd40bd62df189f626840fa058afdc3bb54716356213ea206cb2feb5be849de5bfdf96d0f3df1d271f0b"} 19:14:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:14:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:14:58 INFO - Contents: 19:14:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3747f0143baff8b308f33d877177ef91476d835656804f9069d70d7f4b4740ff36978449c7558eaedc2bc952c89b9c6ad24dbac65378da38c3e361cfa1eaebc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0e08709aed268e91d0021e2c35b8ea154c1dba04f85461bbf353dea6ab748aaff65606631d3273d2f9328e2ac4792d1ea6adbdfd23446004cea737727557ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96b42e2296cd08fea0680bdeb686df9d802d9683a688ebd40bd62df189f626840fa058afdc3bb54716356213ea206cb2feb5be849de5bfdf96d0f3df1d271f0b"} 19:14:58 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:58 INFO - Copying logs to upload dir... 19:14:58 INFO - mkdir: /builds/slave/test/build/upload/logs 19:14:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.138913 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-26 19:14:58.622809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:58.626890) ========= 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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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/f3747f0143baff8b308f33d877177ef91476d835656804f9069d70d7f4b4740ff36978449c7558eaedc2bc952c89b9c6ad24dbac65378da38c3e361cfa1eaebc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0e08709aed268e91d0021e2c35b8ea154c1dba04f85461bbf353dea6ab748aaff65606631d3273d2f9328e2ac4792d1ea6adbdfd23446004cea737727557ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96b42e2296cd08fea0680bdeb686df9d802d9683a688ebd40bd62df189f626840fa058afdc3bb54716356213ea206cb2feb5be849de5bfdf96d0f3df1d271f0b"} build_url:https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011111 build_url: 'https://queue.taskcluster.net/v1/task/a-ZJRTZHQ0SnlNgoHiq3Qg/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/f3747f0143baff8b308f33d877177ef91476d835656804f9069d70d7f4b4740ff36978449c7558eaedc2bc952c89b9c6ad24dbac65378da38c3e361cfa1eaebc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0e08709aed268e91d0021e2c35b8ea154c1dba04f85461bbf353dea6ab748aaff65606631d3273d2f9328e2ac4792d1ea6adbdfd23446004cea737727557ce5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96b42e2296cd08fea0680bdeb686df9d802d9683a688ebd40bd62df189f626840fa058afdc3bb54716356213ea206cb2feb5be849de5bfdf96d0f3df1d271f0b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:58.663833) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:58.664685) ========= 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.sZAyDSOhPg/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.0UMg3Q4LZv/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005352 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:14:58.715456) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:14:58.715851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 19:14:58.716239) ========= ========= Total master_lag: 0.36 =========