builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0245 starttime: 1479135279.81 results: success (0) buildid: 20161114015620 builduid: 7575ab475a3f4481a1ee0dc2e232252d revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.811484) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.811954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.812227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.875944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:39.876310) ========= 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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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-11-14 06:54:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-11-14 06:54:40 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.487424 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.391658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.391969) ========= 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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.024193 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:40.440123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:54:40.440493) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0f867a8846778f927cfb3871e58cc61f6193ad5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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-11-14 06:54:40,527 truncating revision to first 12 chars 2016-11-14 06:54:40,527 Setting DEBUG logging. 2016-11-14 06:54:40,527 attempt 1/10 2016-11-14 06:54:40,527 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0f867a884677?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 06:54:41,917 unpacking tar archive at: mozilla-aurora-0f867a884677/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:54:42.118477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.120838) ========= script_repo_revision: 0f867a8846778f927cfb3871e58cc61f6193ad5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.121223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.121488) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:54:42.140459) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 06:54:42.140790) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:54:42 INFO - MultiFileLogger online at 20161114 06:54:42 in /builds/slave/test 06:54:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:54:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:42 INFO - {'append_to_log': False, 06:54:42 INFO - 'base_work_dir': '/builds/slave/test', 06:54:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:54:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:42 INFO - 'branch': 'Mozilla-Aurora', 06:54:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:42 INFO - 'config_files': ('talos/mac_config.py',), 06:54:42 INFO - 'default_actions': ('clobber', 06:54:42 INFO - 'read-buildbot-config', 06:54:42 INFO - 'download-and-extract', 06:54:42 INFO - 'populate-webroot', 06:54:42 INFO - 'create-virtualenv', 06:54:42 INFO - 'install', 06:54:42 INFO - 'run-tests'), 06:54:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:42 INFO - 'download_minidump_stackwalk': True, 06:54:42 INFO - 'download_symbols': 'ondemand', 06:54:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:42 INFO - 'installer_path': 'installer.exe', 06:54:42 INFO - 'log_level': 'info', 06:54:42 INFO - 'log_name': 'talos', 06:54:42 INFO - 'log_to_console': True, 06:54:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:42 INFO - 'opt_config_files': (), 06:54:42 INFO - 'pip_index': False, 06:54:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:42 INFO - 'cmd': ('bash', 06:54:42 INFO - '-c', 06:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:42 INFO - 'enabled': True, 06:54:42 INFO - 'halt_on_failure': False, 06:54:42 INFO - 'name': 'check_screen_resolution'},), 06:54:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:42 INFO - 'cmd': ('bash', 06:54:42 INFO - '-c', 06:54:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:42 INFO - 'enabled': True, 06:54:42 INFO - 'halt_on_failure': False, 06:54:42 INFO - 'name': 'check_screen_resolution'},), 06:54:42 INFO - 'run_cmd_checks_enabled': True, 06:54:42 INFO - 'sps_profile': False, 06:54:42 INFO - 'sps_profile_interval': 0, 06:54:42 INFO - 'suite': 'dromaeojs', 06:54:42 INFO - 'system_bits': '32', 06:54:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:42 INFO - 'title': 't-yosemite-r7-0245', 06:54:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:42 INFO - 'use_talos_json': True, 06:54:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:42 INFO - 'work_dir': 'build'} 06:54:42 INFO - [mozharness: 2016-11-14 14:54:42.357832Z] Running clobber step. 06:54:42 INFO - Running pre-action listener: _resource_record_pre_action 06:54:42 INFO - Running main action method: clobber 06:54:42 INFO - rmtree: /builds/slave/test/build 06:54:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:44 INFO - Running post-action listener: _resource_record_post_action 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.724692Z] Finished clobber step (success) 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.724872Z] Running read-buildbot-config step. 06:54:44 INFO - Running pre-action listener: _resource_record_pre_action 06:54:44 INFO - Running main action method: read_buildbot_config 06:54:44 INFO - Using buildbot properties: 06:54:44 INFO - { 06:54:44 INFO - "project": "", 06:54:44 INFO - "product": "firefox", 06:54:44 INFO - "script_repo_revision": "production", 06:54:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:54:44 INFO - "repository": "", 06:54:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:54:44 INFO - "buildid": "20161114015620", 06:54:44 INFO - "pgo_build": "False", 06:54:44 INFO - "basedir": "/builds/slave/test", 06:54:44 INFO - "buildnumber": 30, 06:54:44 INFO - "slavename": "t-yosemite-r7-0245", 06:54:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 06:54:44 INFO - "platform": "yosemite_r7", 06:54:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:54:44 INFO - "branch": "mozilla-aurora", 06:54:44 INFO - "repo_path": "releases/mozilla-aurora", 06:54:44 INFO - "revision": "0f867a8846778f927cfb3871e58cc61f6193ad5d", 06:54:44 INFO - "stage_platform": "macosx64", 06:54:44 INFO - "builduid": "7575ab475a3f4481a1ee0dc2e232252d", 06:54:44 INFO - "slavebuilddir": "test" 06:54:44 INFO - } 06:54:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:54:44 INFO - Running post-action listener: _resource_record_post_action 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.730658Z] Finished read-buildbot-config step (success) 06:54:44 INFO - [mozharness: 2016-11-14 14:54:44.730891Z] Running download-and-extract step. 06:54:44 INFO - Running pre-action listener: _resource_record_pre_action 06:54:44 INFO - Running main action method: download_and_extract 06:54:44 INFO - mkdir: /builds/slave/test/build/tests 06:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:54:44 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:54:44 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:54:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 06:54:46 INFO - Downloaded 1199 bytes. 06:54:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:54:46 INFO - Using the following test package requirements: 06:54:46 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:54:46 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:54:46 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:54:46 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'jsshell-mac.zip'], 06:54:46 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:54:46 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:54:46 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:54:46 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:54:46 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:54:46 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:54:46 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:54:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:54:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:54:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:54:46 INFO - Expected file size: 16423758 06:54:53 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:54:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:54:53 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:54:54 INFO - Expected file size: 16423758 06:55:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 06:55:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:55:00 INFO - Fetch https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 06:55:01 INFO - Expected file size: 14414089 06:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:02 INFO - trying https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 06:55:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 06:55:05 INFO - Downloaded 115545916 bytes. 06:55:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:05 INFO - mkdir: /builds/slave/test/properties 06:55:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:05 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:05 INFO - Contents: 06:55:05 INFO - build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:55:06 INFO - Running post-action listener: _resource_record_post_action 06:55:06 INFO - Running post-action listener: set_extra_try_arguments 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.053249Z] Finished download-and-extract step (success) 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.053397Z] Running populate-webroot step. 06:55:06 INFO - Running pre-action listener: _resource_record_pre_action 06:55:06 INFO - Running main action method: populate_webroot 06:55:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:06 INFO - '--tppagecycles', 06:55:06 INFO - '7'], 06:55:06 INFO - 'tests': ['tsvgm']}}, 06:55:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['damp', 'tps']}, 06:55:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['damp', 'tps']}, 06:55:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['dromaeo_dom']}, 06:55:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['basic_compositor_video']}, 06:55:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:55:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['a11yr', 06:55:06 INFO - 'ts_paint', 06:55:06 INFO - 'tpaint', 06:55:06 INFO - 'sessionrestore', 06:55:06 INFO - 'sessionrestore_no_auto_restore', 06:55:06 INFO - 'tabpaint']}, 06:55:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tsvgx', 06:55:06 INFO - 'tsvgr_opacity', 06:55:06 INFO - 'tart', 06:55:06 INFO - 'tscrollx', 06:55:06 INFO - 'cart']}, 06:55:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:06 INFO - 'tsvgr_opacity', 06:55:06 INFO - 'tart', 06:55:06 INFO - 'tscrollx', 06:55:06 INFO - 'cart']}, 06:55:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s'], 06:55:06 INFO - 'tests': ['tp5o']}, 06:55:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'tests': ['tp5o']}, 06:55:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--disable-e10s', 06:55:06 INFO - '--xperf_path', 06:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:06 INFO - 'tests': ['tp5n']}, 06:55:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:06 INFO - 'talos_options': ['--xperf_path', 06:55:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:06 INFO - 'tests': ['tp5n']}}, 06:55:06 INFO - 'talos.zip': {'path': '', 06:55:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:06 INFO - Running post-action listener: _resource_record_post_action 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.071855Z] Finished populate-webroot step (success) 06:55:06 INFO - [mozharness: 2016-11-14 14:55:06.071993Z] Running create-virtualenv step. 06:55:06 INFO - Running pre-action listener: _resource_record_pre_action 06:55:06 INFO - Running main action method: create_virtualenv 06:55:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:06 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 06:55:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:06 INFO - Using real prefix '/tools/python27' 06:55:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:06 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:09 INFO - Installing pip.................done. 06:55:09 INFO - Return code: 0 06:55:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:09 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:09 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 06:55:09 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 06:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:09 INFO - 'HOME': '/Users/cltbld', 06:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:09 INFO - 'LOGNAME': 'cltbld', 06:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:09 INFO - 'MOZ_NO_REMOTE': '1', 06:55:09 INFO - 'NO_EM_RESTART': '1', 06:55:09 INFO - 'PAGER': '/bin/cat', 06:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:09 INFO - 'PWD': '/builds/slave/test', 06:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:09 INFO - 'SHELL': '/bin/bash', 06:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:09 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:09 INFO - 'USER': 'cltbld', 06:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:09 INFO - 'XPC_FLAGS': '0x0', 06:55:09 INFO - 'XPC_SERVICE_NAME': '0', 06:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:10 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 06:55:10 INFO - Cleaning up... 06:55:10 INFO - Return code: 0 06:55:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:10 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:10 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 06:55:10 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 06:55:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:10 INFO - 'HOME': '/Users/cltbld', 06:55:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:10 INFO - 'LOGNAME': 'cltbld', 06:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:10 INFO - 'MOZ_NO_REMOTE': '1', 06:55:10 INFO - 'NO_EM_RESTART': '1', 06:55:10 INFO - 'PAGER': '/bin/cat', 06:55:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:10 INFO - 'PWD': '/builds/slave/test', 06:55:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:10 INFO - 'SHELL': '/bin/bash', 06:55:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:10 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:10 INFO - 'USER': 'cltbld', 06:55:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:10 INFO - 'XPC_FLAGS': '0x0', 06:55:10 INFO - 'XPC_SERVICE_NAME': '0', 06:55:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:10 INFO - Downloading/unpacking psutil>=3.1.1 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:10 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 06:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:15 INFO - Installing collected packages: psutil 06:55:15 INFO - Running setup.py install for psutil 06:55:15 INFO - building 'psutil._psutil_osx' extension 06:55:15 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 06:55:15 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 06:55:15 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 06:55:15 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 06:55:15 INFO - building 'psutil._psutil_posix' extension 06:55:15 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 06:55:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:16 INFO - ^ 06:55:16 INFO - 1 warning generated. 06:55:16 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 06:55:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:16 INFO - Successfully installed psutil 06:55:16 INFO - Cleaning up... 06:55:16 INFO - Return code: 0 06:55:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:55:16 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')]} 06:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:16 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')]} 06:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:16 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:16 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 06:55:16 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 06:55:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:16 INFO - 'HOME': '/Users/cltbld', 06:55:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:16 INFO - 'LOGNAME': 'cltbld', 06:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:16 INFO - 'MOZ_NO_REMOTE': '1', 06:55:16 INFO - 'NO_EM_RESTART': '1', 06:55:16 INFO - 'PAGER': '/bin/cat', 06:55:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:16 INFO - 'PWD': '/builds/slave/test', 06:55:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:16 INFO - 'SHELL': '/bin/bash', 06:55:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:16 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:16 INFO - 'USER': 'cltbld', 06:55:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:16 INFO - 'XPC_FLAGS': '0x0', 06:55:16 INFO - 'XPC_SERVICE_NAME': '0', 06:55:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:55:19 INFO - Installing collected packages: mozsystemmonitor 06:55:19 INFO - Running setup.py install for mozsystemmonitor 06:55:19 INFO - Successfully installed mozsystemmonitor 06:55:19 INFO - Cleaning up... 06:55:19 INFO - Return code: 0 06:55:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:19 INFO - 'HOME': '/Users/cltbld', 06:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:19 INFO - 'LOGNAME': 'cltbld', 06:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:19 INFO - 'MOZ_NO_REMOTE': '1', 06:55:19 INFO - 'NO_EM_RESTART': '1', 06:55:19 INFO - 'PAGER': '/bin/cat', 06:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:19 INFO - 'PWD': '/builds/slave/test', 06:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:19 INFO - 'SHELL': '/bin/bash', 06:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:19 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:19 INFO - 'USER': 'cltbld', 06:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:19 INFO - 'XPC_FLAGS': '0x0', 06:55:19 INFO - 'XPC_SERVICE_NAME': '0', 06:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:19 INFO - Downloading/unpacking jsonschema==2.5.1 06:55:19 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 06:55:19 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 06:55:19 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 06:55:19 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 06:55:19 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 06:55:19 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 06:55:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:55:22 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 06:55:22 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 06:55:22 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 06:55:22 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 06:55:22 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 06:55:22 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 06:55:22 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:22 INFO - warning: no files found matching '*.txt' 06:55:22 INFO - no previously-included directories found matching 'build' 06:55:22 INFO - no previously-included directories found matching 'dist' 06:55:22 INFO - no previously-included directories found matching '.git*' 06:55:22 INFO - Installing collected packages: jsonschema, functools32 06:55:22 INFO - Running setup.py install for functools32 06:55:22 INFO - warning: no files found matching '*.txt' 06:55:22 INFO - no previously-included directories found matching 'build' 06:55:22 INFO - no previously-included directories found matching 'dist' 06:55:22 INFO - no previously-included directories found matching '.git*' 06:55:22 INFO - Successfully installed jsonschema functools32 06:55:22 INFO - Cleaning up... 06:55:22 INFO - Return code: 0 06:55:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:55:22 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')]} 06:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:22 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')]} 06:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:22 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:22 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 06:55:22 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 06:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:22 INFO - 'HOME': '/Users/cltbld', 06:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:22 INFO - 'LOGNAME': 'cltbld', 06:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:22 INFO - 'MOZ_NO_REMOTE': '1', 06:55:22 INFO - 'NO_EM_RESTART': '1', 06:55:22 INFO - 'PAGER': '/bin/cat', 06:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:22 INFO - 'PWD': '/builds/slave/test', 06:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:22 INFO - 'SHELL': '/bin/bash', 06:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:22 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:22 INFO - 'USER': 'cltbld', 06:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:22 INFO - 'XPC_FLAGS': '0x0', 06:55:22 INFO - 'XPC_SERVICE_NAME': '0', 06:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:55:23 INFO - Cleaning up... 06:55:23 INFO - Return code: 0 06:55:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:23 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')]} 06:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:23 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')]} 06:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:23 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:23 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 06:55:23 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 06:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:23 INFO - 'HOME': '/Users/cltbld', 06:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:23 INFO - 'LOGNAME': 'cltbld', 06:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:23 INFO - 'MOZ_NO_REMOTE': '1', 06:55:23 INFO - 'NO_EM_RESTART': '1', 06:55:23 INFO - 'PAGER': '/bin/cat', 06:55:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:23 INFO - 'PWD': '/builds/slave/test', 06:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:23 INFO - 'SHELL': '/bin/bash', 06:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:23 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:23 INFO - 'USER': 'cltbld', 06:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:23 INFO - 'XPC_FLAGS': '0x0', 06:55:23 INFO - 'XPC_SERVICE_NAME': '0', 06:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:25 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 06:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:27 INFO - Downloading docopt-0.6.1.tar.gz 06:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:27 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:27 INFO - Running setup.py install for blobuploader 06:55:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:27 INFO - Running setup.py install for requests 06:55:27 INFO - Running setup.py install for docopt 06:55:27 INFO - Successfully installed blobuploader requests docopt 06:55:27 INFO - Cleaning up... 06:55:28 INFO - Return code: 0 06:55:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:28 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:28 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 06:55:28 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 06:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:28 INFO - 'HOME': '/Users/cltbld', 06:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:28 INFO - 'LOGNAME': 'cltbld', 06:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:28 INFO - 'MOZ_NO_REMOTE': '1', 06:55:28 INFO - 'NO_EM_RESTART': '1', 06:55:28 INFO - 'PAGER': '/bin/cat', 06:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:28 INFO - 'PWD': '/builds/slave/test', 06:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:28 INFO - 'SHELL': '/bin/bash', 06:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:28 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:28 INFO - 'USER': 'cltbld', 06:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:28 INFO - 'XPC_FLAGS': '0x0', 06:55:28 INFO - 'XPC_SERVICE_NAME': '0', 06:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-cvVUZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-te6a2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-AuMoR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-qJ3Iix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-tkE0NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-dsiAM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:28 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-v4r8xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-3MKWBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-egTZpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-2ro4Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-uVDE6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-k4m6os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-sSEG4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-mgNj8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:29 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-y5sbYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:30 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-G6dd1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:30 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-6VieRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:30 INFO - Running setup.py install for manifestparser 06:55:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozcrash 06:55:30 INFO - Running setup.py install for mozdebug 06:55:30 INFO - Running setup.py install for mozdevice 06:55:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:30 INFO - Running setup.py install for mozfile 06:55:30 INFO - Running setup.py install for mozhttpd 06:55:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for mozinfo 06:55:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for mozInstall 06:55:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for mozleak 06:55:31 INFO - Running setup.py install for mozlog 06:55:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for moznetwork 06:55:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:31 INFO - Running setup.py install for mozprocess 06:55:32 INFO - Running setup.py install for mozprofile 06:55:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:32 INFO - Running setup.py install for mozrunner 06:55:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:32 INFO - Running setup.py install for mozscreenshot 06:55:32 INFO - Running setup.py install for moztest 06:55:32 INFO - Running setup.py install for mozversion 06:55:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:32 INFO - Cleaning up... 06:55:32 INFO - Return code: 0 06:55:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:32 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')]} 06:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:32 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')]} 06:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:32 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:32 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 06:55:32 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 06:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:32 INFO - 'HOME': '/Users/cltbld', 06:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:32 INFO - 'LOGNAME': 'cltbld', 06:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:32 INFO - 'MOZ_NO_REMOTE': '1', 06:55:32 INFO - 'NO_EM_RESTART': '1', 06:55:32 INFO - 'PAGER': '/bin/cat', 06:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:32 INFO - 'PWD': '/builds/slave/test', 06:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:32 INFO - 'SHELL': '/bin/bash', 06:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:32 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:32 INFO - 'USER': 'cltbld', 06:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:32 INFO - 'XPC_FLAGS': '0x0', 06:55:32 INFO - 'XPC_SERVICE_NAME': '0', 06:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-PahlFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-P05pl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Elh6ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-8wqnqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-waY5O8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-6AxKLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-vjTTXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-lo2N9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:33 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)) 06:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:33 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-f0WmzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-QrfCmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-1HTqbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-uNGnFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-pMQ7Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-AeelCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Gq7mNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-Sv6Fwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:34 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)) 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:34 INFO - Running setup.py (path:/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/pip-tV75Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:34 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)) 06:55:34 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)) 06:55:34 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)) 06:55:34 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)) 06:55:34 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)) 06:55:34 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)) 06:55:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:34 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 06:55:34 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 06:55:34 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 06:55:34 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 06:55:34 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 06:55:34 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 06:55:37 INFO - Downloading blessings-1.6.tar.gz 06:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:37 INFO - Installing collected packages: blessings 06:55:37 INFO - Running setup.py install for blessings 06:55:37 INFO - Successfully installed blessings 06:55:37 INFO - Cleaning up... 06:55:37 INFO - Return code: 0 06:55:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:38 INFO - Reading from file tmpfile_stdout 06:55:38 INFO - Current package versions: 06:55:38 INFO - blessings == 1.6 06:55:38 INFO - blobuploader == 1.2.4 06:55:38 INFO - docopt == 0.6.1 06:55:38 INFO - functools32 == 3.2.3-2 06:55:38 INFO - jsonschema == 2.5.1 06:55:38 INFO - manifestparser == 1.1 06:55:38 INFO - mozInstall == 1.12 06:55:38 INFO - mozcrash == 0.17 06:55:38 INFO - mozdebug == 0.1 06:55:38 INFO - mozdevice == 0.48 06:55:38 INFO - mozfile == 1.2 06:55:38 INFO - mozhttpd == 0.7 06:55:38 INFO - mozinfo == 0.9 06:55:38 INFO - mozleak == 0.1 06:55:38 INFO - mozlog == 3.4 06:55:38 INFO - moznetwork == 0.27 06:55:38 INFO - mozprocess == 0.23 06:55:38 INFO - mozprofile == 0.28 06:55:38 INFO - mozrunner == 6.12 06:55:38 INFO - mozscreenshot == 0.1 06:55:38 INFO - mozsystemmonitor == 0.3 06:55:38 INFO - moztest == 0.7 06:55:38 INFO - mozversion == 1.4 06:55:38 INFO - psutil == 3.1.1 06:55:38 INFO - requests == 1.2.3 06:55:38 INFO - wsgiref == 0.1.2 06:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:38 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 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:38 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 06:55:38 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 06:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:38 INFO - 'HOME': '/Users/cltbld', 06:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:38 INFO - 'LOGNAME': 'cltbld', 06:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:38 INFO - 'MOZ_NO_REMOTE': '1', 06:55:38 INFO - 'NO_EM_RESTART': '1', 06:55:38 INFO - 'PAGER': '/bin/cat', 06:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:38 INFO - 'PWD': '/builds/slave/test', 06:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:38 INFO - 'SHELL': '/bin/bash', 06:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:38 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:38 INFO - 'USER': 'cltbld', 06:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:38 INFO - 'XPC_FLAGS': '0x0', 06:55:38 INFO - 'XPC_SERVICE_NAME': '0', 06:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 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)) 06:55:38 INFO - Cleaning up... 06:55:38 INFO - Return code: 0 06:55:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101268490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011de570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8af264bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, '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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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 06:55:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:38 INFO - 'HOME': '/Users/cltbld', 06:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:38 INFO - 'LOGNAME': 'cltbld', 06:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:38 INFO - 'MOZ_NO_REMOTE': '1', 06:55:38 INFO - 'NO_EM_RESTART': '1', 06:55:38 INFO - 'PAGER': '/bin/cat', 06:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:38 INFO - 'PWD': '/builds/slave/test', 06:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:38 INFO - 'SHELL': '/bin/bash', 06:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:55:38 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:38 INFO - 'USER': 'cltbld', 06:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:38 INFO - 'XPC_FLAGS': '0x0', 06:55:38 INFO - 'XPC_SERVICE_NAME': '0', 06:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:38 INFO - Cleaning up... 06:55:38 INFO - Return code: 0 06:55:38 INFO - Running post-action listener: _resource_record_post_action 06:55:38 INFO - Running post-action listener: _start_resource_monitoring 06:55:38 INFO - Starting resource monitoring. 06:55:38 INFO - [mozharness: 2016-11-14 14:55:38.631650Z] Finished create-virtualenv step (success) 06:55:38 INFO - [mozharness: 2016-11-14 14:55:38.632635Z] Running install step. 06:55:38 INFO - Running pre-action listener: _resource_record_pre_action 06:55:38 INFO - Running main action method: install 06:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:38 INFO - Reading from file tmpfile_stdout 06:55:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:38 INFO - Reading from file tmpfile_stdout 06:55:38 INFO - Output received: 06:55:38 INFO - Usage: mozinstall [options] installer 06:55:38 INFO - Options: 06:55:38 INFO - -h, --help show this help message and exit 06:55:38 INFO - -d DEST, --destination=DEST 06:55:38 INFO - Directory to install application into. [default: 06:55:38 INFO - "/builds/slave/test"] 06:55:38 INFO - --app=APP Application being installed. [default: firefox] 06:55:38 INFO - mkdir: /builds/slave/test/build/application 06:55:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:55:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:56:11 INFO - Reading from file tmpfile_stdout 06:56:11 INFO - Output received: 06:56:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:56:11 INFO - Running post-action listener: _resource_record_post_action 06:56:11 INFO - [mozharness: 2016-11-14 14:56:11.278488Z] Finished install step (success) 06:56:11 INFO - [mozharness: 2016-11-14 14:56:11.278622Z] Running run-tests step. 06:56:11 INFO - Running pre-action listener: _resource_record_pre_action 06:56:11 INFO - Running main action method: run_tests 06:56:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:11 INFO - 2016-11-14 06:56:11.291 screenresolution[1645:7697] starting screenresolution argv=screenresolution get 06:56:11 INFO - 2016-11-14 06:56:11.294 screenresolution[1645:7697] Display 0: 1600x1200x32@60 06:56:11 INFO - 2016-11-14 06:56:11.299 screenresolution[1646:7699] starting screenresolution argv=screenresolution list 06:56:11 INFO - Available Modes on Display 0 06:56:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:11 INFO - Intel Iris: 06:56:11 INFO - Chipset Model: Intel Iris 06:56:11 INFO - Type: GPU 06:56:11 INFO - Bus: Built-In 06:56:11 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:11 INFO - Vendor: Intel (0x8086) 06:56:11 INFO - Device ID: 0x0a2e 06:56:11 INFO - Revision ID: 0x0009 06:56:11 INFO - Displays: 06:56:11 INFO - Display: 06:56:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:11 INFO - Display Serial Number: 1600x1200 60 06:56:11 INFO - Main Display: Yes 06:56:11 INFO - Mirror: Off 06:56:11 INFO - Online: Yes 06:56:11 INFO - Rotation: Supported 06:56:11 INFO - Return code: 0 06:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:11 INFO - Python 2.7.3 06:56:11 INFO - Return code: 0 06:56:11 INFO - grabbing minidump binary from tooltool 06:56:11 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')]} 06:56:11 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 0x10107cd30>, '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 0x100ee2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101074b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:11 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 06:56:11 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 06:56:11 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 06:56:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:11 INFO - Return code: 0 06:56:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 06:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0245 --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 06:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8EsnCc1rFQ/Render', 06:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:11 INFO - 'HOME': '/Users/cltbld', 06:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:11 INFO - 'LOGNAME': 'cltbld', 06:56:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:11 INFO - 'MOZ_NO_REMOTE': '1', 06:56:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:11 INFO - 'NO_EM_RESTART': '1', 06:56:11 INFO - 'PAGER': '/bin/cat', 06:56:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:11 INFO - 'PWD': '/builds/slave/test', 06:56:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:11 INFO - 'SHELL': '/bin/bash', 06:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ef2HieQgh6/Listeners', 06:56:11 INFO - 'TMPDIR': '/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/', 06:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:11 INFO - 'USER': 'cltbld', 06:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:11 INFO - 'XPC_FLAGS': '0x0', 06:56:11 INFO - 'XPC_SERVICE_NAME': '0', 06:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0245', '--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 06:56:11 INFO - mozversion application_buildid: 20161114015620 06:56:11 INFO - mozversion application_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 06:56:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:11 INFO - mozversion application_name: Firefox 06:56:11 INFO - mozversion application_remotingname: firefox-dev 06:56:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:11 INFO - mozversion application_vendor: Mozilla 06:56:11 INFO - mozversion application_version: 51.0a2 06:56:11 INFO - mozversion platform_buildid: 20161114015620 06:56:11 INFO - mozversion platform_changeset: 0f867a8846778f927cfb3871e58cc61f6193ad5d 06:56:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:56:11 INFO - mozversion platform_version: 51.0a2 06:56:11 INFO - using testdate: 1479135371 06:56:11 INFO - actual date: 1479135371 06:56:11 INFO - starting webserver on 'localhost:49274' 06:56:11 INFO - SUITE-START | Running 2 tests 06:56:11 INFO - TEST-START | dromaeo_css 06:56:11 INFO - operating with platform_type : mac_ 06:56:11 INFO - Initialising browser for dromaeo_css test... 06:56:11 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpRoC1G4/profile http://localhost:49274/getInfo.html) 06:56:14 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 06:56:14 INFO - PROCESS | 1656 | colorDepth:24 06:56:14 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 06:56:14 INFO - PROCESS | 1656 | __metrics 06:56:14 INFO - PROCESS | 1656 | 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" 06:56:14 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:56:14 INFO - TEST-INFO | 1656: exit 0 06:56:14 INFO - Browser initialized. 06:56:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:14 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmpRoC1G4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:26 INFO - PROCESS | 1658 | RSS: Main: 219561984 06:56:26 INFO - PROCESS | 1658 | 06:57:17 INFO - PROCESS | 1658 | 1479135437803 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] 06:59:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 06:59:32 INFO - PROCESS | 1658 | RSS: Main: 367566848 06:59:32 INFO - PROCESS | 1658 | 07:02:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 07:02:36 INFO - PROCESS | 1658 | RSS: Main: 353370112 07:02:36 INFO - PROCESS | 1658 | 07:05:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 07:05:39 INFO - PROCESS | 1658 | RSS: Main: 323055616 07:05:39 INFO - PROCESS | 1658 | 07:08:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 07:08:41 INFO - PROCESS | 1658 | RSS: Main: 311500800 07:08:41 INFO - PROCESS | 1658 | 07:11:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 07:11:46 INFO - PROCESS | 1658 | RSS: Main: 310439936 07:11:46 INFO - PROCESS | 1658 | 07:14:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 07:14:49 INFO - PROCESS | 1658 | RSS: Main: 391725056 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | __start_tp_report 07:14:49 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 07:14:49 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 07:14:49 INFO - PROCESS | 1658 | |i|pagename|runs| 07:14:49 INFO - PROCESS | 1658 | |0;dojo.html;2954.85225738713;3315.486099654553;3328.883489077881;3336.849841757121;3401.7448691348154;5726.055200891853;5753.993051216042;5811.157382179582;5829.8834023319505;5839.6496210227415;5679.545636349092;5774.422557744224;5783.6529808211535;5819.709014549277;5825.475707186352;5231.398389185235;5249.1338929076655;5288.92066619001;5295.8146464873735;5310.654807437523;5192.169252919533;5216.921746173811;5358.973205133969;5363.356397232337;5365.141577347626;5269.025230332381;5318.441563635821;5322.308099947001;5324.760385782649;5327.174287985349;5298.284731561228;5315;5339.759710813023;5347.839564813062;5354.759035843357;5199.53204211619;5269.473052694738;5281.656692314988;5303.390110137345;5328.547073498718;5831.037878750001;5839.824805255849;5848.152017957373;5848.947189505887;5850.853728656775;6159.722812473449;6159.784407545759;6177.227846519185;6184.010558310693;6207.658578778165;6294.496440284766;6302.842428939267;6305.243370795488;6352.237731472207;6355.173827402455;5806.680632565207;5830.421279841282;5846.1523079153285;5868.471837534642;5875.706214689334;6198.442140207313;6244.37556244381;6294.464970477469;6341.175647165839;6343;6121.7578389577775;6152.3540028297275;6161.045038019114;6179;6179.62922224668;6292.685365731695;6315.873682526324;6316.747330106836;6318.526110541728;6324.557280990287;6112.449879510866;6151.323354431009;6154.169187159766;6243.531735119794;6274.6548939808745;6274.529410294246;6291.937080629226;6300.180976473121;6320.020396838498;6326.335734747877;4949.876253093629;4951.702897826142;4966.776495057731;4974.701517908937;4988.625853061035;4362.956370436255;4386.956130438719;4394.736315821061;4399.274119770202;4464.687471877002;5837;5876.177335173079;5903.822885313448;5936.436038576328;5946.910796337972;6257.2491301044165;6310.242770867525;6323.588966717149;6332.176817013758;6353.269374021954;4616.838410655611;5780.942190578125;5855.970720146372;5873.324567674772;5915.704214789243;5362.27609272751;5387.353517577837;5412.83761487156;5423.29497165366;5461.290032295856;6334.271558770616;6351.396617321532;6353.936460635427;6360.363963603695;6367.586106903036;6276.592021518587;6310.905336420049;6329.651869147241;6338.841528961812;6383.425491705769;6220.564560480723;6240.344763799736;6268.529860260407;6305.905411418924;6337.461315788025;6210.4100110489435;6218.502519798315;6246.125542424155;6248.343923887926;6267.4986001120715;6321.5258855586935;6321.652309123042;6325;6334.208223972004;6334.904976425265;5998.790042348497;6030;6064.636121832704;6135.662538560422;6148.723307451265;6101.206843110367;6112.633242005494;6150.2927163375;6196.318404975359;6200.286966998672;5575.944240557705;5990;5998.9100163496705;6001.459868611846;6006.489448396936;5905.586608937505;6071.544634152545;6111.602745821508;6149.893019256577;6150.753969841336;5804.1874137619925;5806.796762113306;5841.795537156179;5843.707814609337;5942.1978032965 07:14:49 INFO - PROCESS | 1658 | |1;ext.html;470.64466327922435;518.9377274727032;520.232656831174;523.2674256041543;534.988871033746;25444;40885.59114408855;42125;42270;45067;43259.78370108145;43336.34995475062;43490.34764478535;43543.78228108855;43663.78168109155;9913.553890074927;10099.848502272473;10114.291999560033;10114.544845481934;10131.341462804894;9001.279897608176;9194.448333100036;12217.877821221808;12459.750804983894;12492.93753531231;12399.442025108847;12460.252384856893;12463.501459941592;12473.812892806614;12504.437300321462;8964.14840590143;12375;12440.875591244063;12444.315562644051;12456.19034762742;8905.777355566099;9981.351212171186;12308;12326.445309961073;12492.81260781089;39800.80099599483;40068.79965600153;40128.79935600303;40258.39612405816;40369.192616147804;3307.255867429833;3308.8676452942095;3375.1393394684196;3395.2869897321593;3424.229548351626;29960.8501957491;30877.536836947238;31688.683113168805;31731.73073077074;32039.83980080108;3144.6540880503126;3238.5304130900886;3258.266889949766;3339.482380231068;3383.4924761285756;374946;375540;375547;376016;376733;33256.99999999951;33897.66102338994;56906;57370.426295736506;57567.712161438925;35211.29577408489;35441.64558354435;35519;35527.93416197466;35544.111397215274;15236.771448428282;15382.3077961492;15387.230468496266;15389.230538473255;15400.691986160215;11665.708357291136;11988.920997110128;12964.157329773723;13094.672633184247;13099.869001309866;7609.505382150142;7846.372290216769;7862.213778622092;7880.172581878935;7913.248241417056;2839.205022593677;3220.8228547430117;3263.4125857345907;3289.2434740009453;3293.5883014623173;845.0927227027066;935.7473482159779;943;1027.1525991057408;1119.9440027998567;29378.412431751247;29390.412191756044;29489.705102948697;29962.55056174159;30085.548716769266;932.6782260120248;1051.779126383468;1071.7481391872905;1085.365061439067;1165.8950694437542;14549.563513094625;14954.850451495346;15074.849251507563;15346.232688365537;15362.308696108701;708264;716181.4190929116;716664;718005;719279;48702.512974869795;58132.8373432529;58652.7067364669;58686.11970820441;58712.706436467546;1136.3466007045981;1208.1422190245025;1242.3850194153952;1357.6402253403053;1357.7623915814693;29485;29926.551101733057;30163.547546786376;30387.117001000686;30710.846445767627;48508;49100.50899490959;49145.26282105843;49250.75374623104;49331.76670583264;559197;559331;563550;563867;699247;40029.59970400259;40132.79933600313;40856.79571602123;40957.795211024946;41082.383764242964;44757.77621111873;44785.776071119435;44792.77603611961;44908.307276261614;45267.32099018452;34001.31997360088;36592.81703591465;36940;37428.2514349706;37776.866693999225;37119.07202319964;37250.44124338083;37584.62415375921;37662.623373767005;38110.61889381071;34511;35734.64265357313;35798.4630230552;38414.54269115793;39154.80422597869;30547.54178687277;31197.376052479278;35042.474362885085;35067;35469.64530354663;21112.277019937163;25832.612510811978;25850.741492585585;26116.8694156528;26201.606975894996 07:14:49 INFO - PROCESS | 1658 | |2;jquery.html;356.43505044504457;372.8583138407405;377.93952967525195;381.2946049807856;408.7322803563667;15087.471938482142;15125.394984200633;17051.914740426295;20187.697184542245;20730.983209839567;19392.806071939278;19677.212911483522;19971.900140499278;20180.798192018075;21000.36998890032;1685.039527469343;1685.8904171228892;1687.426275066477;1688.004077594219;1909.5035290824417;3599.982000089996;4437.4009508716235;4496.7301961882395;6118.357572454895;6208.875822483547;6907.516473846833;6909.792706218822;7005.894911576331;7011.193712723051;7022.648867556627;6691.665416729144;6839.350261725178;6914.135733033371;6932.688029038705;7011.89482157768;5800.361960184377;6043.1841701370195;6070.150178974903;6076;6078.45293923549;23787.76212237873;26159.215223543324;26219.475610487683;26511.867440662867;26555.601665975028;2165.6101901657694;2239.3729755668437;2294.0823670531754;2924.4297362014418;2951.911442656702;10268;10397.220208484317;12577.434015469325;14819.555413337617;16035.19824008795;1849.5653521422455;1857.6563335782923;1903.4955736729778;1905.361703829205;1940.9514762130918;109059.45470272677;115806.42096789546;117459;123101.38449307786;123671;9036.728898133066;11290.491927863266;11582.71043223926;11652.242604230698;11714.711381748;14666.926665366818;14668.926655366655;14674.413023479156;14690;14739;8469.915300847037;8685.348598855111;8718.128187181232;8795.868061979076;8821.823563528693;8725.345599080094;8735.388522803343;8735.825283494294;8902.821943561092;8913.37606367548;4459.353393757887;4534.727916325031;4536.206163921301;4588.839390621379;4642.2340313847835;1884.9821096607952;1924.4803902946126;1933.4682962185511;1938.5928954919625;1942.9902850485657;836.2056046755606;873.9737807865774;878.2183856367838;900.5452246615417;961.2262128986233;18672.78626889248;19770.60458790816;20067.096980635906;20688.17247310091;21126.049327780285;923.8152369526122;928.2110206324705;932.9766755831023;949.6533765175661;966.6375109334;10355.741106472398;11154.274972126786;11183.105351571854;11187.440627968732;11252.49363778632;608963;615168;624609;625778;627026;97691;107108.46445767721;112602;118474.81525184811;129787.35106324407;926.8795056642593;998.7752755629925;1009.7122320138872;1015.4465816130227;1017.2167431078028;18681.43955681332;19590.02049897528;19606.509837254183;19738;19795.30716424918;55899.16151257816;55978.72010639921;57782.7110864443;57887.710561446926;58456.4154358468;73397.6330118346;80221;81845.59077204576;82182.76725849237;83282.16717832744;7693.5383876965325;7966.840663186588;7975.162607926316;7978.800529986796;8313.210245026712;8809.080297046814;12047.156699030984;12276.754464910831;12496.812547811609;12725;10716.89283107159;10848.240623156304;11085.612003579836;11093.112550996062;11193.328400296008;9221.953890230507;10614.469276536296;10754.300970436896;11068.225224234226;11089.5564177432;10240.590376384862;10269.486525673537;10643.787124257626;10773.407462589634;11447.656570302905;7834.451588388986;7875.251851074138;7887.369010479033;8118.837623247384;8285.922830032297;8072.838543228985;10023.899761002296;10455.11131553796;10896.836547451952;11086.501107450023 07:14:49 INFO - PROCESS | 1658 | |3;mootools.html;1334.7909210257021;1533.1184568872898;1680.55465301695;1799.4691565988032;1876.493346796365;8086.878696819553;8333.624986875606;8567.18611731886;9137.725868223955;9151.267898568107;8198.262156405923;8645.69740059098;8896;8897.199252067312;9020.143086406797;2063.9277625283116;2383.928482145534;2428.4778772563895;2430.5538204768136;2437.9882348825217;2134.647783115784;2215.3353993801875;2392.928212153638;2420.7942324902406;2446.804255659552;2350.2831636350907;2420.1287536486852;2431.659567660529;2440.4143005678598;2442.7190873049562;2423.09134074722;2437.890294936732;2449.9387515312083;2450.5221481810963;2450.571150048734;2423.4183795889035;2434.0750514804263;2444;2446.0582675669993;2459.446624509489;8953.686620968236;9166.954165229197;9175.678851240242;9175.908240917572;9219.585118669609;5278.630495865291;5451.291332126838;5454.53636440903;5463.098588732854;5479.808206712746;3067.8312692801887;3427.365937301582;3531.2054787672823;3577.266660334651;3603.94594081089;1063.0698975846929;1093.9398333091676;1126.222906194723;1127.0307535519446;1133.6485689436302;10887.891121088767;11988.220765650205;12015.519379224821;12032;12035.93982030093;4686.691592069429;4766.118268120409;4780.641451891052;4867.951320486821;4901.411830580353;10197.541110650038;10207.489625518694;10217.74455638615;10230.335028223142;10273.229507786797;5404.972975135178;5408.432114627986;5413.621046526705;5413.729313534308;5423.701696406657;4085.816138273785;4769.856904292877;4899.755012249373;4940.950590494049;4943.530364615356;3838.6353296436796;3841.4429907663234;3879.8254078566533;3897.941530877039;3935.92128157441;1119.5969450997634;1129.6215767717742;1131.140333346646;1181.757739663367;1198.167273744739;759.2521366454039;879.3756432932562;885.831691978522;927.4898805656861;934.621478301289;5723.685197314105;5746.2529871116485;5817.563682723812;5859.765609375577;5896.285340235624;476.4520801078718;486.4405933176875;490.94845041270867;491.1772780592493;524.7743470307804;3908.2769687607883;3944.15200731844;3961.603839616073;3992.321305378093;4033.7983100845427;10668.199885008655;11062.280951738112;11184.217104802749;11190.888091119148;11204.15968802343;9411.764705882271;11093.83359249612;11128.221024528368;11137.498812553455;11160.720981975515;6723.899141512881;8291.792705182297;8390.370722195737;8397.748067557983;8400.957995209985;6006.639601623917;6049.576529642883;6092.786752463642;6126.264848218242;6135.325114237341;9870.407775533491;10080.69757907264;10342;10387.896121038693;10403.687889363331;10201.234907382124;10503.527341269813;10600.946995264974;10671.413072281099;10671.57313707443;7363.521371110861;7583.810404739926;7695.384369250559;7799.220077992382;7806.0632724073475;8263.132371100948;8358.122397148456;8399.370047246359;8422.073571907207;8422.284105851071;7598.734044308423;7647.770566883002;7682.462227644011;7702.152763196156;7772.222777722409;6448.806535803933;7458.47790654649;7461.4403919705155;7484.550926944401;7505.174430812497;7016.508844381048;7156.534825236343;7159.498835081495;7159.64201789898;7159.856802863809;4293.551248568995;4941.258811178208;5085.821996230115;5088.363954505687;5094.872628184325;4984.40187177541;5049.671771334852;5066.518680725325;5116.232565115262;5132.281480592795 07:14:49 INFO - PROCESS | 1658 | |4;prototype.html;302.08468340926987;304.92224482756893;310.0821568158251;314.613025978047;317.8077263255729;4110.1163249901265;4476.910461790766;5330.253764472977;5347.866303342418;5405.216243644669;4300.956990430095;4479.118770116551;4873.758071287212;5197.974010129953;5204.32343795307;3890.8054597270093;4074.246264441088;4095.7438836125352;4110.732802367851;4124.752514849104;4080.8163632636456;4104.322786740185;4107.322291821846;4114.362273847543;4116.650084742801;3366.663333666638;3780.5085338905906;4043.818028188724;4100.384942258655;4101.958980410188;3986.8670261410007;4012.137390461065;4013.9397909031386;4025.7181997260204;4060.736052156615;2939.3827296267596;3008.699130086996;3450.5341778859784;3477.5826900771817;3494.860205591773;4309.525952145262;4782.210935195689;4840.927386089212;5201.439568129584;5252.65857719247;4164.729292595972;4318.935215971763;4608.009278005245;4618.191816432144;4625.629949604024;4942.579880710144;5231.2937753403185;5560.749766260528;5595.356533998602;5617.522510586564;3254.934901301984;3831.272058308912;3841.2317536492815;3844.1735026969054;3865.9806700966597;5156.432792392834;5550.69471179085;5776.595638305363;5884.470397664188;5925.407459254083;3124.5781819454537;3590.551181102362;3899.083715326896;3908.394198899175;3910.3156947534635;3182.6499085100622;3569.803660798629;3983.9203215935518;3991.2815693174925;3993.381025940984;3851.5955824638568;4488.775561221991;4578.839740609063;4657.278121891045;4675.929861052087;5149.665271757323;5485.17722341644;5721.256236689287;5721.742521586539;5794.739236734357;1274.4902039184215;1311;1344.5831792144465;1352.5198554513204;1360.340234986031;820.9466384684977;843.9873401898976;869.2046777198918;885.1414128295543;910.3036177324352;5308.089087928342;5344.904294619671;5357.464253574612;5416.647917885325;5457.454254574511;5215.452377500384;5370.70461124634;5527.922055199278;5782.45066718661;5834.7989447597665;3817.1172293509408;5321.866953326198;5321.9622173676535;5340.626156169031;5368.9731551342775;2575.433404650974;2973.5391014392803;3036.498977668704;3039;3055.6486004109365;5065.848024559269;5246.291750613695;5757.251557297524;5927.695906900475;5991.741734235859;4577.977110114428;5133.922991155136;5840.8247752567495;5869.442402971711;5897.49871260939;5775.797847075416;5899.144624029492;5900.170947006442;5930.673812940329;5990.34106248321;4889.779959901742;5121.820736274212;5712.771489140554;5807.593468457337;5855.36049906027;5013.674111182761;5176.792928282977;5656.935218645082;5682.289713785777;5705.572082093942;5341.931613677358;5489.612018771847;5726.656400615976;5964.7912323068485;5988.353202869246;3225.4677978133345;3326.650701676289;3474.114100904253;3787.9204426738247;3879.767213967171;5465.617406781487;5732.885342293047;5794.18881356602;5830.82507524775;5856.765729370948;5317.920231196613;5652.576056795675;5670.752434464412;5670.886582268249;5681.176229446624;5688.829335119953;5727.6849773262875;5731;5741.62679425836;5777.480026797609;4672.252439609646;5506.449355064622;5589.888202236014;5633.887322253614;5639.88720225585;4884.316195732671;5181.689098654093;5372.570194384518;5591.30108736408;5745.425457454221;4901.50984901507;5592.427483357538;5602.887942241051;5609.289166804164;5611.607187496836 07:14:49 INFO - PROCESS | 1658 | |5;yui.html;741.8850078237873;789.8775689768084;793.9206079392058;795.5505139596131;795.705588932095;14850.77723834142;15793.210339483037;15794.684106317867;15873.523794286175;16054.67890642188;11780.882191178085;14402.783958240634;14820.925895370536;15088.622784430394;15117.244137793094;843.9451435656678;857.4812238595654;858.9871151932726;859.8065435277075;859.9484030958163;684.8732984397902;708.922018577956;847.6355167278068;881.8633111867639;884.7788052986754;922.4741897118645;922.7600823785797;923.8429466990594;924.2652091587204;928.2202949522433;915.6474757218485;918.7886786039215;922.5433410461798;923.5428462910869;923.7413524213231;529.9496547827989;548.7064420535035;663.3200969006758;678.9781379024586;679.1748026148205;15203.239838008056;15267.541973740805;15273.465428710053;15282.235888205656;15295.770563441558;13461.865381346159;13724.176549406968;13853.792193117111;13990.16059036461;14117.576472705836;12278.693032674166;12541.93729031349;12599.37003149848;12793.552225672056;12901.548445804445;4529.614982726473;4593.311003349491;4621.930671039937;4640.930386044212;4761.119192949315;118381;119601.73683142116;122096.99999999911;122573.77426225712;124385;10995.615153469751;11075.058620017227;11090.833637495443;11099.83350249747;11107.166962477846;21642.917854107232;21752.782472175393;21812.672809907865;21821.127154913625;21830.345089647337;7602.847943041108;7681.923180768233;7786.4938778979185;8010.319122874621;8018.198180181935;3994.9201015979515;4334.891627709332;4363.4763828340165;4391.275439552502;4518.457785065813;3411.7441191910707;3539.7168226541817;3543.787372757643;3551.378508761008;3557.2351944332095;639.587466084373;653.3433898931544;662.8773676869795;667.7095463473405;670.2359310386164;566.7392999220323;616.636184651058;625.4746013348808;637.1875858280729;650.40487953522;7554.8866766998535;8800.668783153054;9161.076174003401;9185.540722963826;9275;624.3444383397415;626.5175814622806;639.159505250594;652.6182183422751;664.1863716946798;4168.6665066794585;4449.243628583084;4454.487733910577;4457.197704413172;4519.118771839526;101888;108951.45524272328;139687;170838;177152.114239428;120089.19643214348;125091;127425.72574274139;133608.66391336155;134162.98755518676;73049.2695073053;74701.6264918672;78975;125120;128101;8446.66213351459;8603.225709686158;8841.336899732674;8845.071267517076;9123.635054597742;45463.77268113638;47652.285215722484;60469.79060418679;61850;63827.40431489064;74950;91500.54249728708;94563.05436945817;95383;99352.50323748335;11587.710307242049;13162.341882905625;13197.868021320048;13238.139520931494;13466.259355735529;14641;14875.330610122786;14897.553073407815;15072.171030593423;15079.321430535432;11264.718382040515;13330.86669133335;13788.724225515634;13886.93056534711;14373.7843932339;13083.448727498046;13615.727685446038;13689.31553422305;14066.718665626835;14087.929560352133;13706.588802335946;13758.31208439554;13818.170909745448;13825.51610693621;13852.238126903118;10896.400697961688;11270.211085223955;11350.375729334966;11740.941295293469;11874.703132421759;10372.948135259276;11506.137039721887;11606.883931160917;11668.649940501798;11740.236884602473 07:14:49 INFO - PROCESS | 1658 | __end_tp_report 07:14:49 INFO - PROCESS | 1658 | __start_cc_report 07:14:49 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1358 07:14:49 INFO - PROCESS | 1658 | __end_cc_report 07:14:49 INFO - PROCESS | 1658 | __startTimestamp1479136489248__endTimestamp 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | ------- Summary: start ------- 07:14:49 INFO - PROCESS | 1658 | Number of tests: 6 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5786.58 Median:5990.00 stddev:656.88 (11.0%) stddev-sans-first:620.20 07:14:49 INFO - PROCESS | 1658 | Values: 2954.9 3315.5 3328.9 3336.8 3401.7 5726.1 5754.0 5811.2 5829.9 5839.6 5679.5 5774.4 5783.7 5819.7 5825.5 5231.4 5249.1 5288.9 5295.8 5310.7 5192.2 5216.9 5359.0 5363.4 5365.1 5269.0 5318.4 5322.3 5324.8 5327.2 5298.3 5315.0 5339.8 5347.8 5354.8 5199.5 5269.5 5281.7 5303.4 5328.5 5831.0 5839.8 5848.2 5848.9 5850.9 6159.7 6159.8 6177.2 6184.0 6207.7 6294.5 6302.8 6305.2 6352.2 6355.2 5806.7 5830.4 5846.2 5868.5 5875.7 6198.4 6244.4 6294.5 6341.2 6343.0 6121.8 6152.4 6161.0 6179.0 6179.6 6292.7 6315.9 6316.7 6318.5 6324.6 6112.4 6151.3 6154.2 6243.5 6274.7 6274.5 6291.9 6300.2 6320.0 6326.3 4949.9 4951.7 4966.8 4974.7 4988.6 4363.0 4387.0 4394.7 4399.3 4464.7 5837.0 5876.2 5903.8 5936.4 5946.9 6257.2 6310.2 6323.6 6332.2 6353.3 4616.8 5780.9 5856.0 5873.3 5915.7 5362.3 5387.4 5412.8 5423.3 5461.3 6334.3 6351.4 6353.9 6360.4 6367.6 6276.6 6310.9 6329.7 6338.8 6383.4 6220.6 6240.3 6268.5 6305.9 6337.5 6210.4 6218.5 6246.1 6248.3 6267.5 6321.5 6321.7 6325.0 6334.2 6334.9 5998.8 6030.0 6064.6 6135.7 6148.7 6101.2 6112.6 6150.3 6196.3 6200.3 5575.9 5990.0 5998.9 6001.5 6006.5 5905.6 6071.5 6111.6 6149.9 6150.8 5804.2 5806.8 5841.8 5843.7 5942.2 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:68304.38 Median:35455.65 stddev:155305.39 (438.0%) stddev-sans-first:155657.55 07:14:49 INFO - PROCESS | 1658 | Values: 470.6 518.9 520.2 523.3 535.0 25444.0 40885.6 42125.0 42270.0 45067.0 43259.8 43336.3 43490.3 43543.8 43663.8 9913.6 10099.8 10114.3 10114.5 10131.3 9001.3 9194.4 12217.9 12459.8 12492.9 12399.4 12460.3 12463.5 12473.8 12504.4 8964.1 12375.0 12440.9 12444.3 12456.2 8905.8 9981.4 12308.0 12326.4 12492.8 39800.8 40068.8 40128.8 40258.4 40369.2 3307.3 3308.9 3375.1 3395.3 3424.2 29960.9 30877.5 31688.7 31731.7 32039.8 3144.7 3238.5 3258.3 3339.5 3383.5 374946.0 375540.0 375547.0 376016.0 376733.0 33257.0 33897.7 56906.0 57370.4 57567.7 35211.3 35441.6 35519.0 35527.9 35544.1 15236.8 15382.3 15387.2 15389.2 15400.7 11665.7 11988.9 12964.2 13094.7 13099.9 7609.5 7846.4 7862.2 7880.2 7913.2 2839.2 3220.8 3263.4 3289.2 3293.6 845.1 935.7 943.0 1027.2 1119.9 29378.4 29390.4 29489.7 29962.6 30085.5 932.7 1051.8 1071.7 1085.4 1165.9 14549.6 14954.9 15074.8 15346.2 15362.3 708264.0 716181.4 716664.0 718005.0 719279.0 48702.5 58132.8 58652.7 58686.1 58712.7 1136.3 1208.1 1242.4 1357.6 1357.8 29485.0 29926.6 30163.5 30387.1 30710.8 48508.0 49100.5 49145.3 49250.8 49331.8 559197.0 559331.0 563550.0 563867.0 699247.0 40029.6 40132.8 40856.8 40957.8 41082.4 44757.8 44785.8 44792.8 44908.3 45267.3 34001.3 36592.8 36940.0 37428.3 37776.9 37119.1 37250.4 37584.6 37662.6 38110.6 34511.0 35734.6 35798.5 38414.5 39154.8 30547.5 31197.4 35042.5 35067.0 35469.6 21112.3 25832.6 25850.7 26116.9 26201.6 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35262.29 Median:13040.92 stddev:103091.71 (790.5%) stddev-sans-first:103347.59 07:14:49 INFO - PROCESS | 1658 | Values: 356.4 372.9 377.9 381.3 408.7 15087.5 15125.4 17051.9 20187.7 20731.0 19392.8 19677.2 19971.9 20180.8 21000.4 1685.0 1685.9 1687.4 1688.0 1909.5 3600.0 4437.4 4496.7 6118.4 6208.9 6907.5 6909.8 7005.9 7011.2 7022.6 6691.7 6839.4 6914.1 6932.7 7011.9 5800.4 6043.2 6070.2 6076.0 6078.5 23787.8 26159.2 26219.5 26511.9 26555.6 2165.6 2239.4 2294.1 2924.4 2951.9 10268.0 10397.2 12577.4 14819.6 16035.2 1849.6 1857.7 1903.5 1905.4 1941.0 109059.5 115806.4 117459.0 123101.4 123671.0 9036.7 11290.5 11582.7 11652.2 11714.7 14666.9 14668.9 14674.4 14690.0 14739.0 8469.9 8685.3 8718.1 8795.9 8821.8 8725.3 8735.4 8735.8 8902.8 8913.4 4459.4 4534.7 4536.2 4588.8 4642.2 1885.0 1924.5 1933.5 1938.6 1943.0 836.2 874.0 878.2 900.5 961.2 18672.8 19770.6 20067.1 20688.2 21126.0 923.8 928.2 933.0 949.7 966.6 10355.7 11154.3 11183.1 11187.4 11252.5 608963.0 615168.0 624609.0 625778.0 627026.0 97691.0 107108.5 112602.0 118474.8 129787.4 926.9 998.8 1009.7 1015.4 1017.2 18681.4 19590.0 19606.5 19738.0 19795.3 55899.2 55978.7 57782.7 57887.7 58456.4 73397.6 80221.0 81845.6 82182.8 83282.2 7693.5 7966.8 7975.2 7978.8 8313.2 8809.1 12047.2 12276.8 12496.8 12725.0 10716.9 10848.2 11085.6 11093.1 11193.3 9222.0 10614.5 10754.3 11068.2 11089.6 10240.6 10269.5 10643.8 10773.4 11447.7 7834.5 7875.3 7887.4 8118.8 8285.9 8072.8 10023.9 10455.1 10896.8 11086.5 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5779.15 Median:2677.20 stddev:3301.11 (123.3%) stddev-sans-first:3293.47 07:14:49 INFO - PROCESS | 1658 | Values: 1334.8 1533.1 1680.6 1799.5 1876.5 8086.9 8333.6 8567.2 9137.7 9151.3 8198.3 8645.7 8896.0 8897.2 9020.1 2063.9 2383.9 2428.5 2430.6 2438.0 2134.6 2215.3 2392.9 2420.8 2446.8 2350.3 2420.1 2431.7 2440.4 2442.7 2423.1 2437.9 2449.9 2450.5 2450.6 2423.4 2434.1 2444.0 2446.1 2459.4 8953.7 9167.0 9175.7 9175.9 9219.6 5278.6 5451.3 5454.5 5463.1 5479.8 3067.8 3427.4 3531.2 3577.3 3603.9 1063.1 1093.9 1126.2 1127.0 1133.6 10887.9 11988.2 12015.5 12032.0 12035.9 4686.7 4766.1 4780.6 4868.0 4901.4 10197.5 10207.5 10217.7 10230.3 10273.2 5405.0 5408.4 5413.6 5413.7 5423.7 4085.8 4769.9 4899.8 4941.0 4943.5 3838.6 3841.4 3879.8 3897.9 3935.9 1119.6 1129.6 1131.1 1181.8 1198.2 759.3 879.4 885.8 927.5 934.6 5723.7 5746.3 5817.6 5859.8 5896.3 476.5 486.4 490.9 491.2 524.8 3908.3 3944.2 3961.6 3992.3 4033.8 10668.2 11062.3 11184.2 11190.9 11204.2 9411.8 11093.8 11128.2 11137.5 11160.7 6723.9 8291.8 8390.4 8397.7 8401.0 6006.6 6049.6 6092.8 6126.3 6135.3 9870.4 10080.7 10342.0 10387.9 10403.7 10201.2 10503.5 10600.9 10671.4 10671.6 7363.5 7583.8 7695.4 7799.2 7806.1 8263.1 8358.1 8399.4 8422.1 8422.3 7598.7 7647.8 7682.5 7702.2 7772.2 6448.8 7458.5 7461.4 7484.6 7505.2 7016.5 7156.5 7159.5 7159.6 7159.9 4293.6 4941.3 5085.8 5088.4 5094.9 4984.4 5049.7 5066.5 5116.2 5132.3 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4513.26 Median:5166.61 stddev:1411.94 (27.3%) stddev-sans-first:1380.07 07:14:49 INFO - PROCESS | 1658 | Values: 302.1 304.9 310.1 314.6 317.8 4110.1 4476.9 5330.3 5347.9 5405.2 4301.0 4479.1 4873.8 5198.0 5204.3 3890.8 4074.2 4095.7 4110.7 4124.8 4080.8 4104.3 4107.3 4114.4 4116.7 3366.7 3780.5 4043.8 4100.4 4102.0 3986.9 4012.1 4013.9 4025.7 4060.7 2939.4 3008.7 3450.5 3477.6 3494.9 4309.5 4782.2 4840.9 5201.4 5252.7 4164.7 4318.9 4608.0 4618.2 4625.6 4942.6 5231.3 5560.7 5595.4 5617.5 3254.9 3831.3 3841.2 3844.2 3866.0 5156.4 5550.7 5776.6 5884.5 5925.4 3124.6 3590.6 3899.1 3908.4 3910.3 3182.6 3569.8 3983.9 3991.3 3993.4 3851.6 4488.8 4578.8 4657.3 4675.9 5149.7 5485.2 5721.3 5721.7 5794.7 1274.5 1311.0 1344.6 1352.5 1360.3 820.9 844.0 869.2 885.1 910.3 5308.1 5344.9 5357.5 5416.6 5457.5 5215.5 5370.7 5527.9 5782.5 5834.8 3817.1 5321.9 5322.0 5340.6 5369.0 2575.4 2973.5 3036.5 3039.0 3055.6 5065.8 5246.3 5757.3 5927.7 5991.7 4578.0 5133.9 5840.8 5869.4 5897.5 5775.8 5899.1 5900.2 5930.7 5990.3 4889.8 5121.8 5712.8 5807.6 5855.4 5013.7 5176.8 5656.9 5682.3 5705.6 5341.9 5489.6 5726.7 5964.8 5988.4 3225.5 3326.7 3474.1 3787.9 3879.8 5465.6 5732.9 5794.2 5830.8 5856.8 5317.9 5652.6 5670.8 5670.9 5681.2 5688.8 5727.7 5731.0 5741.6 5777.5 4672.3 5506.4 5589.9 5633.9 5639.9 4884.3 5181.7 5372.6 5591.3 5745.4 4901.5 5592.4 5602.9 5609.3 5611.6 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24367.47 Median:3554.31 stddev:39124.75 (1100.8%) stddev-sans-first:39194.29 07:14:49 INFO - PROCESS | 1658 | Values: 741.9 789.9 793.9 795.6 795.7 14850.8 15793.2 15794.7 15873.5 16054.7 11780.9 14402.8 14820.9 15088.6 15117.2 843.9 857.5 859.0 859.8 859.9 684.9 708.9 847.6 881.9 884.8 922.5 922.8 923.8 924.3 928.2 915.6 918.8 922.5 923.5 923.7 529.9 548.7 663.3 679.0 679.2 15203.2 15267.5 15273.5 15282.2 15295.8 13461.9 13724.2 13853.8 13990.2 14117.6 12278.7 12541.9 12599.4 12793.6 12901.5 4529.6 4593.3 4621.9 4640.9 4761.1 118381.0 119601.7 122097.0 122573.8 124385.0 10995.6 11075.1 11090.8 11099.8 11107.2 21642.9 21752.8 21812.7 21821.1 21830.3 7602.8 7681.9 7786.5 8010.3 8018.2 3994.9 4334.9 4363.5 4391.3 4518.5 3411.7 3539.7 3543.8 3551.4 3557.2 639.6 653.3 662.9 667.7 670.2 566.7 616.6 625.5 637.2 650.4 7554.9 8800.7 9161.1 9185.5 9275.0 624.3 626.5 639.2 652.6 664.2 4168.7 4449.2 4454.5 4457.2 4519.1 101888.0 108951.5 139687.0 170838.0 177152.1 120089.2 125091.0 127425.7 133608.7 134163.0 73049.3 74701.6 78975.0 125120.0 128101.0 8446.7 8603.2 8841.3 8845.1 9123.6 45463.8 47652.3 60469.8 61850.0 63827.4 74950.0 91500.5 94563.1 95383.0 99352.5 11587.7 13162.3 13197.9 13238.1 13466.3 14641.0 14875.3 14897.6 15072.2 15079.3 11264.7 13330.9 13788.7 13886.9 14373.8 13083.4 13615.7 13689.3 14066.7 14087.9 13706.6 13758.3 13818.2 13825.5 13852.2 10896.4 11270.2 11350.4 11740.9 11874.7 10372.9 11506.1 11606.9 11668.6 11740.2 07:14:49 INFO - PROCESS | 1658 | -------- Summary: end -------- 07:14:49 INFO - PROCESS | 1658 | 07:14:49 INFO - TEST-INFO | 1658: exit 0 07:14:49 INFO - TEST-OK | dromaeo_css | took 1117952ms 07:14:49 INFO - TEST-START | kraken 07:14:49 INFO - operating with platform_type : mac_ 07:14:49 INFO - Initialising browser for kraken test... 07:14:49 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmp99fyj7/profile http://localhost:49274/getInfo.html) 07:14:52 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 07:14:52 INFO - PROCESS | 1664 | colorDepth:24 07:14:52 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 07:14:52 INFO - PROCESS | 1664 | __metrics 07:14:52 INFO - PROCESS | 1664 | 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" 07:14:52 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:53 INFO - TEST-INFO | 1664: exit 0 07:14:53 INFO - Browser initialized. 07:14:53 INFO - Running cycle 1/1 for kraken test... 07:14:53 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/T/tmp99fyj7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:05 INFO - PROCESS | 1665 | RSS: Main: 220037120 07:15:05 INFO - PROCESS | 1665 | 07:15:07 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:08 INFO - PROCESS | 1665 | RSS: Main: 269815808 07:15:08 INFO - PROCESS | 1665 | 07:15:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 07:15:11 INFO - PROCESS | 1665 | RSS: Main: 281100288 07:15:11 INFO - PROCESS | 1665 | 07:15:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 07:15:15 INFO - PROCESS | 1665 | RSS: Main: 379539456 07:15:15 INFO - PROCESS | 1665 | 07:15:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 07:15:18 INFO - PROCESS | 1665 | RSS: Main: 279691264 07:15:18 INFO - PROCESS | 1665 | 07:15:20 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:20 INFO - PROCESS | 1665 | RSS: Main: 280039424 07:15:20 INFO - PROCESS | 1665 | 07:15:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:24 INFO - PROCESS | 1665 | RSS: Main: 316043264 07:15:24 INFO - PROCESS | 1665 | 07:15:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:27 INFO - PROCESS | 1665 | RSS: Main: 318431232 07:15:27 INFO - PROCESS | 1665 | 07:15:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 07:15:31 INFO - PROCESS | 1665 | RSS: Main: 316534784 07:15:31 INFO - PROCESS | 1665 | 07:15:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:33 INFO - PROCESS | 1665 | RSS: Main: 295657472 07:15:33 INFO - PROCESS | 1665 | 07:15:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:35 INFO - PROCESS | 1665 | RSS: Main: 297701376 07:15:35 INFO - PROCESS | 1665 | 07:15:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:38 INFO - PROCESS | 1665 | RSS: Main: 299499520 07:15:38 INFO - PROCESS | 1665 | 07:15:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:42 INFO - PROCESS | 1665 | RSS: Main: 307552256 07:15:42 INFO - PROCESS | 1665 | 07:15:45 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:45 INFO - PROCESS | 1665 | RSS: Main: 307183616 07:15:45 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 07:15:47 INFO - PROCESS | 1665 | RSS: Main: 351358976 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | __start_tp_report 07:15:47 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:15:47 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:15:47 INFO - PROCESS | 1665 | |i|pagename|runs| 07:15:47 INFO - PROCESS | 1665 | |0;ai-astar;115;114;112;115;115;113;114;114;112;113 07:15:47 INFO - PROCESS | 1665 | |1;audio-beat-detection;145;110;109;143;107;110;109;109;137;107 07:15:47 INFO - PROCESS | 1665 | |2;audio-dft;183;186;181;188;258;219;182;183;183;181 07:15:47 INFO - PROCESS | 1665 | |3;audio-fft;82;59;57;88;62;60;74;49;83;96 07:15:47 INFO - PROCESS | 1665 | |4;audio-oscillator;88;72;94;70;67;70;91;68;69;89 07:15:47 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;89;87;95;84;86;83;91;85;91;84 07:15:47 INFO - PROCESS | 1665 | |6;imaging-darkroom;93;94;93;94;93;93;98;94;91;131 07:15:47 INFO - PROCESS | 1665 | |7;imaging-desaturate;86;84;85;84;83;83;85;89;79;93 07:15:47 INFO - PROCESS | 1665 | |8;json-parse-financial;53;52;53;55;57;57;57;56;56;56 07:15:47 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;72;74;66;77;74;70;71;71;71;72 07:15:47 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;83;79;82;82;82;82;81;81;82;85 07:15:47 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;146;152;139;138;135;136;141;141;167;141 07:15:47 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;155;205;222;162;164;164;165;163;163;164 07:15:47 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;63;64;67;66;65;63;64;65;66;65 07:15:47 INFO - PROCESS | 1665 | __end_tp_report 07:15:47 INFO - PROCESS | 1665 | __start_cc_report 07:15:47 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1957 07:15:47 INFO - PROCESS | 1665 | __end_cc_report 07:15:47 INFO - PROCESS | 1665 | __startTimestamp1479136547558__endTimestamp 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:15:47 INFO - PROCESS | 1665 | Number of tests: 14 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.13 07:15:47 INFO - PROCESS | 1665 | Values: 115.0 114.0 112.0 115.0 115.0 113.0 114.0 114.0 112.0 113.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:110.00 stddev:16.07 (14.6%) stddev-sans-first:13.92 07:15:47 INFO - PROCESS | 1665 | Values: 145.0 110.0 109.0 143.0 107.0 110.0 109.0 109.0 137.0 107.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:194.40 Median:184.50 stddev:25.09 (13.6%) stddev-sans-first:26.27 07:15:47 INFO - PROCESS | 1665 | Values: 183.0 186.0 181.0 188.0 258.0 219.0 182.0 183.0 183.0 181.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:71.00 Median:78.00 stddev:15.68 (20.1%) stddev-sans-first:16.12 07:15:47 INFO - PROCESS | 1665 | Values: 82.0 59.0 57.0 88.0 62.0 60.0 74.0 49.0 83.0 96.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:80.00 stddev:11.11 (13.9%) stddev-sans-first:11.16 07:15:47 INFO - PROCESS | 1665 | Values: 88.0 72.0 94.0 70.0 67.0 70.0 91.0 68.0 69.0 89.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:3.89 (4.4%) stddev-sans-first:4.09 07:15:47 INFO - PROCESS | 1665 | Values: 89.0 87.0 95.0 84.0 86.0 83.0 91.0 85.0 91.0 84.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:93.50 stddev:11.94 (12.8%) stddev-sans-first:12.55 07:15:47 INFO - PROCESS | 1665 | Values: 93.0 94.0 93.0 94.0 93.0 93.0 98.0 94.0 91.0 131.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:3.75 (4.4%) stddev-sans-first:3.97 07:15:47 INFO - PROCESS | 1665 | Values: 86.0 84.0 85.0 84.0 83.0 83.0 85.0 89.0 79.0 93.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.87 (3.3%) stddev-sans-first:1.81 07:15:47 INFO - PROCESS | 1665 | Values: 53.0 52.0 53.0 55.0 57.0 57.0 57.0 56.0 56.0 56.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:2.90 (4.0%) stddev-sans-first:3.07 07:15:47 INFO - PROCESS | 1665 | Values: 72.0 74.0 66.0 77.0 74.0 70.0 71.0 71.0 71.0 72.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.52 (1.9%) stddev-sans-first:1.56 07:15:47 INFO - PROCESS | 1665 | Values: 83.0 79.0 82.0 82.0 82.0 82.0 81.0 81.0 82.0 85.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:141.00 stddev:9.59 (6.8%) stddev-sans-first:10.14 07:15:47 INFO - PROCESS | 1665 | Values: 146.0 152.0 139.0 138.0 135.0 136.0 141.0 141.0 167.0 141.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:164.00 stddev:22.05 (13.4%) stddev-sans-first:22.44 07:15:47 INFO - PROCESS | 1665 | Values: 155.0 205.0 222.0 162.0 164.0 164.0 165.0 163.0 163.0 164.0 07:15:47 INFO - PROCESS | 1665 | 07:15:47 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.32 (2.0%) stddev-sans-first:1.22 07:15:47 INFO - PROCESS | 1665 | Values: 63.0 64.0 67.0 66.0 65.0 63.0 64.0 65.0 66.0 65.0 07:15:47 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:15:47 INFO - PROCESS | 1665 | 07:15:48 INFO - TEST-INFO | 1665: exit 0 07:15:48 INFO - TEST-OK | kraken | took 58557ms 07:15:48 INFO - SUITE-END | took 1176s 07:15:48 INFO - Completed test suite (00:19:36) 07:15:48 INFO - javascript benchmark 07:15:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2954.85225738713, 3315.486099654553, 3328.883489077881, 3336.849841757121, 3401.7448691348154, 5726.055200891853, 5753.993051216042, 5811.157382179582, 5829.8834023319505, 5839.6496210227415, 5679.545636349092, 5774.422557744224, 5783.6529808211535, 5819.709014549277, 5825.475707186352, 5231.398389185235, 5249.1338929076655, 5288.92066619001, 5295.8146464873735, 5310.654807437523, 5192.169252919533, 5216.921746173811, 5358.973205133969, 5363.356397232337, 5365.141577347626, 5269.025230332381, 5318.441563635821, 5322.308099947001, 5324.760385782649, 5327.174287985349, 5298.284731561228, 5315.0, 5339.759710813023, 5347.839564813062, 5354.759035843357, 5199.53204211619, 5269.473052694738, 5281.656692314988, 5303.390110137345, 5328.547073498718, 5831.037878750001, 5839.824805255849, 5848.152017957373, 5848.947189505887, 5850.853728656775, 6159.722812473449, 6159.784407545759, 6177.227846519185, 6184.010558310693, 6207.658578778165, 6294.496440284766, 6302.842428939267, 6305.243370795488, 6352.237731472207, 6355.173827402455, 5806.680632565207, 5830.421279841282, 5846.1523079153285, 5868.471837534642, 5875.706214689334, 6198.442140207313, 6244.37556244381, 6294.464970477469, 6341.175647165839, 6343.0, 6121.7578389577775, 6152.3540028297275, 6161.045038019114, 6179.0, 6179.62922224668, 6292.685365731695, 6315.873682526324, 6316.747330106836, 6318.526110541728, 6324.557280990287, 6112.449879510866, 6151.323354431009, 6154.169187159766, 6243.531735119794, 6274.6548939808745, 6274.529410294246, 6291.937080629226, 6300.180976473121, 6320.020396838498, 6326.335734747877, 4949.876253093629, 4951.702897826142, 4966.776495057731, 4974.701517908937, 4988.625853061035, 4362.956370436255, 4386.956130438719, 4394.736315821061, 4399.274119770202, 4464.687471877002, 5837.0, 5876.177335173079, 5903.822885313448, 5936.436038576328, 5946.910796337972, 6257.2491301044165, 6310.242770867525, 6323.588966717149, 6332.176817013758, 6353.269374021954, 4616.838410655611, 5780.942190578125, 5855.970720146372, 5873.324567674772, 5915.704214789243, 5362.27609272751, 5387.353517577837, 5412.83761487156, 5423.29497165366, 5461.290032295856, 6334.271558770616, 6351.396617321532, 6353.936460635427, 6360.363963603695, 6367.586106903036, 6276.592021518587, 6310.905336420049, 6329.651869147241, 6338.841528961812, 6383.425491705769, 6220.564560480723, 6240.344763799736, 6268.529860260407, 6305.905411418924, 6337.461315788025, 6210.4100110489435, 6218.502519798315, 6246.125542424155, 6248.343923887926, 6267.4986001120715, 6321.5258855586935, 6321.652309123042, 6325.0, 6334.208223972004, 6334.904976425265, 5998.790042348497, 6030.0, 6064.636121832704, 6135.662538560422, 6148.723307451265, 6101.206843110367, 6112.633242005494, 6150.2927163375, 6196.318404975359, 6200.286966998672, 5575.944240557705, 5990.0, 5998.9100163496705, 6001.459868611846, 6006.489448396936, 5905.586608937505, 6071.544634152545, 6111.602745821508, 6149.893019256577, 6150.753969841336, 5804.1874137619925, 5806.796762113306, 5841.795537156179, 5843.707814609337, 5942.1978032965], "value": 5742.461483836081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.64466327922435, 518.9377274727032, 520.232656831174, 523.2674256041543, 534.988871033746, 25444.0, 40885.59114408855, 42125.0, 42270.0, 45067.0, 43259.78370108145, 43336.34995475062, 43490.34764478535, 43543.78228108855, 43663.78168109155, 9913.553890074927, 10099.848502272473, 10114.291999560033, 10114.544845481934, 10131.341462804894, 9001.279897608176, 9194.448333100036, 12217.877821221808, 12459.750804983894, 12492.93753531231, 12399.442025108847, 12460.252384856893, 12463.501459941592, 12473.812892806614, 12504.437300321462, 8964.14840590143, 12375.0, 12440.875591244063, 12444.315562644051, 12456.19034762742, 8905.777355566099, 9981.351212171186, 12308.0, 12326.445309961073, 12492.81260781089, 39800.80099599483, 40068.79965600153, 40128.79935600303, 40258.39612405816, 40369.192616147804, 3307.255867429833, 3308.8676452942095, 3375.1393394684196, 3395.2869897321593, 3424.229548351626, 29960.8501957491, 30877.536836947238, 31688.683113168805, 31731.73073077074, 32039.83980080108, 3144.6540880503126, 3238.5304130900886, 3258.266889949766, 3339.482380231068, 3383.4924761285756, 374946.0, 375540.0, 375547.0, 376016.0, 376733.0, 33256.99999999951, 33897.66102338994, 56906.0, 57370.426295736506, 57567.712161438925, 35211.29577408489, 35441.64558354435, 35519.0, 35527.93416197466, 35544.111397215274, 15236.771448428282, 15382.3077961492, 15387.230468496266, 15389.230538473255, 15400.691986160215, 11665.708357291136, 11988.920997110128, 12964.157329773723, 13094.672633184247, 13099.869001309866, 7609.505382150142, 7846.372290216769, 7862.213778622092, 7880.172581878935, 7913.248241417056, 2839.205022593677, 3220.8228547430117, 3263.4125857345907, 3289.2434740009453, 3293.5883014623173, 845.0927227027066, 935.7473482159779, 943.0, 1027.1525991057408, 1119.9440027998567, 29378.412431751247, 29390.412191756044, 29489.705102948697, 29962.55056174159, 30085.548716769266, 932.6782260120248, 1051.779126383468, 1071.7481391872905, 1085.365061439067, 1165.8950694437542, 14549.563513094625, 14954.850451495346, 15074.849251507563, 15346.232688365537, 15362.308696108701, 708264.0, 716181.4190929116, 716664.0, 718005.0, 719279.0, 48702.512974869795, 58132.8373432529, 58652.7067364669, 58686.11970820441, 58712.706436467546, 1136.3466007045981, 1208.1422190245025, 1242.3850194153952, 1357.6402253403053, 1357.7623915814693, 29485.0, 29926.551101733057, 30163.547546786376, 30387.117001000686, 30710.846445767627, 48508.0, 49100.50899490959, 49145.26282105843, 49250.75374623104, 49331.76670583264, 559197.0, 559331.0, 563550.0, 563867.0, 699247.0, 40029.59970400259, 40132.79933600313, 40856.79571602123, 40957.795211024946, 41082.383764242964, 44757.77621111873, 44785.776071119435, 44792.77603611961, 44908.307276261614, 45267.32099018452, 34001.31997360088, 36592.81703591465, 36940.0, 37428.2514349706, 37776.866693999225, 37119.07202319964, 37250.44124338083, 37584.62415375921, 37662.623373767005, 38110.61889381071, 34511.0, 35734.64265357313, 35798.4630230552, 38414.54269115793, 39154.80422597869, 30547.54178687277, 31197.376052479278, 35042.474362885085, 35067.0, 35469.64530354663, 21112.277019937163, 25832.612510811978, 25850.741492585585, 26116.8694156528, 26201.606975894996], "value": 18993.103574770204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.43505044504457, 372.8583138407405, 377.93952967525195, 381.2946049807856, 408.7322803563667, 15087.471938482142, 15125.394984200633, 17051.914740426295, 20187.697184542245, 20730.983209839567, 19392.806071939278, 19677.212911483522, 19971.900140499278, 20180.798192018075, 21000.36998890032, 1685.039527469343, 1685.8904171228892, 1687.426275066477, 1688.004077594219, 1909.5035290824417, 3599.982000089996, 4437.4009508716235, 4496.7301961882395, 6118.357572454895, 6208.875822483547, 6907.516473846833, 6909.792706218822, 7005.894911576331, 7011.193712723051, 7022.648867556627, 6691.665416729144, 6839.350261725178, 6914.135733033371, 6932.688029038705, 7011.89482157768, 5800.361960184377, 6043.1841701370195, 6070.150178974903, 6076.0, 6078.45293923549, 23787.76212237873, 26159.215223543324, 26219.475610487683, 26511.867440662867, 26555.601665975028, 2165.6101901657694, 2239.3729755668437, 2294.0823670531754, 2924.4297362014418, 2951.911442656702, 10268.0, 10397.220208484317, 12577.434015469325, 14819.555413337617, 16035.19824008795, 1849.5653521422455, 1857.6563335782923, 1903.4955736729778, 1905.361703829205, 1940.9514762130918, 109059.45470272677, 115806.42096789546, 117459.0, 123101.38449307786, 123671.0, 9036.728898133066, 11290.491927863266, 11582.71043223926, 11652.242604230698, 11714.711381748, 14666.926665366818, 14668.926655366655, 14674.413023479156, 14690.0, 14739.0, 8469.915300847037, 8685.348598855111, 8718.128187181232, 8795.868061979076, 8821.823563528693, 8725.345599080094, 8735.388522803343, 8735.825283494294, 8902.821943561092, 8913.37606367548, 4459.353393757887, 4534.727916325031, 4536.206163921301, 4588.839390621379, 4642.2340313847835, 1884.9821096607952, 1924.4803902946126, 1933.4682962185511, 1938.5928954919625, 1942.9902850485657, 836.2056046755606, 873.9737807865774, 878.2183856367838, 900.5452246615417, 961.2262128986233, 18672.78626889248, 19770.60458790816, 20067.096980635906, 20688.17247310091, 21126.049327780285, 923.8152369526122, 928.2110206324705, 932.9766755831023, 949.6533765175661, 966.6375109334, 10355.741106472398, 11154.274972126786, 11183.105351571854, 11187.440627968732, 11252.49363778632, 608963.0, 615168.0, 624609.0, 625778.0, 627026.0, 97691.0, 107108.46445767721, 112602.0, 118474.81525184811, 129787.35106324407, 926.8795056642593, 998.7752755629925, 1009.7122320138872, 1015.4465816130227, 1017.2167431078028, 18681.43955681332, 19590.02049897528, 19606.509837254183, 19738.0, 19795.30716424918, 55899.16151257816, 55978.72010639921, 57782.7110864443, 57887.710561446926, 58456.4154358468, 73397.6330118346, 80221.0, 81845.59077204576, 82182.76725849237, 83282.16717832744, 7693.5383876965325, 7966.840663186588, 7975.162607926316, 7978.800529986796, 8313.210245026712, 8809.080297046814, 12047.156699030984, 12276.754464910831, 12496.812547811609, 12725.0, 10716.89283107159, 10848.240623156304, 11085.612003579836, 11093.112550996062, 11193.328400296008, 9221.953890230507, 10614.469276536296, 10754.300970436896, 11068.225224234226, 11089.5564177432, 10240.590376384862, 10269.486525673537, 10643.787124257626, 10773.407462589634, 11447.656570302905, 7834.451588388986, 7875.251851074138, 7887.369010479033, 8118.837623247384, 8285.922830032297, 8072.838543228985, 10023.899761002296, 10455.11131553796, 10896.836547451952, 11086.501107450023], "value": 9298.544655865762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.7909210257021, 1533.1184568872898, 1680.55465301695, 1799.4691565988032, 1876.493346796365, 8086.878696819553, 8333.624986875606, 8567.18611731886, 9137.725868223955, 9151.267898568107, 8198.262156405923, 8645.69740059098, 8896.0, 8897.199252067312, 9020.143086406797, 2063.9277625283116, 2383.928482145534, 2428.4778772563895, 2430.5538204768136, 2437.9882348825217, 2134.647783115784, 2215.3353993801875, 2392.928212153638, 2420.7942324902406, 2446.804255659552, 2350.2831636350907, 2420.1287536486852, 2431.659567660529, 2440.4143005678598, 2442.7190873049562, 2423.09134074722, 2437.890294936732, 2449.9387515312083, 2450.5221481810963, 2450.571150048734, 2423.4183795889035, 2434.0750514804263, 2444.0, 2446.0582675669993, 2459.446624509489, 8953.686620968236, 9166.954165229197, 9175.678851240242, 9175.908240917572, 9219.585118669609, 5278.630495865291, 5451.291332126838, 5454.53636440903, 5463.098588732854, 5479.808206712746, 3067.8312692801887, 3427.365937301582, 3531.2054787672823, 3577.266660334651, 3603.94594081089, 1063.0698975846929, 1093.9398333091676, 1126.222906194723, 1127.0307535519446, 1133.6485689436302, 10887.891121088767, 11988.220765650205, 12015.519379224821, 12032.0, 12035.93982030093, 4686.691592069429, 4766.118268120409, 4780.641451891052, 4867.951320486821, 4901.411830580353, 10197.541110650038, 10207.489625518694, 10217.74455638615, 10230.335028223142, 10273.229507786797, 5404.972975135178, 5408.432114627986, 5413.621046526705, 5413.729313534308, 5423.701696406657, 4085.816138273785, 4769.856904292877, 4899.755012249373, 4940.950590494049, 4943.530364615356, 3838.6353296436796, 3841.4429907663234, 3879.8254078566533, 3897.941530877039, 3935.92128157441, 1119.5969450997634, 1129.6215767717742, 1131.140333346646, 1181.757739663367, 1198.167273744739, 759.2521366454039, 879.3756432932562, 885.831691978522, 927.4898805656861, 934.621478301289, 5723.685197314105, 5746.2529871116485, 5817.563682723812, 5859.765609375577, 5896.285340235624, 476.4520801078718, 486.4405933176875, 490.94845041270867, 491.1772780592493, 524.7743470307804, 3908.2769687607883, 3944.15200731844, 3961.603839616073, 3992.321305378093, 4033.7983100845427, 10668.199885008655, 11062.280951738112, 11184.217104802749, 11190.888091119148, 11204.15968802343, 9411.764705882271, 11093.83359249612, 11128.221024528368, 11137.498812553455, 11160.720981975515, 6723.899141512881, 8291.792705182297, 8390.370722195737, 8397.748067557983, 8400.957995209985, 6006.639601623917, 6049.576529642883, 6092.786752463642, 6126.264848218242, 6135.325114237341, 9870.407775533491, 10080.69757907264, 10342.0, 10387.896121038693, 10403.687889363331, 10201.234907382124, 10503.527341269813, 10600.946995264974, 10671.413072281099, 10671.57313707443, 7363.521371110861, 7583.810404739926, 7695.384369250559, 7799.220077992382, 7806.0632724073475, 8263.132371100948, 8358.122397148456, 8399.370047246359, 8422.073571907207, 8422.284105851071, 7598.734044308423, 7647.770566883002, 7682.462227644011, 7702.152763196156, 7772.222777722409, 6448.806535803933, 7458.47790654649, 7461.4403919705155, 7484.550926944401, 7505.174430812497, 7016.508844381048, 7156.534825236343, 7159.498835081495, 7159.64201789898, 7159.856802863809, 4293.551248568995, 4941.258811178208, 5085.821996230115, 5088.363954505687, 5094.872628184325, 4984.40187177541, 5049.671771334852, 5066.518680725325, 5116.232565115262, 5132.281480592795], "value": 4550.050594159746, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.08468340926987, 304.92224482756893, 310.0821568158251, 314.613025978047, 317.8077263255729, 4110.1163249901265, 4476.910461790766, 5330.253764472977, 5347.866303342418, 5405.216243644669, 4300.956990430095, 4479.118770116551, 4873.758071287212, 5197.974010129953, 5204.32343795307, 3890.8054597270093, 4074.246264441088, 4095.7438836125352, 4110.732802367851, 4124.752514849104, 4080.8163632636456, 4104.322786740185, 4107.322291821846, 4114.362273847543, 4116.650084742801, 3366.663333666638, 3780.5085338905906, 4043.818028188724, 4100.384942258655, 4101.958980410188, 3986.8670261410007, 4012.137390461065, 4013.9397909031386, 4025.7181997260204, 4060.736052156615, 2939.3827296267596, 3008.699130086996, 3450.5341778859784, 3477.5826900771817, 3494.860205591773, 4309.525952145262, 4782.210935195689, 4840.927386089212, 5201.439568129584, 5252.65857719247, 4164.729292595972, 4318.935215971763, 4608.009278005245, 4618.191816432144, 4625.629949604024, 4942.579880710144, 5231.2937753403185, 5560.749766260528, 5595.356533998602, 5617.522510586564, 3254.934901301984, 3831.272058308912, 3841.2317536492815, 3844.1735026969054, 3865.9806700966597, 5156.432792392834, 5550.69471179085, 5776.595638305363, 5884.470397664188, 5925.407459254083, 3124.5781819454537, 3590.551181102362, 3899.083715326896, 3908.394198899175, 3910.3156947534635, 3182.6499085100622, 3569.803660798629, 3983.9203215935518, 3991.2815693174925, 3993.381025940984, 3851.5955824638568, 4488.775561221991, 4578.839740609063, 4657.278121891045, 4675.929861052087, 5149.665271757323, 5485.17722341644, 5721.256236689287, 5721.742521586539, 5794.739236734357, 1274.4902039184215, 1311.0, 1344.5831792144465, 1352.5198554513204, 1360.340234986031, 820.9466384684977, 843.9873401898976, 869.2046777198918, 885.1414128295543, 910.3036177324352, 5308.089087928342, 5344.904294619671, 5357.464253574612, 5416.647917885325, 5457.454254574511, 5215.452377500384, 5370.70461124634, 5527.922055199278, 5782.45066718661, 5834.7989447597665, 3817.1172293509408, 5321.866953326198, 5321.9622173676535, 5340.626156169031, 5368.9731551342775, 2575.433404650974, 2973.5391014392803, 3036.498977668704, 3039.0, 3055.6486004109365, 5065.848024559269, 5246.291750613695, 5757.251557297524, 5927.695906900475, 5991.741734235859, 4577.977110114428, 5133.922991155136, 5840.8247752567495, 5869.442402971711, 5897.49871260939, 5775.797847075416, 5899.144624029492, 5900.170947006442, 5930.673812940329, 5990.34106248321, 4889.779959901742, 5121.820736274212, 5712.771489140554, 5807.593468457337, 5855.36049906027, 5013.674111182761, 5176.792928282977, 5656.935218645082, 5682.289713785777, 5705.572082093942, 5341.931613677358, 5489.612018771847, 5726.656400615976, 5964.7912323068485, 5988.353202869246, 3225.4677978133345, 3326.650701676289, 3474.114100904253, 3787.9204426738247, 3879.767213967171, 5465.617406781487, 5732.885342293047, 5794.18881356602, 5830.82507524775, 5856.765729370948, 5317.920231196613, 5652.576056795675, 5670.752434464412, 5670.886582268249, 5681.176229446624, 5688.829335119953, 5727.6849773262875, 5731.0, 5741.62679425836, 5777.480026797609, 4672.252439609646, 5506.449355064622, 5589.888202236014, 5633.887322253614, 5639.88720225585, 4884.316195732671, 5181.689098654093, 5372.570194384518, 5591.30108736408, 5745.425457454221, 4901.50984901507, 5592.427483357538, 5602.887942241051, 5609.289166804164, 5611.607187496836], "value": 4066.4654428791855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8850078237873, 789.8775689768084, 793.9206079392058, 795.5505139596131, 795.705588932095, 14850.77723834142, 15793.210339483037, 15794.684106317867, 15873.523794286175, 16054.67890642188, 11780.882191178085, 14402.783958240634, 14820.925895370536, 15088.622784430394, 15117.244137793094, 843.9451435656678, 857.4812238595654, 858.9871151932726, 859.8065435277075, 859.9484030958163, 684.8732984397902, 708.922018577956, 847.6355167278068, 881.8633111867639, 884.7788052986754, 922.4741897118645, 922.7600823785797, 923.8429466990594, 924.2652091587204, 928.2202949522433, 915.6474757218485, 918.7886786039215, 922.5433410461798, 923.5428462910869, 923.7413524213231, 529.9496547827989, 548.7064420535035, 663.3200969006758, 678.9781379024586, 679.1748026148205, 15203.239838008056, 15267.541973740805, 15273.465428710053, 15282.235888205656, 15295.770563441558, 13461.865381346159, 13724.176549406968, 13853.792193117111, 13990.16059036461, 14117.576472705836, 12278.693032674166, 12541.93729031349, 12599.37003149848, 12793.552225672056, 12901.548445804445, 4529.614982726473, 4593.311003349491, 4621.930671039937, 4640.930386044212, 4761.119192949315, 118381.0, 119601.73683142116, 122096.99999999911, 122573.77426225712, 124385.0, 10995.615153469751, 11075.058620017227, 11090.833637495443, 11099.83350249747, 11107.166962477846, 21642.917854107232, 21752.782472175393, 21812.672809907865, 21821.127154913625, 21830.345089647337, 7602.847943041108, 7681.923180768233, 7786.4938778979185, 8010.319122874621, 8018.198180181935, 3994.9201015979515, 4334.891627709332, 4363.4763828340165, 4391.275439552502, 4518.457785065813, 3411.7441191910707, 3539.7168226541817, 3543.787372757643, 3551.378508761008, 3557.2351944332095, 639.587466084373, 653.3433898931544, 662.8773676869795, 667.7095463473405, 670.2359310386164, 566.7392999220323, 616.636184651058, 625.4746013348808, 637.1875858280729, 650.40487953522, 7554.8866766998535, 8800.668783153054, 9161.076174003401, 9185.540722963826, 9275.0, 624.3444383397415, 626.5175814622806, 639.159505250594, 652.6182183422751, 664.1863716946798, 4168.6665066794585, 4449.243628583084, 4454.487733910577, 4457.197704413172, 4519.118771839526, 101888.0, 108951.45524272328, 139687.0, 170838.0, 177152.114239428, 120089.19643214348, 125091.0, 127425.72574274139, 133608.66391336155, 134162.98755518676, 73049.2695073053, 74701.6264918672, 78975.0, 125120.0, 128101.0, 8446.66213351459, 8603.225709686158, 8841.336899732674, 8845.071267517076, 9123.635054597742, 45463.77268113638, 47652.285215722484, 60469.79060418679, 61850.0, 63827.40431489064, 74950.0, 91500.54249728708, 94563.05436945817, 95383.0, 99352.50323748335, 11587.710307242049, 13162.341882905625, 13197.868021320048, 13238.139520931494, 13466.259355735529, 14641.0, 14875.330610122786, 14897.553073407815, 15072.171030593423, 15079.321430535432, 11264.718382040515, 13330.86669133335, 13788.724225515634, 13886.93056534711, 14373.7843932339, 13083.448727498046, 13615.727685446038, 13689.31553422305, 14066.718665626835, 14087.929560352133, 13706.588802335946, 13758.31208439554, 13818.170909745448, 13825.51610693621, 13852.238126903118, 10896.400697961688, 11270.211085223955, 11350.375729334966, 11740.941295293469, 11874.703132421759, 10372.948135259276, 11506.137039721887, 11606.883931160917, 11668.649940501798, 11740.236884602473], "value": 7807.640788182589, "unit": "score"}], "name": "dromaeo_css", "value": 7260.798543817334, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 112.0, 115.0, 115.0, 113.0, 114.0, 114.0, 112.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 109.0, 143.0, 107.0, 110.0, 109.0, 109.0, 137.0, 107.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 181.0, 188.0, 258.0, 219.0, 182.0, 183.0, 183.0, 181.0], "value": 194.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 88.0, 62.0, 60.0, 74.0, 49.0, 83.0, 96.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 94.0, 70.0, 67.0, 70.0, 91.0, 68.0, 69.0, 89.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 95.0, 84.0, 86.0, 83.0, 91.0, 85.0, 91.0, 84.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 94.0, 93.0, 93.0, 98.0, 94.0, 91.0, 131.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 83.0, 83.0, 85.0, 89.0, 79.0, 93.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 55.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 66.0, 77.0, 74.0, 70.0, 71.0, 71.0, 71.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 82.0, 82.0, 82.0, 82.0, 81.0, 81.0, 82.0, 85.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 152.0, 139.0, 138.0, 135.0, 136.0, 141.0, 141.0, 167.0, 141.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 205.0, 222.0, 162.0, 164.0, 164.0, 165.0, 163.0, 163.0, 164.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 67.0, 66.0, 65.0, 63.0, 64.0, 65.0, 66.0, 65.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1435.5, "alertThreshold": 2.0}]} 07:15:48 INFO - Return code: 0 07:15:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:48 INFO - # TBPL SUCCESS # 07:15:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:48 INFO - 2016-11-14 07:15:48.895 screenresolution[1669:9973] starting screenresolution argv=screenresolution get 07:15:48 INFO - 2016-11-14 07:15:48.898 screenresolution[1669:9973] Display 0: 1600x1200x32@60 07:15:48 INFO - 2016-11-14 07:15:48.904 screenresolution[1670:9976] starting screenresolution argv=screenresolution list 07:15:48 INFO - Available Modes on Display 0 07:15:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:49 INFO - Intel Iris: 07:15:49 INFO - Chipset Model: Intel Iris 07:15:49 INFO - Type: GPU 07:15:49 INFO - Bus: Built-In 07:15:49 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:49 INFO - Vendor: Intel (0x8086) 07:15:49 INFO - Device ID: 0x0a2e 07:15:49 INFO - Revision ID: 0x0009 07:15:49 INFO - Displays: 07:15:49 INFO - Display: 07:15:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:49 INFO - Display Serial Number: 1600x1200 60 07:15:49 INFO - Main Display: Yes 07:15:49 INFO - Mirror: Off 07:15:49 INFO - Online: Yes 07:15:49 INFO - Rotation: Supported 07:15:49 INFO - Return code: 0 07:15:49 INFO - Running post-action listener: _resource_record_post_action 07:15:49 INFO - [mozharness: 2016-11-14 15:15:49.138268Z] Finished run-tests step (success) 07:15:49 INFO - Running post-run listener: _resource_record_post_run 07:15:49 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 32082944; Write bytes: 663505408; Read time: 198; Write time: 1903 07:15:49 INFO - TinderboxPrint: CPU usage
53.4% 07:15:49 INFO - TinderboxPrint: I/O read bytes / time
32,082,944 / 198 07:15:49 INFO - TinderboxPrint: I/O write bytes / time
663,505,408 / 1,903 07:15:49 INFO - TinderboxPrint: CPU idle
2,258.1 (46.6%) 07:15:49 INFO - TinderboxPrint: CPU system
968.4 (20.0%) 07:15:49 INFO - TinderboxPrint: CPU user
1,615.2 (33.4%) 07:15:49 INFO - TinderboxPrint: Swap in / out
391,815,168 / 0 07:15:49 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356805120; Write bytes: 356624384; Read time: 27466; Write time: 768 07:15:49 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30321664; Write bytes: 295883264; Read time: 183; Write time: 1099 07:15:49 INFO - Running post-run listener: _upload_blobber_files 07:15:49 INFO - Blob upload gear active. 07:15:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:49 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 07:15:49 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:15:49 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:15:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:51 INFO - (blobuploader) - INFO - Done attempting. 07:15:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:52 INFO - (blobuploader) - INFO - Done attempting. 07:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:54 INFO - (blobuploader) - INFO - Done attempting. 07:15:54 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:54 INFO - Return code: 0 07:15:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62023ba2e8200ae51d65abad9e5a415ce11707f2680e47262ab8ba265a788db45100c9c9932172e26fa83c02c5bbac9e44291c1a95f11cb2106e7c14f0d8393f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f941e9e79b111fd380a78034b36a0803ac505c3024862f1297b49ec22adb84f52d0ee2bc0d68f074e9a3413b8f928b1366e3a31d302819a9a60c9f57dfb408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4030fbd90d5b15e64712e65bdd95927893576619fbc94b1f8ea45d107bac0f9673c75ba2f3e85ef61939d5548dc5f10e4c2363f83745215f28ba3d32014f89c2"} 07:15:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:54 INFO - Contents: 07:15:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62023ba2e8200ae51d65abad9e5a415ce11707f2680e47262ab8ba265a788db45100c9c9932172e26fa83c02c5bbac9e44291c1a95f11cb2106e7c14f0d8393f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f941e9e79b111fd380a78034b36a0803ac505c3024862f1297b49ec22adb84f52d0ee2bc0d68f074e9a3413b8f928b1366e3a31d302819a9a60c9f57dfb408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4030fbd90d5b15e64712e65bdd95927893576619fbc94b1f8ea45d107bac0f9673c75ba2f3e85ef61939d5548dc5f10e4c2363f83745215f28ba3d32014f89c2"} 07:15:54 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:54 INFO - Copying logs to upload dir... 07:15:54 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.363288 ========= master_lag: 2.75 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-14 07:15:57.253536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-11-14 07:15:57.257897) ========= 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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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/Mozilla-Aurora/sha512/62023ba2e8200ae51d65abad9e5a415ce11707f2680e47262ab8ba265a788db45100c9c9932172e26fa83c02c5bbac9e44291c1a95f11cb2106e7c14f0d8393f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f941e9e79b111fd380a78034b36a0803ac505c3024862f1297b49ec22adb84f52d0ee2bc0d68f074e9a3413b8f928b1366e3a31d302819a9a60c9f57dfb408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4030fbd90d5b15e64712e65bdd95927893576619fbc94b1f8ea45d107bac0f9673c75ba2f3e85ef61939d5548dc5f10e4c2363f83745215f28ba3d32014f89c2"} build_url:https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010701 build_url: 'https://queue.taskcluster.net/v1/task/bTey_UX3RsOMHmH55_KCsg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62023ba2e8200ae51d65abad9e5a415ce11707f2680e47262ab8ba265a788db45100c9c9932172e26fa83c02c5bbac9e44291c1a95f11cb2106e7c14f0d8393f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/94f941e9e79b111fd380a78034b36a0803ac505c3024862f1297b49ec22adb84f52d0ee2bc0d68f074e9a3413b8f928b1366e3a31d302819a9a60c9f57dfb408", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4030fbd90d5b15e64712e65bdd95927893576619fbc94b1f8ea45d107bac0f9673c75ba2f3e85ef61939d5548dc5f10e4c2363f83745215f28ba3d32014f89c2"}' ========= master_lag: 4.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 4 secs) (at 2016-11-14 07:16:01.420567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:16:01.420900) ========= 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.8EsnCc1rFQ/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.ef2HieQgh6/Listeners TMPDIR=/var/folders/sk/y86qdwzs1q5_clfw5d0041sc00000w/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.005468 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:16:01.517283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:16:01.517573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:16:01.517846) ========= ========= Total master_lag: 7.07 =========