builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1485193409.53 results: success (0) buildid: 20170123080355 builduid: f903847fcc944708b363bf3e38e30cc6 revision: dca7b42e6c67219398e6419293c075ef829adb29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.528878) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.529352) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.529655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.555804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.556075) ========= 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.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-23 09:43:29-- 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% 21.1M=0.001s 2017-01-23 09:43:29 (21.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.722262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.722586) ========= 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.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.025477 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:29.770952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 09:43:29.771277) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev dca7b42e6c67219398e6419293c075ef829adb29 --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 dca7b42e6c67219398e6419293c075ef829adb29 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-23 09:43:29,866 truncating revision to first 12 chars 2017-01-23 09:43:29,866 Setting DEBUG logging. 2017-01-23 09:43:29,867 attempt 1/10 2017-01-23 09:43:29,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/dca7b42e6c67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 09:43:30,867 unpacking tar archive at: mozilla-aurora-dca7b42e6c67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.266748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 09:43:31.062239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:31.062544) ========= script_repo_revision: dca7b42e6c67219398e6419293c075ef829adb29 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:31.062919) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:31.063191) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 09:43:31.082850) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-23 09:43:31.083446) ========= /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.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:43:31 INFO - MultiFileLogger online at 20170123 09:43:31 in /builds/slave/test 09:43:31 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 09:43:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:43:31 INFO - {'append_to_log': False, 09:43:31 INFO - 'base_work_dir': '/builds/slave/test', 09:43:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:43:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:43:31 INFO - 'branch': 'Mozilla-Aurora', 09:43:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:31 INFO - 'config_files': ('talos/mac_config.py',), 09:43:31 INFO - 'default_actions': ('clobber', 09:43:31 INFO - 'read-buildbot-config', 09:43:31 INFO - 'download-and-extract', 09:43:31 INFO - 'populate-webroot', 09:43:31 INFO - 'create-virtualenv', 09:43:31 INFO - 'install', 09:43:31 INFO - 'run-tests'), 09:43:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:31 INFO - 'download_minidump_stackwalk': True, 09:43:31 INFO - 'download_symbols': 'ondemand', 09:43:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:31 INFO - 'installer_path': 'installer.exe', 09:43:31 INFO - 'log_level': 'info', 09:43:31 INFO - 'log_name': 'talos', 09:43:31 INFO - 'log_to_console': True, 09:43:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:43:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:43:31 INFO - 'opt_config_files': (), 09:43:31 INFO - 'pip_index': False, 09:43:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:31 INFO - 'cmd': ('bash', 09:43:31 INFO - '-c', 09:43:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:31 INFO - 'enabled': True, 09:43:31 INFO - 'halt_on_failure': False, 09:43:31 INFO - 'name': 'check_screen_resolution'},), 09:43:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:43:31 INFO - 'cmd': ('bash', 09:43:31 INFO - '-c', 09:43:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:43:31 INFO - 'enabled': True, 09:43:31 INFO - 'halt_on_failure': False, 09:43:31 INFO - 'name': 'check_screen_resolution'},), 09:43:31 INFO - 'run_cmd_checks_enabled': True, 09:43:31 INFO - 'sps_profile': False, 09:43:31 INFO - 'sps_profile_interval': 0, 09:43:31 INFO - 'suite': 'dromaeojs', 09:43:31 INFO - 'system_bits': '32', 09:43:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:31 INFO - 'title': 't-yosemite-r7-0345', 09:43:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:31 INFO - 'use_talos_json': True, 09:43:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:43:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:31 INFO - 'work_dir': 'build'} 09:43:31 INFO - [mozharness: 2017-01-23 17:43:31.286281Z] Running clobber step. 09:43:31 INFO - Running pre-action listener: _resource_record_pre_action 09:43:31 INFO - Running main action method: clobber 09:43:31 INFO - rmtree: /builds/slave/test/build 09:43:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:43:33 INFO - Running post-action listener: _resource_record_post_action 09:43:33 INFO - [mozharness: 2017-01-23 17:43:33.707401Z] Finished clobber step (success) 09:43:33 INFO - [mozharness: 2017-01-23 17:43:33.707544Z] Running read-buildbot-config step. 09:43:33 INFO - Running pre-action listener: _resource_record_pre_action 09:43:33 INFO - Running main action method: read_buildbot_config 09:43:33 INFO - Using buildbot properties: 09:43:33 INFO - { 09:43:33 INFO - "project": "", 09:43:33 INFO - "product": "firefox", 09:43:33 INFO - "script_repo_revision": "production", 09:43:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:43:33 INFO - "repository": "", 09:43:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:43:33 INFO - "buildid": "20170123080355", 09:43:33 INFO - "stage_platform": "macosx64", 09:43:33 INFO - "basedir": "/builds/slave/test", 09:43:33 INFO - "nightly_build": "True", 09:43:33 INFO - "buildnumber": 39, 09:43:33 INFO - "slavename": "t-yosemite-r7-0345", 09:43:33 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:43:33 INFO - "platform": "yosemite_r7", 09:43:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:43:33 INFO - "branch": "mozilla-aurora", 09:43:33 INFO - "repo_path": "releases/mozilla-aurora", 09:43:33 INFO - "revision": "dca7b42e6c67219398e6419293c075ef829adb29", 09:43:33 INFO - "pgo_build": "False", 09:43:33 INFO - "builduid": "f903847fcc944708b363bf3e38e30cc6", 09:43:33 INFO - "slavebuilddir": "test" 09:43:33 INFO - } 09:43:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:43:33 INFO - Running post-action listener: _resource_record_post_action 09:43:33 INFO - [mozharness: 2017-01-23 17:43:33.711234Z] Finished read-buildbot-config step (success) 09:43:33 INFO - [mozharness: 2017-01-23 17:43:33.711376Z] Running download-and-extract step. 09:43:33 INFO - Running pre-action listener: _resource_record_pre_action 09:43:33 INFO - Running main action method: download_and_extract 09:43:33 INFO - mkdir: /builds/slave/test/build/tests 09:43:33 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')]} 09:43:33 INFO - trying https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:43:33 INFO - Downloading https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:43:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:43:35 INFO - Downloaded 1199 bytes. 09:43:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:43:35 INFO - Using the following test package requirements: 09:43:35 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:43:35 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:43:35 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:43:35 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'jsshell-mac.zip'], 09:43:35 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:43:35 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:43:35 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:43:35 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:43:35 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:43:35 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:43:35 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:43:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:43:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:43:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:43:35 INFO - Fetch https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:43:35 INFO - Expected file size: 16349583 09:43:35 INFO - Obtained file size: 16349583 09:43:42 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:43:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:43:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:43:42 INFO - Fetch https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:43:43 INFO - Expected file size: 16349583 09:43:43 INFO - Obtained file size: 16349583 09:43:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:43:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:43:49 INFO - Fetch https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:43:50 INFO - Expected file size: 14403485 09:43:50 INFO - Obtained file size: 14403485 09:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:51 INFO - trying https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:43:51 INFO - Downloading https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:43:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:43:53 INFO - Downloaded 73914865 bytes. 09:43:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:43:53 INFO - mkdir: /builds/slave/test/properties 09:43:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:43:53 INFO - Writing to file /builds/slave/test/properties/build_url 09:43:53 INFO - Contents: 09:43:53 INFO - build_url:https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:43:53 INFO - Running post-action listener: _resource_record_post_action 09:43:53 INFO - Running post-action listener: set_extra_try_arguments 09:43:53 INFO - [mozharness: 2017-01-23 17:43:53.977805Z] Finished download-and-extract step (success) 09:43:53 INFO - [mozharness: 2017-01-23 17:43:53.977917Z] Running populate-webroot step. 09:43:53 INFO - Running pre-action listener: _resource_record_pre_action 09:43:53 INFO - Running main action method: populate_webroot 09:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:53 INFO - '--tppagecycles', 09:43:53 INFO - '7'], 09:43:53 INFO - 'tests': ['tsvgm']}}, 09:43:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:43:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:43:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:43:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['damp', 'tps']}, 09:43:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'tests': ['damp', 'tps']}, 09:43:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['dromaeo_dom']}, 09:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['basic_compositor_video']}, 09:43:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:43:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'other-e10s': {'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['a11yr', 09:43:53 INFO - 'ts_paint', 09:43:53 INFO - 'tpaint', 09:43:53 INFO - 'sessionrestore', 09:43:53 INFO - 'sessionrestore_no_auto_restore', 09:43:53 INFO - 'tabpaint']}, 09:43:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['tsvgx', 09:43:53 INFO - 'tsvgr_opacity', 09:43:53 INFO - 'tart', 09:43:53 INFO - 'tscrollx', 09:43:53 INFO - 'cart', 09:43:53 INFO - 'tsvg_static']}, 09:43:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:43:53 INFO - 'tsvgr_opacity', 09:43:53 INFO - 'tart', 09:43:53 INFO - 'tscrollx', 09:43:53 INFO - 'cart', 09:43:53 INFO - 'tsvg_static']}, 09:43:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'talos_options': ['--disable-e10s'], 09:43:53 INFO - 'tests': ['tp5o']}, 09:43:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:43:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'talos_options': ['--disable-e10s', 09:43:53 INFO - '--xperf_path', 09:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:53 INFO - 'tests': ['tp5n']}, 09:43:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:43:53 INFO - 'talos_options': ['--xperf_path', 09:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:53 INFO - 'tests': ['tp5n']}}, 09:43:53 INFO - 'talos.zip': {'path': '', 09:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:53 INFO - Running post-action listener: _resource_record_post_action 09:43:53 INFO - [mozharness: 2017-01-23 17:43:53.996680Z] Finished populate-webroot step (success) 09:43:53 INFO - [mozharness: 2017-01-23 17:43:53.996809Z] Running create-virtualenv step. 09:43:53 INFO - Running pre-action listener: _resource_record_pre_action 09:43:53 INFO - Running main action method: create_virtualenv 09:43:53 INFO - Creating virtualenv /builds/slave/test/build/venv 09:43:53 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 09:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:43:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:54 INFO - Using real prefix '/tools/python27' 09:43:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:43:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:57 INFO - Installing pip.................done. 09:43:57 INFO - Return code: 0 09:43:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:43:57 INFO - Reading from file tmpfile_stdout 09:43:57 INFO - Output received: 09:43:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:43:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:57 INFO - 'HOME': '/Users/cltbld', 09:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:57 INFO - 'LOGNAME': 'cltbld', 09:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:57 INFO - 'MOZ_NO_REMOTE': '1', 09:43:57 INFO - 'NO_EM_RESTART': '1', 09:43:57 INFO - 'PAGER': '/bin/cat', 09:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:57 INFO - 'PWD': '/builds/slave/test', 09:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:57 INFO - 'SHELL': '/bin/bash', 09:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:43:57 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:57 INFO - 'USER': 'cltbld', 09:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:57 INFO - 'XPC_FLAGS': '0x0', 09:43:57 INFO - 'XPC_SERVICE_NAME': '0', 09:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:58 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 09:43:58 INFO - Cleaning up... 09:43:58 INFO - Return code: 0 09:43:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:43:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:43:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:43:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:43:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:43:58 INFO - 'HOME': '/Users/cltbld', 09:43:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:43:58 INFO - 'LOGNAME': 'cltbld', 09:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:58 INFO - 'MOZ_NO_REMOTE': '1', 09:43:58 INFO - 'NO_EM_RESTART': '1', 09:43:58 INFO - 'PAGER': '/bin/cat', 09:43:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:43:58 INFO - 'PWD': '/builds/slave/test', 09:43:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:43:58 INFO - 'SHELL': '/bin/bash', 09:43:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:43:58 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:43:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:43:58 INFO - 'USER': 'cltbld', 09:43:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:43:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:58 INFO - 'XPC_FLAGS': '0x0', 09:43:58 INFO - 'XPC_SERVICE_NAME': '0', 09:43:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:43:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:58 INFO - Downloading/unpacking psutil>=3.1.1 09:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:44:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:01 INFO - Installing collected packages: psutil 09:44:01 INFO - Running setup.py install for psutil 09:44:02 INFO - building 'psutil._psutil_osx' extension 09:44:02 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 09:44:02 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 09:44:02 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 09:44:02 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 09:44:02 INFO - building 'psutil._psutil_posix' extension 09:44:02 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 09:44:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:44:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:44:02 INFO - ^ 09:44:02 INFO - 1 warning generated. 09:44:02 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 09:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:44:03 INFO - Successfully installed psutil 09:44:03 INFO - Cleaning up... 09:44:03 INFO - Return code: 0 09:44:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:44:03 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')]} 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:03 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')]} 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:03 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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:03 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 09:44:03 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 09:44:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:03 INFO - 'HOME': '/Users/cltbld', 09:44:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:03 INFO - 'LOGNAME': 'cltbld', 09:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:03 INFO - 'MOZ_NO_REMOTE': '1', 09:44:03 INFO - 'NO_EM_RESTART': '1', 09:44:03 INFO - 'PAGER': '/bin/cat', 09:44:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:03 INFO - 'PWD': '/builds/slave/test', 09:44:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:03 INFO - 'SHELL': '/bin/bash', 09:44:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:03 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:03 INFO - 'USER': 'cltbld', 09:44:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:03 INFO - 'XPC_FLAGS': '0x0', 09:44:03 INFO - 'XPC_SERVICE_NAME': '0', 09:44:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:44:06 INFO - Installing collected packages: mozsystemmonitor 09:44:06 INFO - Running setup.py install for mozsystemmonitor 09:44:06 INFO - Successfully installed mozsystemmonitor 09:44:06 INFO - Cleaning up... 09:44:06 INFO - Return code: 0 09:44:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:44:06 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')]} 09:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:06 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')]} 09:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:06 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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:06 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 09:44:06 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 09:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:06 INFO - 'HOME': '/Users/cltbld', 09:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:06 INFO - 'LOGNAME': 'cltbld', 09:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:06 INFO - 'MOZ_NO_REMOTE': '1', 09:44:06 INFO - 'NO_EM_RESTART': '1', 09:44:06 INFO - 'PAGER': '/bin/cat', 09:44:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:06 INFO - 'PWD': '/builds/slave/test', 09:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:06 INFO - 'SHELL': '/bin/bash', 09:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:06 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:06 INFO - 'USER': 'cltbld', 09:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:06 INFO - 'XPC_FLAGS': '0x0', 09:44:06 INFO - 'XPC_SERVICE_NAME': '0', 09:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:44:06 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 09:44:06 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 09:44:06 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 09:44:06 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 09:44:06 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 09:44:06 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 09:44:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:44:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:44:09 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 09:44:09 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 09:44:09 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 09:44:09 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 09:44:09 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 09:44:09 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 09:44:09 INFO - Downloading functools32-3.2.3-2.tar.gz 09:44:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:44:09 INFO - warning: no files found matching '*.txt' 09:44:09 INFO - no previously-included directories found matching 'build' 09:44:09 INFO - no previously-included directories found matching 'dist' 09:44:09 INFO - no previously-included directories found matching '.git*' 09:44:09 INFO - Installing collected packages: jsonschema, functools32 09:44:09 INFO - Running setup.py install for functools32 09:44:09 INFO - warning: no files found matching '*.txt' 09:44:09 INFO - no previously-included directories found matching 'build' 09:44:09 INFO - no previously-included directories found matching 'dist' 09:44:09 INFO - no previously-included directories found matching '.git*' 09:44:09 INFO - Successfully installed jsonschema functools32 09:44:09 INFO - Cleaning up... 09:44:10 INFO - Return code: 0 09:44:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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', '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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:44: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 functools32==3.2.3-2 09:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:10 INFO - 'HOME': '/Users/cltbld', 09:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:10 INFO - 'LOGNAME': 'cltbld', 09:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:10 INFO - 'MOZ_NO_REMOTE': '1', 09:44:10 INFO - 'NO_EM_RESTART': '1', 09:44:10 INFO - 'PAGER': '/bin/cat', 09:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:10 INFO - 'PWD': '/builds/slave/test', 09:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:10 INFO - 'SHELL': '/bin/bash', 09:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:10 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:10 INFO - 'USER': 'cltbld', 09:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:10 INFO - 'XPC_FLAGS': '0x0', 09:44:10 INFO - 'XPC_SERVICE_NAME': '0', 09:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:44:10 INFO - Cleaning up... 09:44:10 INFO - Return code: 0 09:44:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:44: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')]} 09:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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')]} 09:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44: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', '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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:44: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 blobuploader==1.2.4 09:44:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:10 INFO - 'HOME': '/Users/cltbld', 09:44:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:10 INFO - 'LOGNAME': 'cltbld', 09:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:10 INFO - 'MOZ_NO_REMOTE': '1', 09:44:10 INFO - 'NO_EM_RESTART': '1', 09:44:10 INFO - 'PAGER': '/bin/cat', 09:44:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:10 INFO - 'PWD': '/builds/slave/test', 09:44:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:10 INFO - 'SHELL': '/bin/bash', 09:44:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:10 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:10 INFO - 'USER': 'cltbld', 09:44:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:10 INFO - 'XPC_FLAGS': '0x0', 09:44:10 INFO - 'XPC_SERVICE_NAME': '0', 09:44:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:44:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:44:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:44:14 INFO - Downloading docopt-0.6.1.tar.gz 09:44:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:44:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:44:14 INFO - Running setup.py install for blobuploader 09:44:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:44:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:44:14 INFO - Running setup.py install for requests 09:44:15 INFO - Running setup.py install for docopt 09:44:15 INFO - Successfully installed blobuploader requests docopt 09:44:15 INFO - Cleaning up... 09:44:15 INFO - Return code: 0 09:44:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:15 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')]} 09:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:15 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')]} 09:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:15 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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:15 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 09:44:15 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 09:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:15 INFO - 'HOME': '/Users/cltbld', 09:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:15 INFO - 'LOGNAME': 'cltbld', 09:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:15 INFO - 'MOZ_NO_REMOTE': '1', 09:44:15 INFO - 'NO_EM_RESTART': '1', 09:44:15 INFO - 'PAGER': '/bin/cat', 09:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:15 INFO - 'PWD': '/builds/slave/test', 09:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:15 INFO - 'SHELL': '/bin/bash', 09:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:15 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:15 INFO - 'USER': 'cltbld', 09:44:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:15 INFO - 'XPC_FLAGS': '0x0', 09:44:15 INFO - 'XPC_SERVICE_NAME': '0', 09:44:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xwfYXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-qlAiUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DldmdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Re_H6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-6SE6B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-lev1qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-dWyzP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-no4TIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-8VRHHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ng5vlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-CwNi7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FUtXLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-_sM0hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:17 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-NBJaoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:17 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-p_k8iB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:17 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-s44j7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:17 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-OSPokh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:44:17 INFO - Running setup.py install for manifestparser 09:44:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:44:17 INFO - Running setup.py install for mozcrash 09:44:17 INFO - Running setup.py install for mozdebug 09:44:17 INFO - Running setup.py install for mozdevice 09:44:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozfile 09:44:18 INFO - Running setup.py install for mozhttpd 09:44:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozinfo 09:44:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozInstall 09:44:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for mozleak 09:44:18 INFO - Running setup.py install for mozlog 09:44:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:44:18 INFO - Running setup.py install for moznetwork 09:44:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Running setup.py install for mozprocess 09:44:19 INFO - Running setup.py install for mozprofile 09:44:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Running setup.py install for mozrunner 09:44:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Running setup.py install for mozscreenshot 09:44:19 INFO - Running setup.py install for moztest 09:44:19 INFO - Running setup.py install for mozversion 09:44:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:44:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:44:19 INFO - Cleaning up... 09:44:20 INFO - Return code: 0 09:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:20 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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:20 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 09:44:20 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 09:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:20 INFO - 'HOME': '/Users/cltbld', 09:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:20 INFO - 'LOGNAME': 'cltbld', 09:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:20 INFO - 'MOZ_NO_REMOTE': '1', 09:44:20 INFO - 'NO_EM_RESTART': '1', 09:44:20 INFO - 'PAGER': '/bin/cat', 09:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:20 INFO - 'PWD': '/builds/slave/test', 09:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:20 INFO - 'SHELL': '/bin/bash', 09:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:20 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:20 INFO - 'USER': 'cltbld', 09:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:20 INFO - 'XPC_FLAGS': '0x0', 09:44:20 INFO - 'XPC_SERVICE_NAME': '0', 09:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-VHh5iO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:44:20 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)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-OBaC5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FYCGHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:44:20 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)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-bnp2Cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:44:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-dLXfAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:44:20 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)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GoeYw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:44:20 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)) 09:44:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:44:20 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DrbzUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-lzpI4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9LfC6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-A3oY1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HzHXJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-RuZWCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ZfDUcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-zsDbg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-aEepis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:44:21 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)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Kn41_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:44:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:44:21 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-CNU2mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:44:22 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)) 09:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:44:22 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)) 09:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:44:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44: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 09:44:24 INFO - Downloading blessings-1.6.tar.gz 09:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:44:24 INFO - Installing collected packages: blessings 09:44:24 INFO - Running setup.py install for blessings 09:44:24 INFO - Successfully installed blessings 09:44:24 INFO - Cleaning up... 09:44:25 INFO - Return code: 0 09:44:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:44:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:25 INFO - Reading from file tmpfile_stdout 09:44:25 INFO - Current package versions: 09:44:25 INFO - blessings == 1.6 09:44:25 INFO - blobuploader == 1.2.4 09:44:25 INFO - docopt == 0.6.1 09:44:25 INFO - functools32 == 3.2.3-2 09:44:25 INFO - jsonschema == 2.5.1 09:44:25 INFO - manifestparser == 1.1 09:44:25 INFO - mozInstall == 1.12 09:44:25 INFO - mozcrash == 1.0 09:44:25 INFO - mozdebug == 0.1 09:44:25 INFO - mozdevice == 0.49 09:44:25 INFO - mozfile == 1.2 09:44:25 INFO - mozhttpd == 0.7 09:44:25 INFO - mozinfo == 0.9 09:44:25 INFO - mozleak == 0.1 09:44:25 INFO - mozlog == 3.4 09:44:25 INFO - moznetwork == 0.27 09:44:25 INFO - mozprocess == 0.24 09:44:25 INFO - mozprofile == 0.28 09:44:25 INFO - mozrunner == 6.13 09:44:25 INFO - mozscreenshot == 0.1 09:44:25 INFO - mozsystemmonitor == 0.3 09:44:25 INFO - moztest == 0.8 09:44:25 INFO - mozversion == 1.4 09:44:25 INFO - psutil == 3.1.1 09:44:25 INFO - requests == 1.2.3 09:44:25 INFO - wsgiref == 0.1.2 09:44:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:44:25 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')]} 09:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:26 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 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:26 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 09:44:26 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 09:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:26 INFO - 'HOME': '/Users/cltbld', 09:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:26 INFO - 'LOGNAME': 'cltbld', 09:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:26 INFO - 'MOZ_NO_REMOTE': '1', 09:44:26 INFO - 'NO_EM_RESTART': '1', 09:44:26 INFO - 'PAGER': '/bin/cat', 09:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:26 INFO - 'PWD': '/builds/slave/test', 09:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:26 INFO - 'SHELL': '/bin/bash', 09:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:26 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:26 INFO - 'USER': 'cltbld', 09:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:26 INFO - 'XPC_FLAGS': '0x0', 09:44:26 INFO - 'XPC_SERVICE_NAME': '0', 09:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 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)) 09:44:26 INFO - Cleaning up... 09:44:26 INFO - Return code: 0 09:44:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:44:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1b9b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1bc768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f056f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, '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.L8CKjPezbb/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.tfUpsXxeEj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 09:44:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:44:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:44:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:26 INFO - 'HOME': '/Users/cltbld', 09:44:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:26 INFO - 'LOGNAME': 'cltbld', 09:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:26 INFO - 'MOZ_NO_REMOTE': '1', 09:44:26 INFO - 'NO_EM_RESTART': '1', 09:44:26 INFO - 'PAGER': '/bin/cat', 09:44:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:26 INFO - 'PWD': '/builds/slave/test', 09:44:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:26 INFO - 'SHELL': '/bin/bash', 09:44:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:26 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:26 INFO - 'USER': 'cltbld', 09:44:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:26 INFO - 'XPC_FLAGS': '0x0', 09:44:26 INFO - 'XPC_SERVICE_NAME': '0', 09:44:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:44:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:44:27 INFO - Cleaning up... 09:44:27 INFO - Return code: 0 09:44:27 INFO - Running post-action listener: _resource_record_post_action 09:44:27 INFO - Running post-action listener: _start_resource_monitoring 09:44:27 INFO - Starting resource monitoring. 09:44:27 INFO - [mozharness: 2017-01-23 17:44:27.272404Z] Finished create-virtualenv step (success) 09:44:27 INFO - [mozharness: 2017-01-23 17:44:27.273355Z] Running install step. 09:44:27 INFO - Running pre-action listener: _resource_record_pre_action 09:44:27 INFO - Running main action method: install 09:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:44:27 INFO - Reading from file tmpfile_stdout 09:44:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:44:27 INFO - Reading from file tmpfile_stdout 09:44:27 INFO - Output received: 09:44:27 INFO - Usage: mozinstall [options] installer 09:44:27 INFO - Options: 09:44:27 INFO - -h, --help show this help message and exit 09:44:27 INFO - -d DEST, --destination=DEST 09:44:27 INFO - Directory to install application into. [default: 09:44:27 INFO - "/builds/slave/test"] 09:44:27 INFO - --app=APP Application being installed. [default: firefox] 09:44:27 INFO - mkdir: /builds/slave/test/build/application 09:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:44:48 INFO - Reading from file tmpfile_stdout 09:44:48 INFO - Output received: 09:44:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:44:48 INFO - Running post-action listener: _resource_record_post_action 09:44:48 INFO - [mozharness: 2017-01-23 17:44:48.031177Z] Finished install step (success) 09:44:48 INFO - [mozharness: 2017-01-23 17:44:48.031337Z] Running run-tests step. 09:44:48 INFO - Running pre-action listener: _resource_record_pre_action 09:44:48 INFO - Running main action method: run_tests 09:44:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:48 INFO - 2017-01-23 09:44:48.045 screenresolution[1630:7583] starting screenresolution argv=screenresolution get 09:44:48 INFO - 2017-01-23 09:44:48.048 screenresolution[1630:7583] Display 0: 1600x1200x32@60 09:44:48 INFO - 2017-01-23 09:44:48.054 screenresolution[1631:7586] starting screenresolution argv=screenresolution list 09:44:48 INFO - Available Modes on Display 0 09:44:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:48 INFO - Intel Iris: 09:44:48 INFO - Chipset Model: Intel Iris 09:44:48 INFO - Type: GPU 09:44:48 INFO - Bus: Built-In 09:44:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:48 INFO - Vendor: Intel (0x8086) 09:44:48 INFO - Device ID: 0x0a2e 09:44:48 INFO - Revision ID: 0x0009 09:44:48 INFO - Displays: 09:44:48 INFO - Display: 09:44:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:48 INFO - Display Serial Number: 1600x1200 60 09:44:48 INFO - Main Display: Yes 09:44:48 INFO - Mirror: Off 09:44:48 INFO - Online: Yes 09:44:48 INFO - Rotation: Supported 09:44:48 INFO - Return code: 0 09:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:44:48 INFO - Python 2.7.3 09:44:48 INFO - Return code: 0 09:44:48 INFO - grabbing minidump binary from tooltool 09:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:48 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 0x109f97d30>, '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 0x109ebedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109f8cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:44:48 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 09:44:48 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 09:44:48 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 09:44:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:44:48 INFO - Return code: 0 09:44:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:44:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:44:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:44:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:44:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:44:48 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/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 09:44:48 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/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --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 09:44:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L8CKjPezbb/Render', 09:44:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:44:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:44:48 INFO - 'HOME': '/Users/cltbld', 09:44:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:44:48 INFO - 'LOGNAME': 'cltbld', 09:44:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:44:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:44:48 INFO - 'MOZ_NO_REMOTE': '1', 09:44:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:44:48 INFO - 'NO_EM_RESTART': '1', 09:44:48 INFO - 'PAGER': '/bin/cat', 09:44:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:44:48 INFO - 'PWD': '/builds/slave/test', 09:44:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:44:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:44:48 INFO - 'SHELL': '/bin/bash', 09:44:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tfUpsXxeEj/Listeners', 09:44:48 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:44:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:44:48 INFO - 'USER': 'cltbld', 09:44:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:44:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:44:48 INFO - 'XPC_FLAGS': '0x0', 09:44:48 INFO - 'XPC_SERVICE_NAME': '0', 09:44:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:44:48 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/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 09:44:48 INFO - mozversion application_buildid: 20170123080355 09:44:48 INFO - mozversion application_changeset: dca7b42e6c67219398e6419293c075ef829adb29 09:44:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:44:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:44:48 INFO - mozversion application_name: Firefox 09:44:48 INFO - mozversion application_remotingname: firefox-dev 09:44:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:44:48 INFO - mozversion application_vendor: Mozilla 09:44:48 INFO - mozversion application_version: 53.0a2 09:44:48 INFO - mozversion platform_buildid: 20170123080355 09:44:48 INFO - mozversion platform_changeset: dca7b42e6c67219398e6419293c075ef829adb29 09:44:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:44:48 INFO - mozversion platform_version: 53.0a2 09:44:48 INFO - using testdate: 1485193488 09:44:48 INFO - actual date: 1485193488 09:44:48 INFO - starting webserver on 'localhost:49241' 09:44:48 INFO - SUITE-START | Running 2 tests 09:44:48 INFO - TEST-START | dromaeo_css 09:44:48 INFO - operating with platform_type : mac_ 09:44:48 INFO - Initialising browser for dromaeo_css test... 09:44:48 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmp3mniOX/profile http://localhost:49241/getInfo.html) 09:44:51 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 09:44:51 INFO - PROCESS | 1641 | colorDepth:24 09:44:51 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 09:44:51 INFO - PROCESS | 1641 | __metrics 09:44:51 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:44:51 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:51 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:51 INFO - TEST-INFO | 1641: exit 0 09:44:51 INFO - Browser initialized. 09:44:51 INFO - Running cycle 1/1 for dromaeo_css test... 09:44:51 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmp3mniOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:45:04 INFO - PROCESS | 1644 | RSS: Main: 213135360 09:45:04 INFO - PROCESS | 1644 | 09:48:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:48:09 INFO - PROCESS | 1644 | RSS: Main: 337657856 09:48:09 INFO - PROCESS | 1644 | 09:49:53 INFO - PROCESS | 1644 | ************************* 09:49:53 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 09:49:53 INFO - PROCESS | 1644 | 09:49:53 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:49:53 INFO - PROCESS | 1644 | Full stack: 09:49:53 INFO - PROCESS | 1644 | ************************* 09:51:11 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:51:12 INFO - PROCESS | 1644 | RSS: Main: 349880320 09:51:12 INFO - PROCESS | 1644 | 09:54:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:54:15 INFO - PROCESS | 1644 | RSS: Main: 321703936 09:54:15 INFO - PROCESS | 1644 | 09:57:17 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:57:18 INFO - PROCESS | 1644 | RSS: Main: 319139840 09:57:18 INFO - PROCESS | 1644 | 10:00:21 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:00:22 INFO - PROCESS | 1644 | RSS: Main: 317718528 10:00:22 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:03:25 INFO - PROCESS | 1644 | RSS: Main: 579874816 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | __start_tp_report 10:03:25 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 10:03:25 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 10:03:25 INFO - PROCESS | 1644 | |i|pagename|runs| 10:03:25 INFO - PROCESS | 1644 | |0;dojo.html;3098.163495856119;3314.806669598944;3330.966690333096;3335.5663763710713;3374.915627109322;5693.5160511356535;5745.109508026263;5752.511036561892;5773.018586840242;5773.30720313563;5694.6867922264255;5770.451807078321;5775.797847075353;5776;5795.565332600051;5218.478152184789;5226.973865130679;5259.263703081571;5263.789448422059;5327.227552004957;5172.741362931857;5192.1952097424955;5212.400573933989;5331.360236771593;5334.973325133369;5182.144946083891;5202.843914682566;5213.296205012312;5221.738913054351;5267.209918512215;5239.161734122541;5250.05499010178;5251.054810134175;5260.1583746600745;5320.9467905320835;5079.3650793650795;5126.974365128188;5195.246689230041;5198.376194856603;5220.582353411718;5644.040513112781;5644.068728659808;5718.571107166979;5733.913991290134;5736.684482353469;6303.117563541108;6325;6356.237251529846;6369.4585960193435;6376;6306.085617585471;6356.491480681534;6398.136251606066;6413.486921046305;6414.134091897581;5740.167675687002;5775.88448231033;5790.739416726257;5892.970535147297;5942.8811423771285;6116.143739876421;6170.074488826712;6327.462165715873;6342.334054924258;6365.554411191265;6161.075838624242;6183.412575805291;6208;6208.627482351073;6225.844353891189;6161;6251.874962500725;6256.249250090018;6305.873882522324;6351.428371446592;6154.19995400604;6161.84595385119;6208.192934918432;6236;6334.239891213084;6293.2762732285455;6294.150289710922;6310.337414571404;6322.051692246107;6329.303776584572;4998.825041123543;5020.1214787412055;5029.74851257443;5033.84898453047;5048.646594738407;4393;4436.201483732959;4471.821127154943;4477.395551600493;4478.6864919455975;4466.307722303049;5670.858228544319;5757.740901659436;5759.539236861125;5772.365039845614;6219.315875253718;6270.6864656766975;6284.622922624657;6293.244810622755;6344.175257216532;5706.258186435737;5753.165790960287;5796.8550786229835;5803.245578074908;5833.212516310328;5394.676319420847;5460.6996615186545;5469.316335458067;5536.640118392292;5540.141278101901;6305.085762564494;6313.5896166749935;6338.492920566436;6341.682915854281;6342.460890824332;6251.562390632612;6255.218097737783;6280.780172693934;6343.746250149942;6348.746050158126;5372.2747429098135;6371.745130194926;6385.8722825544155;6407.295197528175;6415.06981487691;6099.359567245376;6225.8132256032395;6262.279837818709;6264.843378915563;6270.74917003333;6185.628862268279;6228.5951413158;6262.185915830913;6327.209098862642;6372.171617689671;5964.194833697396;6013.428724271187;6019.786149695144;6070.301915279622;6221.129041934223;6002.339742628395;6024.307204671519;6027.547933904887;6186.505079593531;6217.502599791916;4881.365422495053;5723.513501352431;5850.970745146247;5895.263092113486;5955.434233747787;5171.689698618095;6176.845578860564;6184.196054512884;6188.412100850412;6217.222847144107;5981.760729570942;6019.277686677627;6027.879442411039;6029;6062.848428789139 10:03:25 INFO - PROCESS | 1644 | |1;ext.html;426.7183658785202;477.8136526754564;490.5339927069285;490.72028943502215;499.76011514473043;32397;33140.84007059754;41154.58845411545;43379.56620433795;43427.13145737084;43510.564894351046;43778.68663940079;43836.3424548632;43872.78063609685;43896;9433.867935847691;9675.612975480972;9677.225821934227;9683.515824208762;9700.175485083777;8482.36382271329;8694.347923905701;8699.173578510063;8799.912000880006;9490.478023708692;8644.308455323591;11341.26281791685;11593.826092608617;11622.883771162265;11788.29270243788;11195.832062518988;11311.830322545127;11508.769824603545;11534.13493987946;11543.653690389301;11322.716932076764;11324.094072474183;11425.31448113116;11462.828057579143;11521.596744114;31932.20169495758;32600;39964.40053399201;40614.79692601518;40622.78131656055;4076.9796151019054;4079.7960101995077;4081.4898137732785;4092.2224777292217;4106.568810274938;30153.944611938696;30259.697403025908;30352.54471182912;31173.688263117532;31750.206244843834;2906.7674586033067;2929.8974535891352;2943.690912454183;3048.405560915622;3124.4376012317775;466005;467120;468146;468474;471297;59890.40109598936;59954.800903981675;59988.50028749316;60120.09219400725;60234.49413764691;67981.98027029599;68275.65862170658;68314.65842670755;68368.3163168362;68399.94800156003;16850.915745421193;17087.145642717813;17103.230354633823;17135.828641713673;17175.484735457958;13125.01562382825;13209.141405808783;13247.337633118306;13247.66880827987;13268.336583170803;15589.454369097253;16141.838581614034;17874.731879021823;18291.81708182928;18313.542161446072;5811.970940145272;6060.666663333559;6869.7595584154315;6943.548669336477;7007.509474336849;749.2881762325703;868.6959564152496;895.8880139982502;921.995390023059;922.6678395777515;28550.714492855222;28848.855755721088;30607;30660.773569057434;31390.37219255648;963.4315753705207;1037.5849660135855;1084.34939036579;1122.9775404492027;1193.3913704010843;16052.357905683875;16066.919665401598;16297.51407363134;16321.59196020109;16358.509244722678;600182;605577;606535;607457;607562;63390.36609633845;63444;63475.68262158752;63562.36437635657;63631.36368636347;1415.6531649745878;1452.9564113076624;1457.3514785920377;1466.3621324723779;1467.0317590390505;28409.431811363243;29694.960676376224;30431.54352684756;31020.84489577628;31444.213894652818;51861.740691296305;52101.478985209666;52334.953300933004;52365.47634523606;52403.73798130985;530160;530771;531761;533080;533301.33349333;41307;41602.791986039876;42436.78781606072;42647.360289596305;42663.57336426596;36201.637983619825;36837.81581092077;50023.499765001885;50219.748901256724;53283.93432131258;38782.6121738779;39827.80086099551;40740;41052.1789564213;42204.36693449662;40345.59654403418;40734.59265407308;41687.37468938029;41690.79154604208;42058.78970605128;38656.8402947912;38880.86155261488;39600.40599390954;39737.2052558953;39879.80060099681;34744.652553474145;35804.10489737673;36021;36176.819115904254;36456.08859778527;26121.216363508363;26279.868600656875;26417.33956651099;26501.19104807226;26515.867420662773 10:03:25 INFO - PROCESS | 1644 | |2;jquery.html;333.97802723665586;387.47303667012875;401.62648736674896;411.92379409809166;419.99160016799664;20379.796202037993;21605.1357945682;21769.23807666732;21857.234996775114;22082.227122050732;21157.153713851465;21647.891760541213;21693;21934.341969740894;21937.122515099378;5358.839234822942;5825.825225243249;5873.765049398019;5881.529477641779;5885.529157667398;4123.711340206187;4304.225239456897;4345.717528360662;5716.942830571683;5839.824805255849;4348.369486424483;5448.673079615216;6407.583507072049;6414.807555773335;6417.101605775195;5637.887242255173;5900.675462849542;6407.423331900128;6410.67946602668;6431.967840160816;4932.556069953685;5159.535641792219;5736.823951090017;5880.353161152269;5898.174255604219;13512.459501619924;23363;25146.622800658006;25981.335506025578;26190.21429357122;2509.6110102934076;2563.873592300445;2574.8068894832963;2578.084779903145;2647.907323243677;8723.171298726611;9552.14030737237;9582.856257156149;9918.950405248;10328.967103289686;1624.6507000994843;1837.7411473140808;1852.5276054606124;1874.2315650583196;1875.0624687656173;91842.08157918401;99423.00576994281;112404;120107.399463003;126762;9830.754231144136;11376.952148613329;11641.825372619418;11742.823857642143;11750.23623464472;15388.615284617974;15429.922850385676;15451.690966180613;15458.995165314218;15514.84485155134;8491.787705307417;8590.547804493766;8626.094260102724;8631.654733810577;8790.989036260784;8539.274161696325;8558.52928088961;8564.74305770828;8698.130186981378;8720.215180633773;3855.1904100139286;4670.486246512881;4678.2280923647895;4705.047405326751;4776.522347765195;1799.2443173867007;1837.2375464182483;1992.2031187525106;2000.479875232421;2001.9199232030846;893.9687110951086;1006.8855403652271;1028.4343611013912;1040.484959944832;1050.4432650695144;20795;21923.232686855885;21986.120555177935;22005.889970550365;22031.449213769785;1056.7305337139135;1057.9206559508068;1075.1560025380038;1082.9079528240031;1100.0979197058496;11007.944960275147;11223.933726296153;11405;11420.771584568261;11436.741958384571;679229;708339;730681;773954;782294;125482;132008.3399582996;134947;137452.62547374598;147886;995.5161871131573;1016.5832008876325;1023.4371095897227;1024.139722632977;1027.547878933282;16647.3341066356;17371.131443428032;17408.39070632522;18656.813431865507;19143.52141196481;45092;55249.89500209893;55835.16247256376;56091.71954140203;56596.71701641465;76067.23932760602;78101.70234820341;79696;80107.19892800998;80282.79575806251;5783.971080144573;6137.815865524041;6841.486888483483;7502.662380192795;7654.8086297843;9263.305252106255;12096.334701591144;12910.289934053717;13287.66780830487;13309.800352994907;10876.619318323821;11016.394098324348;11146.108311334912;11359.432028398382;11398.544058237909;10621.734456638645;10707.464626768786;10820.837687434538;10840.945795270973;11373.715657108638;6531.934680653133;11202.21584489078;11420.71448213768;11724.58963936258;11903.642890713292;7350.889736654061;7437.851242975218;7452.105747310141;7634.694612215671;7654.15804261542;9962.252831037556;11040.392778397265;11046.447677615926;11348.659540213806;11407.714807129889 10:03:25 INFO - PROCESS | 1644 | |3;mootools.html;1435.504750860954;1442.2212005517022;1443.2567227877641;1460.1895947749;1466.486729644624;8081.757547273576;8504.872426913586;8514.787130321738;8520.701775437861;8521.318294536437;7456.217097204797;7743.341815945651;7750.651220695068;8048.758537243877;8264.504129752218;2289.2102224732485;2307.561563302967;2314.5602335556273;2317.5596636638984;2318.6058370077126;2316.108298305148;2335.2643917166124;2350.6591544226076;2352.7882490575844;2353.9882300588474;2284.5088306014204;2294.850834695748;2303.424143964009;2328.161861729776;2331.813454923602;2197.5934452126407;2205.9227927022475;2232.8771917544527;2237.518933429304;2282.657601359793;2070.968935465969;2265.2184996176293;2292.33522278539;2338.3452633262714;2340.2511196417154;8424.705135320295;8490.40567160299;8515.53164575948;8523.95738021306;8531.74404767858;5015;5181.326427564431;5182.274481572583;5190.351206099238;5201.55786758126;3166.145140811991;3252.8536215870345;3366.932661346784;3425.554677891883;3432.3135372925267;1119.5074167366415;1128.644476989754;1161.0595417711681;1176.1649229047387;1182.911281653871;10953.507092180791;10962.123030157569;11092.33445993235;11095.778084438267;11098.44507774616;4415.558444155558;4648.86053418398;4696.342512048316;4732.976335118303;4735.644826638016;9664.226861851175;9669.516524173903;9679.225661947168;9688.95155524232;9702.320837541305;5191.273221748958;5234.42421333653;5235.528802407725;5244.213367994831;5245.423003469616;4226.513950895686;4365.628921541705;4515.909681806345;4615.861524154281;4680.15757163707;3856.5950575189763;3873.903152421212;3925.980370098131;3978.840846366171;3986.3023970804993;1266.1073942870255;1268.3341245846004;1270.0665011216747;1281.7628738683372;1283.3390803736083;911.5715613661569;917.9260265489394;920.7099763574453;925.9074092590687;953.5518306395983;5615.298087739033;5825.621334613236;5834.5624078194305;5903.6457812530525;6151.9692401538605;956.2780101023683;987.0573602210015;990.9207263418909;1012.0688966151158;1020.4234607446768;3717.7955212463035;3856.3444214483607;3921.509811273591;3948.151147503243;3956.643902048829;9938.453385063747;10268.691939241835;10288.639897603698;10295.176385889261;10303.536340864679;9264.583093760797;9654.27592930519;9895.455749933679;10052.949735251277;10056.547455364525;7726.9227307726205;7861.724839630586;7947.483413578099;8008.559529225949;8009.0789559200275;5711.371749107678;5723.771049157987;5854.356020837619;5913.02435098204;5949.464548190684;9121.224695900657;9223.262139028995;9343.29925255595;9371.625134994796;9446.574904129193;9476.194523465583;9489.762755931157;9534.380265282734;9564.76088097803;9601.183899368632;6710.362515561014;6738.59568425896;6979.965100174467;7301.671424785791;7466.029416176079;6625.900611490735;8124.471909325875;8134.796630084295;8138.982627171604;8154.714584989497;7088.362047415551;7204.603746793767;7238.02286691311;7243.927560724536;7324.560526368435;7004.089468369079;7056.188538317954;7069.363757261871;7179.784606461814;7239.529430586995;6334.3665633436285;6351.587146835441;6487.253965793994;6499.805005849832;6502.577332473374;4907.018596280686;5019.247112933089;5047.697138171721;5083.440821509705;5110.795568177231;4630;4686.859394218179;4697.177993851131;4825.855224343135;4873.293372461044 10:03:25 INFO - PROCESS | 1644 | |4;prototype.html;310.96734842841516;341.1879726251521;355.5306994766907;366.730453116959;373.7944130728099;5267.604929630274;5295.523402893744;5320.98901208771;5330.920036199455;5359.758810853511;5235.827131740323;5277.366715994077;5297.682139071659;5310.548603368708;5347.866303342409;3526.4886591444224;3932.2528719543197;4089.5501494835544;4105.568915263899;4210.831566737327;4147.3617920921215;4208.431861698662;4210.63149480416;4219.480986844734;4230.640395566381;3658.6158453362414;4172.582741725818;4209.810558524859;4210.3894935234375;4223.197592457439;3957.426173204869;4091.89770255743;4125.360569111793;4220.936685949713;4233.809478573472;3633.218857945528;3654.9086272843124;3672.669459748609;3675.9707281961096;3703.2408356286896;4483.820647174109;4706.199946009152;4993.553158952123;5040.974795126038;5203.479652034766;4327.783610819446;4688.835890743841;4823.710577365369;4851.296561998491;4899.265110233458;4567.817287308504;4787.784549695237;5163.7676304566385;5674.687892165971;5690.573207009491;4080.9387859182134;4102;4104.733192342518;4146.543880173179;4160.854370097032;4862.5623693867365;5043.722595257259;5633.60564760467;5769.567282453832;6063.636181829104;3246.338002837698;3305.735541156702;4050.9594904051173;4139.3583994480905;4176.9582304177175;3552.8401221945073;3592.5329707137903;4201.369794530845;4228.344606585984;4258.425112609758;3995.9600403995587;4102.876913692594;4672.2991551266905;4820.903581928342;4868.488808675109;5595.342212449054;5608;5620.5503559715125;5624.521915637217;5639.238702775073;1105.9391733454577;1358.361570062089;1369.698666293414;1378.9655258618616;1384.3977869626744;911.5235870911558;959.9872134897611;963.2390411574918;968.1286841842398;974.3715303629119;4131.772752498641;4265.0144898571125;4277.331840582176;4962.305277261186;4977.104121258209;4199.664026877843;4822.324874517501;5217.912834866008;5421.484958928895;5512;4462.888427789331;4792;4949;5012.523810238022;5038.3198268234055;2443.8655873927105;2445.3886528367907;2638.4591158812395;2870.8373108890933;2956.926076848096;4676.158291507561;5314.48268971379;5363.03465376236;5753.539716822645;5789.478946894716;5258.609061433669;5303.549198318186;5314.12316967696;5690.459406356389;5763.9135412968835;5666.801661941812;5711.457411545896;5713.257276554022;5732.05421105513;5786.3056433228285;4701.531695859701;5208.718507340352;5344.75948582307;5569.331680198402;5573.903181161924;5079.044567841333;5126.077306084941;5803.7968671096305;5840.225892700933;5850.678212698343;5332.920006199833;5896.17453556511;5943.940560594338;6031.155638210566;6043.758249669964;4239.47006624172;4245.172191422643;4276.166147601312;4289.206496798102;4296.763677997615;5175.549027835983;5734.827955161351;5855.824325270249;5874.383189765013;5957.672328022;4943.8516844494725;5609.298837645294;5683.318001839806;5709.7430615623225;5758.856028599319;4526.932096018497;5422.48486393792;5545.807651354817;5625.921207124802;5638.520725738194;4593.931091033571;5523.254360661259;5540.14127810174;5587.882423515394;5592.636478628876;5283.260343551829;5383.7846486140115;5661.745221464962;5713.542916566582;5736.5410767139365;4617.12274667812;4868.417764226711;4900;5227.686338819683;5581.832545023493 10:03:25 INFO - PROCESS | 1644 | |5;yui.html;719.8128486593484;730.0290613484063;779.5478622399008;791.2483141016032;837.3217693668128;15004.774928376082;15585.84414155858;15882.126483043428;15933.44232951847;16002.759958600616;13563.118397304193;14512;14568.562943111698;14650.560483185494;14821.333040013198;868.4919322196507;880.6477409036405;883.3066043156124;885.4598694796169;886.57887503436;870.7126648206076;874.3660845886714;875.6191056890241;877.8244351129767;877.934154938379;918.2608000559546;919.429953428875;920.0017980491175;921.3964853021282;922.0871337376017;913.5204017890594;915.2083447817656;915.3226612306911;917.2341095185528;917.5228880981919;688.5042769206163;689.1454596300601;690.9378155965987;692.2039654397433;692.9480288978297;11184.496697648545;11311.321320720783;13162.670933226651;13484;13488.730225395437;12066.276023438622;12189.512419503299;12247.75504489914;12442.937785311016;12479.75040499194;10731.517081731341;10745.301555398873;10898.836517452244;11095.72260693481;11206.439678016066;3162.908796465216;3598.4062629666073;3610.9277814443826;3649.4708267301357;3731.738778285521;63798.681006595136;81573;95849.5207523958;101650;111402.44298778454;11188.608398706006;11432.313406349502;11641.47613357401;11779.469923853447;11810.52757889692;23386.7661323388;23578.29265122049;23631.881840590686;23958;23986.640200397007;8092.352611791042;8108.675652973815;8129;8188.631511581993;8250.669973201126;4223.239816832938;4261.169072030986;4388.473383193973;4409.977950110229;4450.399196108484;3453.3783918894337;3571.767835090711;3575.1419659281587;3582.7133829293593;3592.191756854739;640.0974625777632;640.7052755732323;641.868416974519;664.9933500665028;671.2716702377877;538.978440862369;550.6998685716214;558.2999765713413;579.2759051186017;580.1558732044865;9216.585253663601;10285;10295.794084118275;10335.638252661121;10465.47672616366;651.563452486835;675.9121314229217;677.1604999651985;685.9005444210661;691.5850489706136;4634.490206077397;4919.483454237254;4922.827701030446;4926.802927882844;4928.778204980785;92564;93105;94992.57511137339;96670.48453762235;106962.3955640666;70074;78339.82490262651;81191.5940420306;83415;89225;66945.6652716743;77434.61282693551;80761.19238807536;83797;84055.89860253542;10746.623868164577;11413.906391987259;11595.594154204562;11625.825612615987;11661.300321980709;47279.29081063856;51406;52053;52526;52541.47458525366;62195.44511387071;63074.68462657657;65844;67230.66384668046;68795.31204688089;13570.982176336616;13747.931260343634;13802.585922422344;14115.364808583843;14196.219207943663;14433.855661443671;14646.121232726071;14860;15077.773833392728;15863.444779432664;12898.355082245662;13340.599782006168;14206.509360452073;14714;14734.705305894036;13153.21080735159;13373.933130334286;13375.866241337852;13769.257137747123;14264.001519893924;13212.339383030618;13477.797833032708;13624.727505449637;13660.93169534146;13982.44070237179;11348.432578371214;11410;11953.940230298793;12115.273083615011;12169.452374643339;9866.654667086617;9977.501124943868;10927.617533386294;11193.440327983732;11208.831867522156 10:03:25 INFO - PROCESS | 1644 | __end_tp_report 10:03:25 INFO - PROCESS | 1644 | __start_cc_report 10:03:25 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1303 10:03:25 INFO - PROCESS | 1644 | __end_cc_report 10:03:25 INFO - PROCESS | 1644 | __startTimestamp1485194605874__endTimestamp 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | ------- Summary: start ------- 10:03:25 INFO - PROCESS | 1644 | Number of tests: 6 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5760.58 Median:5964.19 stddev:666.64 (11.2%) stddev-sans-first:635.12 10:03:25 INFO - PROCESS | 1644 | Values: 3098.2 3314.8 3331.0 3335.6 3374.9 5693.5 5745.1 5752.5 5773.0 5773.3 5694.7 5770.5 5775.8 5776.0 5795.6 5218.5 5227.0 5259.3 5263.8 5327.2 5172.7 5192.2 5212.4 5331.4 5335.0 5182.1 5202.8 5213.3 5221.7 5267.2 5239.2 5250.1 5251.1 5260.2 5320.9 5079.4 5127.0 5195.2 5198.4 5220.6 5644.0 5644.1 5718.6 5733.9 5736.7 6303.1 6325.0 6356.2 6369.5 6376.0 6306.1 6356.5 6398.1 6413.5 6414.1 5740.2 5775.9 5790.7 5893.0 5942.9 6116.1 6170.1 6327.5 6342.3 6365.6 6161.1 6183.4 6208.0 6208.6 6225.8 6161.0 6251.9 6256.2 6305.9 6351.4 6154.2 6161.8 6208.2 6236.0 6334.2 6293.3 6294.2 6310.3 6322.1 6329.3 4998.8 5020.1 5029.7 5033.8 5048.6 4393.0 4436.2 4471.8 4477.4 4478.7 4466.3 5670.9 5757.7 5759.5 5772.4 6219.3 6270.7 6284.6 6293.2 6344.2 5706.3 5753.2 5796.9 5803.2 5833.2 5394.7 5460.7 5469.3 5536.6 5540.1 6305.1 6313.6 6338.5 6341.7 6342.5 6251.6 6255.2 6280.8 6343.7 6348.7 5372.3 6371.7 6385.9 6407.3 6415.1 6099.4 6225.8 6262.3 6264.8 6270.7 6185.6 6228.6 6262.2 6327.2 6372.2 5964.2 6013.4 6019.8 6070.3 6221.1 6002.3 6024.3 6027.5 6186.5 6217.5 4881.4 5723.5 5851.0 5895.3 5955.4 5171.7 6176.8 6184.2 6188.4 6217.2 5981.8 6019.3 6027.9 6029.0 6062.8 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:68457.06 Median:40737.30 stddev:143282.27 (351.7%) stddev-sans-first:143593.17 10:03:25 INFO - PROCESS | 1644 | Values: 426.7 477.8 490.5 490.7 499.8 32397.0 33140.8 41154.6 43379.6 43427.1 43510.6 43778.7 43836.3 43872.8 43896.0 9433.9 9675.6 9677.2 9683.5 9700.2 8482.4 8694.3 8699.2 8799.9 9490.5 8644.3 11341.3 11593.8 11622.9 11788.3 11195.8 11311.8 11508.8 11534.1 11543.7 11322.7 11324.1 11425.3 11462.8 11521.6 31932.2 32600.0 39964.4 40614.8 40622.8 4077.0 4079.8 4081.5 4092.2 4106.6 30153.9 30259.7 30352.5 31173.7 31750.2 2906.8 2929.9 2943.7 3048.4 3124.4 466005.0 467120.0 468146.0 468474.0 471297.0 59890.4 59954.8 59988.5 60120.1 60234.5 67982.0 68275.7 68314.7 68368.3 68399.9 16850.9 17087.1 17103.2 17135.8 17175.5 13125.0 13209.1 13247.3 13247.7 13268.3 15589.5 16141.8 17874.7 18291.8 18313.5 5812.0 6060.7 6869.8 6943.5 7007.5 749.3 868.7 895.9 922.0 922.7 28550.7 28848.9 30607.0 30660.8 31390.4 963.4 1037.6 1084.3 1123.0 1193.4 16052.4 16066.9 16297.5 16321.6 16358.5 600182.0 605577.0 606535.0 607457.0 607562.0 63390.4 63444.0 63475.7 63562.4 63631.4 1415.7 1453.0 1457.4 1466.4 1467.0 28409.4 29695.0 30431.5 31020.8 31444.2 51861.7 52101.5 52335.0 52365.5 52403.7 530160.0 530771.0 531761.0 533080.0 533301.3 41307.0 41602.8 42436.8 42647.4 42663.6 36201.6 36837.8 50023.5 50219.7 53283.9 38782.6 39827.8 40740.0 41052.2 42204.4 40345.6 40734.6 41687.4 41690.8 42058.8 38656.8 38880.9 39600.4 39737.2 39879.8 34744.7 35804.1 36021.0 36176.8 36456.1 26121.2 26279.9 26417.3 26501.2 26515.9 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:38782.80 Median:13828.12 stddev:121815.25 (880.9%) stddev-sans-first:122122.76 10:03:25 INFO - PROCESS | 1644 | Values: 334.0 387.5 401.6 411.9 420.0 20379.8 21605.1 21769.2 21857.2 22082.2 21157.2 21647.9 21693.0 21934.3 21937.1 5358.8 5825.8 5873.8 5881.5 5885.5 4123.7 4304.2 4345.7 5716.9 5839.8 4348.4 5448.7 6407.6 6414.8 6417.1 5637.9 5900.7 6407.4 6410.7 6432.0 4932.6 5159.5 5736.8 5880.4 5898.2 13512.5 23363.0 25146.6 25981.3 26190.2 2509.6 2563.9 2574.8 2578.1 2647.9 8723.2 9552.1 9582.9 9919.0 10329.0 1624.7 1837.7 1852.5 1874.2 1875.1 91842.1 99423.0 112404.0 120107.4 126762.0 9830.8 11377.0 11641.8 11742.8 11750.2 15388.6 15429.9 15451.7 15459.0 15514.8 8491.8 8590.5 8626.1 8631.7 8791.0 8539.3 8558.5 8564.7 8698.1 8720.2 3855.2 4670.5 4678.2 4705.0 4776.5 1799.2 1837.2 1992.2 2000.5 2001.9 894.0 1006.9 1028.4 1040.5 1050.4 20795.0 21923.2 21986.1 22005.9 22031.4 1056.7 1057.9 1075.2 1082.9 1100.1 11007.9 11223.9 11405.0 11420.8 11436.7 679229.0 708339.0 730681.0 773954.0 782294.0 125482.0 132008.3 134947.0 137452.6 147886.0 995.5 1016.6 1023.4 1024.1 1027.5 16647.3 17371.1 17408.4 18656.8 19143.5 45092.0 55249.9 55835.2 56091.7 56596.7 76067.2 78101.7 79696.0 80107.2 80282.8 5784.0 6137.8 6841.5 7502.7 7654.8 9263.3 12096.3 12910.3 13287.7 13309.8 10876.6 11016.4 11146.1 11359.4 11398.5 10621.7 10707.5 10820.8 10840.9 11373.7 6531.9 11202.2 11420.7 11724.6 11903.6 7350.9 7437.9 7452.1 7634.7 7654.2 9962.3 11040.4 11046.4 11348.7 11407.7 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5479.30 Median:5186.31 stddev:3000.17 (57.8%) stddev-sans-first:2993.20 10:03:25 INFO - PROCESS | 1644 | Values: 1435.5 1442.2 1443.3 1460.2 1466.5 8081.8 8504.9 8514.8 8520.7 8521.3 7456.2 7743.3 7750.7 8048.8 8264.5 2289.2 2307.6 2314.6 2317.6 2318.6 2316.1 2335.3 2350.7 2352.8 2354.0 2284.5 2294.9 2303.4 2328.2 2331.8 2197.6 2205.9 2232.9 2237.5 2282.7 2071.0 2265.2 2292.3 2338.3 2340.3 8424.7 8490.4 8515.5 8524.0 8531.7 5015.0 5181.3 5182.3 5190.4 5201.6 3166.1 3252.9 3366.9 3425.6 3432.3 1119.5 1128.6 1161.1 1176.2 1182.9 10953.5 10962.1 11092.3 11095.8 11098.4 4415.6 4648.9 4696.3 4733.0 4735.6 9664.2 9669.5 9679.2 9689.0 9702.3 5191.3 5234.4 5235.5 5244.2 5245.4 4226.5 4365.6 4515.9 4615.9 4680.2 3856.6 3873.9 3926.0 3978.8 3986.3 1266.1 1268.3 1270.1 1281.8 1283.3 911.6 917.9 920.7 925.9 953.6 5615.3 5825.6 5834.6 5903.6 6152.0 956.3 987.1 990.9 1012.1 1020.4 3717.8 3856.3 3921.5 3948.2 3956.6 9938.5 10268.7 10288.6 10295.2 10303.5 9264.6 9654.3 9895.5 10052.9 10056.5 7726.9 7861.7 7947.5 8008.6 8009.1 5711.4 5723.8 5854.4 5913.0 5949.5 9121.2 9223.3 9343.3 9371.6 9446.6 9476.2 9489.8 9534.4 9564.8 9601.2 6710.4 6738.6 6980.0 7301.7 7466.0 6625.9 8124.5 8134.8 8139.0 8154.7 7088.4 7204.6 7238.0 7243.9 7324.6 7004.1 7056.2 7069.4 7179.8 7239.5 6334.4 6351.6 6487.3 6499.8 6502.6 4907.0 5019.2 5047.7 5083.4 5110.8 4630.0 4686.9 4697.2 4825.9 4873.3 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4519.26 Median:4955.65 stddev:1347.39 (27.2%) stddev-sans-first:1313.63 10:03:25 INFO - PROCESS | 1644 | Values: 311.0 341.2 355.5 366.7 373.8 5267.6 5295.5 5321.0 5330.9 5359.8 5235.8 5277.4 5297.7 5310.5 5347.9 3526.5 3932.3 4089.6 4105.6 4210.8 4147.4 4208.4 4210.6 4219.5 4230.6 3658.6 4172.6 4209.8 4210.4 4223.2 3957.4 4091.9 4125.4 4220.9 4233.8 3633.2 3654.9 3672.7 3676.0 3703.2 4483.8 4706.2 4993.6 5041.0 5203.5 4327.8 4688.8 4823.7 4851.3 4899.3 4567.8 4787.8 5163.8 5674.7 5690.6 4080.9 4102.0 4104.7 4146.5 4160.9 4862.6 5043.7 5633.6 5769.6 6063.6 3246.3 3305.7 4051.0 4139.4 4177.0 3552.8 3592.5 4201.4 4228.3 4258.4 3996.0 4102.9 4672.3 4820.9 4868.5 5595.3 5608.0 5620.6 5624.5 5639.2 1105.9 1358.4 1369.7 1379.0 1384.4 911.5 960.0 963.2 968.1 974.4 4131.8 4265.0 4277.3 4962.3 4977.1 4199.7 4822.3 5217.9 5421.5 5512.0 4462.9 4792.0 4949.0 5012.5 5038.3 2443.9 2445.4 2638.5 2870.8 2956.9 4676.2 5314.5 5363.0 5753.5 5789.5 5258.6 5303.5 5314.1 5690.5 5763.9 5666.8 5711.5 5713.3 5732.1 5786.3 4701.5 5208.7 5344.8 5569.3 5573.9 5079.0 5126.1 5803.8 5840.2 5850.7 5332.9 5896.2 5943.9 6031.2 6043.8 4239.5 4245.2 4276.2 4289.2 4296.8 5175.5 5734.8 5855.8 5874.4 5957.7 4943.9 5609.3 5683.3 5709.7 5758.9 4526.9 5422.5 5545.8 5625.9 5638.5 4593.9 5523.3 5540.1 5587.9 5592.6 5283.3 5383.8 5661.7 5713.5 5736.5 4617.1 4868.4 4900.0 5227.7 5581.8 10:03:25 INFO - PROCESS | 1644 | 10:03:25 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:19718.93 Median:4242.20 stddev:27343.86 (644.6%) stddev-sans-first:27383.35 10:03:25 INFO - PROCESS | 1644 | Values: 719.8 730.0 779.5 791.2 837.3 15004.8 15585.8 15882.1 15933.4 16002.8 13563.1 14512.0 14568.6 14650.6 14821.3 868.5 880.6 883.3 885.5 886.6 870.7 874.4 875.6 877.8 877.9 918.3 919.4 920.0 921.4 922.1 913.5 915.2 915.3 917.2 917.5 688.5 689.1 690.9 692.2 692.9 11184.5 11311.3 13162.7 13484.0 13488.7 12066.3 12189.5 12247.8 12442.9 12479.8 10731.5 10745.3 10898.8 11095.7 11206.4 3162.9 3598.4 3610.9 3649.5 3731.7 63798.7 81573.0 95849.5 101650.0 111402.4 11188.6 11432.3 11641.5 11779.5 11810.5 23386.8 23578.3 23631.9 23958.0 23986.6 8092.4 8108.7 8129.0 8188.6 8250.7 4223.2 4261.2 4388.5 4410.0 4450.4 3453.4 3571.8 3575.1 3582.7 3592.2 640.1 640.7 641.9 665.0 671.3 539.0 550.7 558.3 579.3 580.2 9216.6 10285.0 10295.8 10335.6 10465.5 651.6 675.9 677.2 685.9 691.6 4634.5 4919.5 4922.8 4926.8 4928.8 92564.0 93105.0 94992.6 96670.5 106962.4 70074.0 78339.8 81191.6 83415.0 89225.0 66945.7 77434.6 80761.2 83797.0 84055.9 10746.6 11413.9 11595.6 11625.8 11661.3 47279.3 51406.0 52053.0 52526.0 52541.5 62195.4 63074.7 65844.0 67230.7 68795.3 13571.0 13747.9 13802.6 14115.4 14196.2 14433.9 14646.1 14860.0 15077.8 15863.4 12898.4 13340.6 14206.5 14714.0 14734.7 13153.2 13373.9 13375.9 13769.3 14264.0 13212.3 13477.8 13624.7 13660.9 13982.4 11348.4 11410.0 11953.9 12115.3 12169.5 9866.7 9977.5 10927.6 11193.4 11208.8 10:03:25 INFO - PROCESS | 1644 | -------- Summary: end -------- 10:03:25 INFO - PROCESS | 1644 | 10:03:26 INFO - TEST-INFO | 1644: exit 0 10:03:26 INFO - TEST-OK | dromaeo_css | took 1117893ms 10:03:26 INFO - TEST-START | kraken 10:03:26 INFO - operating with platform_type : mac_ 10:03:26 INFO - Initialising browser for kraken test... 10:03:26 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpXcC0EM/profile http://localhost:49241/getInfo.html) 10:03:28 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 10:03:28 INFO - PROCESS | 1656 | colorDepth:24 10:03:28 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 10:03:28 INFO - PROCESS | 1656 | __metrics 10:03:28 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 10:03:29 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:03:29 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:03:29 INFO - TEST-INFO | 1656: exit 0 10:03:29 INFO - Browser initialized. 10:03:29 INFO - Running cycle 1/1 for kraken test... 10:03:29 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpXcC0EM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:41 INFO - PROCESS | 1658 | RSS: Main: 213065728 10:03:41 INFO - PROCESS | 1658 | 10:03:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:03:45 INFO - PROCESS | 1658 | RSS: Main: 263827456 10:03:45 INFO - PROCESS | 1658 | 10:03:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:03:48 INFO - PROCESS | 1658 | RSS: Main: 276934656 10:03:48 INFO - PROCESS | 1658 | 10:03:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:03:52 INFO - PROCESS | 1658 | RSS: Main: 373571584 10:03:52 INFO - PROCESS | 1658 | 10:03:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:03:55 INFO - PROCESS | 1658 | RSS: Main: 277815296 10:03:55 INFO - PROCESS | 1658 | 10:03:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:03:57 INFO - PROCESS | 1658 | RSS: Main: 280559616 10:03:57 INFO - PROCESS | 1658 | 10:04:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:01 INFO - PROCESS | 1658 | RSS: Main: 320327680 10:04:01 INFO - PROCESS | 1658 | 10:04:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:04:04 INFO - PROCESS | 1658 | RSS: Main: 320925696 10:04:04 INFO - PROCESS | 1658 | 10:04:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:04:08 INFO - PROCESS | 1658 | RSS: Main: 318689280 10:04:08 INFO - PROCESS | 1658 | 10:04:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:04:10 INFO - PROCESS | 1658 | RSS: Main: 294866944 10:04:10 INFO - PROCESS | 1658 | 10:04:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:04:13 INFO - PROCESS | 1658 | RSS: Main: 298352640 10:04:13 INFO - PROCESS | 1658 | 10:04:15 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:04:15 INFO - PROCESS | 1658 | RSS: Main: 301748224 10:04:15 INFO - PROCESS | 1658 | 10:04:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:04:19 INFO - PROCESS | 1658 | RSS: Main: 317562880 10:04:19 INFO - PROCESS | 1658 | 10:04:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:04:22 INFO - PROCESS | 1658 | RSS: Main: 311930880 10:04:22 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:04:24 INFO - PROCESS | 1658 | RSS: Main: 356839424 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | __start_tp_report 10:04:24 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:04:24 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:04:24 INFO - PROCESS | 1658 | |i|pagename|runs| 10:04:24 INFO - PROCESS | 1658 | |0;ai-astar;113;113;114;115;114;114;113;114;114;114 10:04:24 INFO - PROCESS | 1658 | |1;audio-beat-detection;166;139;92;163;142;142;112;108;126;107 10:04:24 INFO - PROCESS | 1658 | |2;audio-dft;185;185;186;197;265;210;184;184;182;184 10:04:24 INFO - PROCESS | 1658 | |3;audio-fft;81;59;58;88;61;59;64;78;97;58 10:04:24 INFO - PROCESS | 1658 | |4;audio-oscillator;82;69;87;69;67;69;82;68;69;83 10:04:24 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;86;88;85;88;85;89;86;90;84 10:04:24 INFO - PROCESS | 1658 | |6;imaging-darkroom;97;96;97;97;97;95;96;97;97;97 10:04:24 INFO - PROCESS | 1658 | |7;imaging-desaturate;87;88;86;86;86;85;88;89;88;87 10:04:24 INFO - PROCESS | 1658 | |8;json-parse-financial;58;55;55;53;54;57;58;57;57;56 10:04:24 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;70;68;83;74;73;70;69;69;70;72 10:04:24 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;87;83;83;86;85;87;84;85;86;83 10:04:24 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;142;140;144;142;147;142;143;142;179;151 10:04:24 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;167;168;170;167;174;167;169;167;166;226 10:04:24 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;66;65;67;66;67;66;65;66;65;65 10:04:24 INFO - PROCESS | 1658 | __end_tp_report 10:04:24 INFO - PROCESS | 1658 | __start_cc_report 10:04:24 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1962 10:04:24 INFO - PROCESS | 1658 | __end_cc_report 10:04:24 INFO - PROCESS | 1658 | __startTimestamp1485194664922__endTimestamp 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:04:24 INFO - PROCESS | 1658 | Number of tests: 14 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 10:04:24 INFO - PROCESS | 1658 | Values: 113.0 113.0 114.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:142.00 stddev:24.83 (17.5%) stddev-sans-first:22.60 10:04:24 INFO - PROCESS | 1658 | Values: 166.0 139.0 92.0 163.0 142.0 142.0 112.0 108.0 126.0 107.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:196.20 Median:185.50 stddev:25.66 (13.8%) stddev-sans-first:26.90 10:04:24 INFO - PROCESS | 1658 | Values: 185.0 185.0 186.0 197.0 265.0 210.0 184.0 184.0 182.0 184.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:70.30 Median:71.00 stddev:14.47 (20.4%) stddev-sans-first:14.82 10:04:24 INFO - PROCESS | 1658 | Values: 81.0 59.0 58.0 88.0 61.0 59.0 64.0 78.0 97.0 58.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.50 stddev:7.89 (10.5%) stddev-sans-first:7.89 10:04:24 INFO - PROCESS | 1658 | Values: 82.0 69.0 87.0 69.0 67.0 69.0 82.0 68.0 69.0 83.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:88.00 stddev:1.97 (2.2%) stddev-sans-first:2.05 10:04:24 INFO - PROCESS | 1658 | Values: 88.0 86.0 88.0 85.0 88.0 85.0 89.0 86.0 90.0 84.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:04:24 INFO - PROCESS | 1658 | Values: 97.0 96.0 97.0 97.0 97.0 95.0 96.0 97.0 97.0 97.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.50 stddev:1.25 (1.4%) stddev-sans-first:1.32 10:04:24 INFO - PROCESS | 1658 | Values: 87.0 88.0 86.0 86.0 86.0 85.0 88.0 89.0 88.0 87.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.70 (3.0%) stddev-sans-first:1.64 10:04:24 INFO - PROCESS | 1658 | Values: 58.0 55.0 55.0 53.0 54.0 57.0 58.0 57.0 57.0 56.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.00 stddev:4.37 (6.2%) stddev-sans-first:4.58 10:04:24 INFO - PROCESS | 1658 | Values: 70.0 68.0 83.0 74.0 73.0 70.0 69.0 69.0 70.0 72.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:1.60 (1.9%) stddev-sans-first:1.50 10:04:24 INFO - PROCESS | 1658 | Values: 87.0 83.0 83.0 86.0 85.0 87.0 84.0 85.0 86.0 83.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:143.50 stddev:11.61 (8.1%) stddev-sans-first:12.16 10:04:24 INFO - PROCESS | 1658 | Values: 142.0 140.0 144.0 142.0 147.0 142.0 143.0 142.0 179.0 151.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:168.50 stddev:18.38 (10.9%) stddev-sans-first:19.32 10:04:24 INFO - PROCESS | 1658 | Values: 167.0 168.0 170.0 167.0 174.0 167.0 169.0 167.0 166.0 226.0 10:04:24 INFO - PROCESS | 1658 | 10:04:24 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 10:04:24 INFO - PROCESS | 1658 | Values: 66.0 65.0 67.0 66.0 67.0 66.0 65.0 66.0 65.0 65.0 10:04:24 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:04:24 INFO - PROCESS | 1658 | 10:04:25 INFO - TEST-INFO | 1658: exit 0 10:04:25 INFO - TEST-OK | kraken | took 59313ms 10:04:25 INFO - SUITE-END | took 1177s 10:04:26 INFO - Completed test suite (00:19:37) 10:04:26 INFO - javascript benchmark 10:04:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.163495856119, 3314.806669598944, 3330.966690333096, 3335.5663763710713, 3374.915627109322, 5693.5160511356535, 5745.109508026263, 5752.511036561892, 5773.018586840242, 5773.30720313563, 5694.6867922264255, 5770.451807078321, 5775.797847075353, 5776.0, 5795.565332600051, 5218.478152184789, 5226.973865130679, 5259.263703081571, 5263.789448422059, 5327.227552004957, 5172.741362931857, 5192.1952097424955, 5212.400573933989, 5331.360236771593, 5334.973325133369, 5182.144946083891, 5202.843914682566, 5213.296205012312, 5221.738913054351, 5267.209918512215, 5239.161734122541, 5250.05499010178, 5251.054810134175, 5260.1583746600745, 5320.9467905320835, 5079.3650793650795, 5126.974365128188, 5195.246689230041, 5198.376194856603, 5220.582353411718, 5644.040513112781, 5644.068728659808, 5718.571107166979, 5733.913991290134, 5736.684482353469, 6303.117563541108, 6325.0, 6356.237251529846, 6369.4585960193435, 6376.0, 6306.085617585471, 6356.491480681534, 6398.136251606066, 6413.486921046305, 6414.134091897581, 5740.167675687002, 5775.88448231033, 5790.739416726257, 5892.970535147297, 5942.8811423771285, 6116.143739876421, 6170.074488826712, 6327.462165715873, 6342.334054924258, 6365.554411191265, 6161.075838624242, 6183.412575805291, 6208.0, 6208.627482351073, 6225.844353891189, 6161.0, 6251.874962500725, 6256.249250090018, 6305.873882522324, 6351.428371446592, 6154.19995400604, 6161.84595385119, 6208.192934918432, 6236.0, 6334.239891213084, 6293.2762732285455, 6294.150289710922, 6310.337414571404, 6322.051692246107, 6329.303776584572, 4998.825041123543, 5020.1214787412055, 5029.74851257443, 5033.84898453047, 5048.646594738407, 4393.0, 4436.201483732959, 4471.821127154943, 4477.395551600493, 4478.6864919455975, 4466.307722303049, 5670.858228544319, 5757.740901659436, 5759.539236861125, 5772.365039845614, 6219.315875253718, 6270.6864656766975, 6284.622922624657, 6293.244810622755, 6344.175257216532, 5706.258186435737, 5753.165790960287, 5796.8550786229835, 5803.245578074908, 5833.212516310328, 5394.676319420847, 5460.6996615186545, 5469.316335458067, 5536.640118392292, 5540.141278101901, 6305.085762564494, 6313.5896166749935, 6338.492920566436, 6341.682915854281, 6342.460890824332, 6251.562390632612, 6255.218097737783, 6280.780172693934, 6343.746250149942, 6348.746050158126, 5372.2747429098135, 6371.745130194926, 6385.8722825544155, 6407.295197528175, 6415.06981487691, 6099.359567245376, 6225.8132256032395, 6262.279837818709, 6264.843378915563, 6270.74917003333, 6185.628862268279, 6228.5951413158, 6262.185915830913, 6327.209098862642, 6372.171617689671, 5964.194833697396, 6013.428724271187, 6019.786149695144, 6070.301915279622, 6221.129041934223, 6002.339742628395, 6024.307204671519, 6027.547933904887, 6186.505079593531, 6217.502599791916, 4881.365422495053, 5723.513501352431, 5850.970745146247, 5895.263092113486, 5955.434233747787, 5171.689698618095, 6176.845578860564, 6184.196054512884, 6188.412100850412, 6217.222847144107, 5981.760729570942, 6019.277686677627, 6027.879442411039, 6029.0, 6062.848428789139], "value": 5717.1038980554185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7183658785202, 477.8136526754564, 490.5339927069285, 490.72028943502215, 499.76011514473043, 32397.0, 33140.84007059754, 41154.58845411545, 43379.56620433795, 43427.13145737084, 43510.564894351046, 43778.68663940079, 43836.3424548632, 43872.78063609685, 43896.0, 9433.867935847691, 9675.612975480972, 9677.225821934227, 9683.515824208762, 9700.175485083777, 8482.36382271329, 8694.347923905701, 8699.173578510063, 8799.912000880006, 9490.478023708692, 8644.308455323591, 11341.26281791685, 11593.826092608617, 11622.883771162265, 11788.29270243788, 11195.832062518988, 11311.830322545127, 11508.769824603545, 11534.13493987946, 11543.653690389301, 11322.716932076764, 11324.094072474183, 11425.31448113116, 11462.828057579143, 11521.596744114, 31932.20169495758, 32600.0, 39964.40053399201, 40614.79692601518, 40622.78131656055, 4076.9796151019054, 4079.7960101995077, 4081.4898137732785, 4092.2224777292217, 4106.568810274938, 30153.944611938696, 30259.697403025908, 30352.54471182912, 31173.688263117532, 31750.206244843834, 2906.7674586033067, 2929.8974535891352, 2943.690912454183, 3048.405560915622, 3124.4376012317775, 466005.0, 467120.0, 468146.0, 468474.0, 471297.0, 59890.40109598936, 59954.800903981675, 59988.50028749316, 60120.09219400725, 60234.49413764691, 67981.98027029599, 68275.65862170658, 68314.65842670755, 68368.3163168362, 68399.94800156003, 16850.915745421193, 17087.145642717813, 17103.230354633823, 17135.828641713673, 17175.484735457958, 13125.01562382825, 13209.141405808783, 13247.337633118306, 13247.66880827987, 13268.336583170803, 15589.454369097253, 16141.838581614034, 17874.731879021823, 18291.81708182928, 18313.542161446072, 5811.970940145272, 6060.666663333559, 6869.7595584154315, 6943.548669336477, 7007.509474336849, 749.2881762325703, 868.6959564152496, 895.8880139982502, 921.995390023059, 922.6678395777515, 28550.714492855222, 28848.855755721088, 30607.0, 30660.773569057434, 31390.37219255648, 963.4315753705207, 1037.5849660135855, 1084.34939036579, 1122.9775404492027, 1193.3913704010843, 16052.357905683875, 16066.919665401598, 16297.51407363134, 16321.59196020109, 16358.509244722678, 600182.0, 605577.0, 606535.0, 607457.0, 607562.0, 63390.36609633845, 63444.0, 63475.68262158752, 63562.36437635657, 63631.36368636347, 1415.6531649745878, 1452.9564113076624, 1457.3514785920377, 1466.3621324723779, 1467.0317590390505, 28409.431811363243, 29694.960676376224, 30431.54352684756, 31020.84489577628, 31444.213894652818, 51861.740691296305, 52101.478985209666, 52334.953300933004, 52365.47634523606, 52403.73798130985, 530160.0, 530771.0, 531761.0, 533080.0, 533301.33349333, 41307.0, 41602.791986039876, 42436.78781606072, 42647.360289596305, 42663.57336426596, 36201.637983619825, 36837.81581092077, 50023.499765001885, 50219.748901256724, 53283.93432131258, 38782.6121738779, 39827.80086099551, 40740.0, 41052.1789564213, 42204.36693449662, 40345.59654403418, 40734.59265407308, 41687.37468938029, 41690.79154604208, 42058.78970605128, 38656.8402947912, 38880.86155261488, 39600.40599390954, 39737.2052558953, 39879.80060099681, 34744.652553474145, 35804.10489737673, 36021.0, 36176.819115904254, 36456.08859778527, 26121.216363508363, 26279.868600656875, 26417.33956651099, 26501.19104807226, 26515.867420662773], "value": 20516.74921628801, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.97802723665586, 387.47303667012875, 401.62648736674896, 411.92379409809166, 419.99160016799664, 20379.796202037993, 21605.1357945682, 21769.23807666732, 21857.234996775114, 22082.227122050732, 21157.153713851465, 21647.891760541213, 21693.0, 21934.341969740894, 21937.122515099378, 5358.839234822942, 5825.825225243249, 5873.765049398019, 5881.529477641779, 5885.529157667398, 4123.711340206187, 4304.225239456897, 4345.717528360662, 5716.942830571683, 5839.824805255849, 4348.369486424483, 5448.673079615216, 6407.583507072049, 6414.807555773335, 6417.101605775195, 5637.887242255173, 5900.675462849542, 6407.423331900128, 6410.67946602668, 6431.967840160816, 4932.556069953685, 5159.535641792219, 5736.823951090017, 5880.353161152269, 5898.174255604219, 13512.459501619924, 23363.0, 25146.622800658006, 25981.335506025578, 26190.21429357122, 2509.6110102934076, 2563.873592300445, 2574.8068894832963, 2578.084779903145, 2647.907323243677, 8723.171298726611, 9552.14030737237, 9582.856257156149, 9918.950405248, 10328.967103289686, 1624.6507000994843, 1837.7411473140808, 1852.5276054606124, 1874.2315650583196, 1875.0624687656173, 91842.08157918401, 99423.00576994281, 112404.0, 120107.399463003, 126762.0, 9830.754231144136, 11376.952148613329, 11641.825372619418, 11742.823857642143, 11750.23623464472, 15388.615284617974, 15429.922850385676, 15451.690966180613, 15458.995165314218, 15514.84485155134, 8491.787705307417, 8590.547804493766, 8626.094260102724, 8631.654733810577, 8790.989036260784, 8539.274161696325, 8558.52928088961, 8564.74305770828, 8698.130186981378, 8720.215180633773, 3855.1904100139286, 4670.486246512881, 4678.2280923647895, 4705.047405326751, 4776.522347765195, 1799.2443173867007, 1837.2375464182483, 1992.2031187525106, 2000.479875232421, 2001.9199232030846, 893.9687110951086, 1006.8855403652271, 1028.4343611013912, 1040.484959944832, 1050.4432650695144, 20795.0, 21923.232686855885, 21986.120555177935, 22005.889970550365, 22031.449213769785, 1056.7305337139135, 1057.9206559508068, 1075.1560025380038, 1082.9079528240031, 1100.0979197058496, 11007.944960275147, 11223.933726296153, 11405.0, 11420.771584568261, 11436.741958384571, 679229.0, 708339.0, 730681.0, 773954.0, 782294.0, 125482.0, 132008.3399582996, 134947.0, 137452.62547374598, 147886.0, 995.5161871131573, 1016.5832008876325, 1023.4371095897227, 1024.139722632977, 1027.547878933282, 16647.3341066356, 17371.131443428032, 17408.39070632522, 18656.813431865507, 19143.52141196481, 45092.0, 55249.89500209893, 55835.16247256376, 56091.71954140203, 56596.71701641465, 76067.23932760602, 78101.70234820341, 79696.0, 80107.19892800998, 80282.79575806251, 5783.971080144573, 6137.815865524041, 6841.486888483483, 7502.662380192795, 7654.8086297843, 9263.305252106255, 12096.334701591144, 12910.289934053717, 13287.66780830487, 13309.800352994907, 10876.619318323821, 11016.394098324348, 11146.108311334912, 11359.432028398382, 11398.544058237909, 10621.734456638645, 10707.464626768786, 10820.837687434538, 10840.945795270973, 11373.715657108638, 6531.934680653133, 11202.21584489078, 11420.71448213768, 11724.58963936258, 11903.642890713292, 7350.889736654061, 7437.851242975218, 7452.105747310141, 7634.694612215671, 7654.15804261542, 9962.252831037556, 11040.392778397265, 11046.447677615926, 11348.659540213806, 11407.714807129889], "value": 9599.788311371676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.504750860954, 1442.2212005517022, 1443.2567227877641, 1460.1895947749, 1466.486729644624, 8081.757547273576, 8504.872426913586, 8514.787130321738, 8520.701775437861, 8521.318294536437, 7456.217097204797, 7743.341815945651, 7750.651220695068, 8048.758537243877, 8264.504129752218, 2289.2102224732485, 2307.561563302967, 2314.5602335556273, 2317.5596636638984, 2318.6058370077126, 2316.108298305148, 2335.2643917166124, 2350.6591544226076, 2352.7882490575844, 2353.9882300588474, 2284.5088306014204, 2294.850834695748, 2303.424143964009, 2328.161861729776, 2331.813454923602, 2197.5934452126407, 2205.9227927022475, 2232.8771917544527, 2237.518933429304, 2282.657601359793, 2070.968935465969, 2265.2184996176293, 2292.33522278539, 2338.3452633262714, 2340.2511196417154, 8424.705135320295, 8490.40567160299, 8515.53164575948, 8523.95738021306, 8531.74404767858, 5015.0, 5181.326427564431, 5182.274481572583, 5190.351206099238, 5201.55786758126, 3166.145140811991, 3252.8536215870345, 3366.932661346784, 3425.554677891883, 3432.3135372925267, 1119.5074167366415, 1128.644476989754, 1161.0595417711681, 1176.1649229047387, 1182.911281653871, 10953.507092180791, 10962.123030157569, 11092.33445993235, 11095.778084438267, 11098.44507774616, 4415.558444155558, 4648.86053418398, 4696.342512048316, 4732.976335118303, 4735.644826638016, 9664.226861851175, 9669.516524173903, 9679.225661947168, 9688.95155524232, 9702.320837541305, 5191.273221748958, 5234.42421333653, 5235.528802407725, 5244.213367994831, 5245.423003469616, 4226.513950895686, 4365.628921541705, 4515.909681806345, 4615.861524154281, 4680.15757163707, 3856.5950575189763, 3873.903152421212, 3925.980370098131, 3978.840846366171, 3986.3023970804993, 1266.1073942870255, 1268.3341245846004, 1270.0665011216747, 1281.7628738683372, 1283.3390803736083, 911.5715613661569, 917.9260265489394, 920.7099763574453, 925.9074092590687, 953.5518306395983, 5615.298087739033, 5825.621334613236, 5834.5624078194305, 5903.6457812530525, 6151.9692401538605, 956.2780101023683, 987.0573602210015, 990.9207263418909, 1012.0688966151158, 1020.4234607446768, 3717.7955212463035, 3856.3444214483607, 3921.509811273591, 3948.151147503243, 3956.643902048829, 9938.453385063747, 10268.691939241835, 10288.639897603698, 10295.176385889261, 10303.536340864679, 9264.583093760797, 9654.27592930519, 9895.455749933679, 10052.949735251277, 10056.547455364525, 7726.9227307726205, 7861.724839630586, 7947.483413578099, 8008.559529225949, 8009.0789559200275, 5711.371749107678, 5723.771049157987, 5854.356020837619, 5913.02435098204, 5949.464548190684, 9121.224695900657, 9223.262139028995, 9343.29925255595, 9371.625134994796, 9446.574904129193, 9476.194523465583, 9489.762755931157, 9534.380265282734, 9564.76088097803, 9601.183899368632, 6710.362515561014, 6738.59568425896, 6979.965100174467, 7301.671424785791, 7466.029416176079, 6625.900611490735, 8124.471909325875, 8134.796630084295, 8138.982627171604, 8154.714584989497, 7088.362047415551, 7204.603746793767, 7238.02286691311, 7243.927560724536, 7324.560526368435, 7004.089468369079, 7056.188538317954, 7069.363757261871, 7179.784606461814, 7239.529430586995, 6334.3665633436285, 6351.587146835441, 6487.253965793994, 6499.805005849832, 6502.577332473374, 4907.018596280686, 5019.247112933089, 5047.697138171721, 5083.440821509705, 5110.795568177231, 4630.0, 4686.859394218179, 4697.177993851131, 4825.855224343135, 4873.293372461044], "value": 4450.881687009968, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.96734842841516, 341.1879726251521, 355.5306994766907, 366.730453116959, 373.7944130728099, 5267.604929630274, 5295.523402893744, 5320.98901208771, 5330.920036199455, 5359.758810853511, 5235.827131740323, 5277.366715994077, 5297.682139071659, 5310.548603368708, 5347.866303342409, 3526.4886591444224, 3932.2528719543197, 4089.5501494835544, 4105.568915263899, 4210.831566737327, 4147.3617920921215, 4208.431861698662, 4210.63149480416, 4219.480986844734, 4230.640395566381, 3658.6158453362414, 4172.582741725818, 4209.810558524859, 4210.3894935234375, 4223.197592457439, 3957.426173204869, 4091.89770255743, 4125.360569111793, 4220.936685949713, 4233.809478573472, 3633.218857945528, 3654.9086272843124, 3672.669459748609, 3675.9707281961096, 3703.2408356286896, 4483.820647174109, 4706.199946009152, 4993.553158952123, 5040.974795126038, 5203.479652034766, 4327.783610819446, 4688.835890743841, 4823.710577365369, 4851.296561998491, 4899.265110233458, 4567.817287308504, 4787.784549695237, 5163.7676304566385, 5674.687892165971, 5690.573207009491, 4080.9387859182134, 4102.0, 4104.733192342518, 4146.543880173179, 4160.854370097032, 4862.5623693867365, 5043.722595257259, 5633.60564760467, 5769.567282453832, 6063.636181829104, 3246.338002837698, 3305.735541156702, 4050.9594904051173, 4139.3583994480905, 4176.9582304177175, 3552.8401221945073, 3592.5329707137903, 4201.369794530845, 4228.344606585984, 4258.425112609758, 3995.9600403995587, 4102.876913692594, 4672.2991551266905, 4820.903581928342, 4868.488808675109, 5595.342212449054, 5608.0, 5620.5503559715125, 5624.521915637217, 5639.238702775073, 1105.9391733454577, 1358.361570062089, 1369.698666293414, 1378.9655258618616, 1384.3977869626744, 911.5235870911558, 959.9872134897611, 963.2390411574918, 968.1286841842398, 974.3715303629119, 4131.772752498641, 4265.0144898571125, 4277.331840582176, 4962.305277261186, 4977.104121258209, 4199.664026877843, 4822.324874517501, 5217.912834866008, 5421.484958928895, 5512.0, 4462.888427789331, 4792.0, 4949.0, 5012.523810238022, 5038.3198268234055, 2443.8655873927105, 2445.3886528367907, 2638.4591158812395, 2870.8373108890933, 2956.926076848096, 4676.158291507561, 5314.48268971379, 5363.03465376236, 5753.539716822645, 5789.478946894716, 5258.609061433669, 5303.549198318186, 5314.12316967696, 5690.459406356389, 5763.9135412968835, 5666.801661941812, 5711.457411545896, 5713.257276554022, 5732.05421105513, 5786.3056433228285, 4701.531695859701, 5208.718507340352, 5344.75948582307, 5569.331680198402, 5573.903181161924, 5079.044567841333, 5126.077306084941, 5803.7968671096305, 5840.225892700933, 5850.678212698343, 5332.920006199833, 5896.17453556511, 5943.940560594338, 6031.155638210566, 6043.758249669964, 4239.47006624172, 4245.172191422643, 4276.166147601312, 4289.206496798102, 4296.763677997615, 5175.549027835983, 5734.827955161351, 5855.824325270249, 5874.383189765013, 5957.672328022, 4943.8516844494725, 5609.298837645294, 5683.318001839806, 5709.7430615623225, 5758.856028599319, 4526.932096018497, 5422.48486393792, 5545.807651354817, 5625.921207124802, 5638.520725738194, 4593.931091033571, 5523.254360661259, 5540.14127810174, 5587.882423515394, 5592.636478628876, 5283.260343551829, 5383.7846486140115, 5661.745221464962, 5713.542916566582, 5736.5410767139365, 4617.12274667812, 4868.417764226711, 4900.0, 5227.686338819683, 5581.832545023493], "value": 4106.164515337477, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.8128486593484, 730.0290613484063, 779.5478622399008, 791.2483141016032, 837.3217693668128, 15004.774928376082, 15585.84414155858, 15882.126483043428, 15933.44232951847, 16002.759958600616, 13563.118397304193, 14512.0, 14568.562943111698, 14650.560483185494, 14821.333040013198, 868.4919322196507, 880.6477409036405, 883.3066043156124, 885.4598694796169, 886.57887503436, 870.7126648206076, 874.3660845886714, 875.6191056890241, 877.8244351129767, 877.934154938379, 918.2608000559546, 919.429953428875, 920.0017980491175, 921.3964853021282, 922.0871337376017, 913.5204017890594, 915.2083447817656, 915.3226612306911, 917.2341095185528, 917.5228880981919, 688.5042769206163, 689.1454596300601, 690.9378155965987, 692.2039654397433, 692.9480288978297, 11184.496697648545, 11311.321320720783, 13162.670933226651, 13484.0, 13488.730225395437, 12066.276023438622, 12189.512419503299, 12247.75504489914, 12442.937785311016, 12479.75040499194, 10731.517081731341, 10745.301555398873, 10898.836517452244, 11095.72260693481, 11206.439678016066, 3162.908796465216, 3598.4062629666073, 3610.9277814443826, 3649.4708267301357, 3731.738778285521, 63798.681006595136, 81573.0, 95849.5207523958, 101650.0, 111402.44298778454, 11188.608398706006, 11432.313406349502, 11641.47613357401, 11779.469923853447, 11810.52757889692, 23386.7661323388, 23578.29265122049, 23631.881840590686, 23958.0, 23986.640200397007, 8092.352611791042, 8108.675652973815, 8129.0, 8188.631511581993, 8250.669973201126, 4223.239816832938, 4261.169072030986, 4388.473383193973, 4409.977950110229, 4450.399196108484, 3453.3783918894337, 3571.767835090711, 3575.1419659281587, 3582.7133829293593, 3592.191756854739, 640.0974625777632, 640.7052755732323, 641.868416974519, 664.9933500665028, 671.2716702377877, 538.978440862369, 550.6998685716214, 558.2999765713413, 579.2759051186017, 580.1558732044865, 9216.585253663601, 10285.0, 10295.794084118275, 10335.638252661121, 10465.47672616366, 651.563452486835, 675.9121314229217, 677.1604999651985, 685.9005444210661, 691.5850489706136, 4634.490206077397, 4919.483454237254, 4922.827701030446, 4926.802927882844, 4928.778204980785, 92564.0, 93105.0, 94992.57511137339, 96670.48453762235, 106962.3955640666, 70074.0, 78339.82490262651, 81191.5940420306, 83415.0, 89225.0, 66945.6652716743, 77434.61282693551, 80761.19238807536, 83797.0, 84055.89860253542, 10746.623868164577, 11413.906391987259, 11595.594154204562, 11625.825612615987, 11661.300321980709, 47279.29081063856, 51406.0, 52053.0, 52526.0, 52541.47458525366, 62195.44511387071, 63074.68462657657, 65844.0, 67230.66384668046, 68795.31204688089, 13570.982176336616, 13747.931260343634, 13802.585922422344, 14115.364808583843, 14196.219207943663, 14433.855661443671, 14646.121232726071, 14860.0, 15077.773833392728, 15863.444779432664, 12898.355082245662, 13340.599782006168, 14206.509360452073, 14714.0, 14734.705305894036, 13153.21080735159, 13373.933130334286, 13375.866241337852, 13769.257137747123, 14264.001519893924, 13212.339383030618, 13477.797833032708, 13624.727505449637, 13660.93169534146, 13982.44070237179, 11348.432578371214, 11410.0, 11953.940230298793, 12115.273083615011, 12169.452374643339, 9866.654667086617, 9977.501124943868, 10927.617533386294, 11193.440327983732, 11208.831867522156], "value": 7477.360093695967, "unit": "score"}], "name": "dromaeo_css", "value": 7320.444759826189, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 139.0, 92.0, 163.0, 142.0, 142.0, 112.0, 108.0, 126.0, 107.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 186.0, 197.0, 265.0, 210.0, 184.0, 184.0, 182.0, 184.0], "value": 196.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 61.0, 59.0, 64.0, 78.0, 97.0, 58.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 87.0, 69.0, 67.0, 69.0, 82.0, 68.0, 69.0, 83.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 88.0, 85.0, 89.0, 86.0, 90.0, 84.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 95.0, 96.0, 97.0, 97.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 86.0, 86.0, 85.0, 88.0, 89.0, 88.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 53.0, 54.0, 57.0, 58.0, 57.0, 57.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 83.0, 74.0, 73.0, 70.0, 69.0, 69.0, 70.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 83.0, 86.0, 85.0, 87.0, 84.0, 85.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 140.0, 144.0, 142.0, 147.0, 142.0, 143.0, 142.0, 179.0, 151.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 170.0, 167.0, 174.0, 167.0, 169.0, 167.0, 166.0, 226.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1454.8, "alertThreshold": 2.0}]} 10:04:26 INFO - Return code: 0 10:04:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:04:26 ERROR - # TBPL SUCCESS # 10:04:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:04:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:04:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:04:26 INFO - 2017-01-23 10:04:26.211 screenresolution[1662:10295] starting screenresolution argv=screenresolution get 10:04:26 INFO - 2017-01-23 10:04:26.214 screenresolution[1662:10295] Display 0: 1600x1200x32@60 10:04:26 INFO - 2017-01-23 10:04:26.221 screenresolution[1663:10298] starting screenresolution argv=screenresolution list 10:04:26 INFO - Available Modes on Display 0 10:04:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:04:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:04:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:04:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:04:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:04:26 INFO - Intel Iris: 10:04:26 INFO - Chipset Model: Intel Iris 10:04:26 INFO - Type: GPU 10:04:26 INFO - Bus: Built-In 10:04:26 INFO - VRAM (Dynamic, Max): 1536 MB 10:04:26 INFO - Vendor: Intel (0x8086) 10:04:26 INFO - Device ID: 0x0a2e 10:04:26 INFO - Revision ID: 0x0009 10:04:26 INFO - Displays: 10:04:26 INFO - Display: 10:04:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:04:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:04:26 INFO - Display Serial Number: 1600x1200 60 10:04:26 INFO - Main Display: Yes 10:04:26 INFO - Mirror: Off 10:04:26 INFO - Online: Yes 10:04:26 INFO - Rotation: Supported 10:04:26 INFO - Return code: 0 10:04:26 INFO - Running post-action listener: _resource_record_post_action 10:04:26 INFO - [mozharness: 2017-01-23 18:04:26.456632Z] Finished run-tests step (success) 10:04:26 INFO - Running post-run listener: _resource_record_post_run 10:04:26 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 38048768; Write bytes: 508883456; Read time: 244; Write time: 1587 10:04:26 INFO - TinderboxPrint: CPU usage
53.5% 10:04:26 INFO - TinderboxPrint: I/O read bytes / time
38,048,768 / 244 10:04:26 INFO - TinderboxPrint: I/O write bytes / time
508,883,456 / 1,587 10:04:26 INFO - TinderboxPrint: CPU idle
2,229.1 (46.5%) 10:04:26 INFO - TinderboxPrint: CPU system
959.8 (20.0%) 10:04:26 INFO - TinderboxPrint: CPU user
1,604.8 (33.5%) 10:04:26 INFO - TinderboxPrint: Swap in / out
245,129,216 / 0 10:04:26 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 199977472; Write bytes: 198623232; Read time: 15333; Write time: 431 10:04:26 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37110784; Write bytes: 300446208; Read time: 231; Write time: 1126 10:04:26 INFO - Running post-run listener: _upload_blobber_files 10:04:26 INFO - Blob upload gear active. 10:04:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:04:26 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 10:04:26 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'] 10:04:26 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 10:04:27 INFO - (blobuploader) - INFO - Open directory for files ... 10:04:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:04:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:04:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:28 INFO - (blobuploader) - INFO - Done attempting. 10:04:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:04:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:04:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:29 INFO - (blobuploader) - INFO - Done attempting. 10:04:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:04:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:04:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:30 INFO - (blobuploader) - INFO - Done attempting. 10:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:04:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:04:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:04:32 INFO - (blobuploader) - INFO - Done attempting. 10:04:32 INFO - (blobuploader) - INFO - Iteration through files over. 10:04:32 INFO - Return code: 0 10:04:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:04:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:04:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a08a1e6cd724f13064bd0b3079d16a5aaf7d28caa0f4a198bc616df32346ce1327be3f8d83f64e603bae8b32c00c801fb6fe136009b459af9a4b1dc564b43366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c3fd094a55da11ea5db034069c5d74e6df71d8f19b41e74cf639be716f0235302bf97f9e5f9488867a08e9e068535f295a0670743f6126c3de31e1d8017a2c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d84e49d7b942323225c4ff8014f7ad474900d090079c25458928e9750d196ac96d35a6a36c0bf9ffcc7286904e05a2b426ffe95870aaadf5eba0cad3e37fe55", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e776188b03bcd50ef804093278272c5cbc5f23470338aaafb42dbf278da2d4a7a554bf83ba1d83b58567f5374fe883c8913c96148a275a2704e83934e36525d"} 10:04:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:04:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:04:32 INFO - Contents: 10:04:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a08a1e6cd724f13064bd0b3079d16a5aaf7d28caa0f4a198bc616df32346ce1327be3f8d83f64e603bae8b32c00c801fb6fe136009b459af9a4b1dc564b43366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c3fd094a55da11ea5db034069c5d74e6df71d8f19b41e74cf639be716f0235302bf97f9e5f9488867a08e9e068535f295a0670743f6126c3de31e1d8017a2c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d84e49d7b942323225c4ff8014f7ad474900d090079c25458928e9750d196ac96d35a6a36c0bf9ffcc7286904e05a2b426ffe95870aaadf5eba0cad3e37fe55", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e776188b03bcd50ef804093278272c5cbc5f23470338aaafb42dbf278da2d4a7a554bf83ba1d83b58567f5374fe883c8913c96148a275a2704e83934e36525d"} 10:04:32 INFO - Running post-run listener: copy_logs_to_upload_dir 10:04:32 INFO - Copying logs to upload dir... 10:04:32 INFO - mkdir: /builds/slave/test/build/upload/logs 10:04:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.506455 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-23 10:04:32.627855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 10:04:32.631866) ========= 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.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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/a08a1e6cd724f13064bd0b3079d16a5aaf7d28caa0f4a198bc616df32346ce1327be3f8d83f64e603bae8b32c00c801fb6fe136009b459af9a4b1dc564b43366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c3fd094a55da11ea5db034069c5d74e6df71d8f19b41e74cf639be716f0235302bf97f9e5f9488867a08e9e068535f295a0670743f6126c3de31e1d8017a2c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d84e49d7b942323225c4ff8014f7ad474900d090079c25458928e9750d196ac96d35a6a36c0bf9ffcc7286904e05a2b426ffe95870aaadf5eba0cad3e37fe55", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e776188b03bcd50ef804093278272c5cbc5f23470338aaafb42dbf278da2d4a7a554bf83ba1d83b58567f5374fe883c8913c96148a275a2704e83934e36525d"} build_url:https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010658 build_url: 'https://queue.taskcluster.net/v1/task/A6giWoWORjab_2xqIkEh5g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a08a1e6cd724f13064bd0b3079d16a5aaf7d28caa0f4a198bc616df32346ce1327be3f8d83f64e603bae8b32c00c801fb6fe136009b459af9a4b1dc564b43366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c3fd094a55da11ea5db034069c5d74e6df71d8f19b41e74cf639be716f0235302bf97f9e5f9488867a08e9e068535f295a0670743f6126c3de31e1d8017a2c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d84e49d7b942323225c4ff8014f7ad474900d090079c25458928e9750d196ac96d35a6a36c0bf9ffcc7286904e05a2b426ffe95870aaadf5eba0cad3e37fe55", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e776188b03bcd50ef804093278272c5cbc5f23470338aaafb42dbf278da2d4a7a554bf83ba1d83b58567f5374fe883c8913c96148a275a2704e83934e36525d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 10:04:32.665193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:04:32.665525) ========= 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.L8CKjPezbb/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.tfUpsXxeEj/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005353 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 10:04:32.714329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 10:04:32.714919) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 10:04:32.715234) ========= ========= Total master_lag: 0.18 =========