JUnit version 4.13.2
.18:51:11.009 [INFO - main] (RandomUtils.java:49) Using random seed: 1786474271004
18:51:11.025 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:51:11.080 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:51:11.090 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskCqFHaa/test-tmp
18:51:11.093 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
18:51:11.097 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskCqFHaa/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
18:51:11.331 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398"
  extra_master_flags: "--authn_token_validity_seconds=1"
  extra_master_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--rpc_inject_invalid_authn_token_ratio=0.5"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:51:11.345 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:51:11.347 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:51:11.348 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:11.348230 24335 mini_oidc.cc:152] Starting JWKS server
18:51:11.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:11.349444 24335 webserver.cc:460] Webserver started at http://127.0.0.1:46063/ using document root <none> and password file <none>
18:51:11.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:11.349570 24335 mini_oidc.cc:189] Starting OIDC Discovery server
18:51:11.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:11.349807 24335 webserver.cc:460] Webserver started at http://127.0.0.1:35035/ using document root <none> and password file <none>
18:51:11.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
18:51:11.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/principal' for realm 'KRBTEST.COM',
18:51:11.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
18:51:11.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:11 dist-test-slave-bndk krb5kdc[24350](info): setting up network...
18:51:11.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
18:51:11.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:11 dist-test-slave-bndk krb5kdc[24350](info): set up 2 sockets
18:51:11.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:11 dist-test-slave-bndk krb5kdc[24350](info): commencing operation
18:51:11.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
18:51:12.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.606802 24335 mini_kdc.cc:121] Time spent starting KDC: real 1.251s	user 0.002s	sys 0.004s
18:51:12.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
18:51:12.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:51:12.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
18:51:12.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
18:51:12.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:51:12.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
18:51:12.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
18:51:12.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:51:12.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
18:51:12.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
18:51:12.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/test-user.keytab.
18:51:12.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal test-user with kvno 1, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/test-user.keytab.
18:51:12.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:12 dist-test-slave-bndk krb5kdc[24350](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474272, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:51:12.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
18:51:12.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:51:12Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
18:51:12.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:51:12Z Disabled control of system clock
18:51:12.714 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.23.195.254@KRBTEST.COM; defaulting to no policy
18:51:12.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:12.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.23.195.254@KRBTEST.COM" created.
18:51:12.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:12.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.254.keytab.
18:51:12.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.254.keytab.
18:51:12.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.732551 24335 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:12.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:12.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/logs
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data/info.pb
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:51:12.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.254:33103
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.254
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.254.keytab
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.254
18:51:12.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.23.195.254:33103
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46063/jwks.json
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
18:51:12.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:51:12.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.820324 24366 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:51:12.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.820557 24366 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:51:12.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.820581 24366 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821767 24366 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821811 24366 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821825 24366 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821838 24366 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821851 24366 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821861 24366 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
18:51:12.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.821871 24366 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46063/jwks.json
18:51:12.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.823593 24366 master_runner.cc:386] Master server non-default flags:
18:51:12.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.23.195.254:33103
18:51:12.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.254.keytab
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.254
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.254:33103
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:51:12.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46063/jwks.json
18:51:12.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:12.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data/info.pb
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.254
18:51:12.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:12.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:51:12.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.24366
18:51:12.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:12.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:51:12.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/logs
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:51:12.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 17:59:43 UTC on ccycloud.quasar-xuakos.root.comops.site
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581133
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.823822 24366 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.824062 24366 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.829296 24366 server_base.cc:1034] running on GCE node
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.829397 24377 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.829357 24378 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.829277 24380 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.829797 24366 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:51:12.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.830259 24366 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:51:12.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.831436 24366 hybrid_clock.cc:648] HybridClock initialized: now 1786474272831411 us; error 74 us; skew 500 ppm
18:51:12.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:12 dist-test-slave-bndk krb5kdc[24350](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474272, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:51:12.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.834019 24366 init.cc:377] Logged in from keytab as kudu/127.23.195.254@KRBTEST.COM (short username kudu)
18:51:12.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.834487 24366 webserver.cc:460] Webserver started at http://127.23.195.254:44193/ using document root <none> and password file <none>
18:51:12.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.834671 24366 fs_manager.cc:359] Metadata directory not provided
18:51:12.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.834709 24366 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:51:12.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.834801 24366 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.835865 24366 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data/instance:
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "124f1d5351104b7aa579f2fa84f9cf2a"
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:12 on dist-test-slave-bndk"
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.836196 24366 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal/instance:
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "124f1d5351104b7aa579f2fa84f9cf2a"
18:51:12.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:12 on dist-test-slave-bndk"
18:51:12.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.837790 24366 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
18:51:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.838557 24393 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:51:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.838807 24366 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:51:12.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.838897 24366 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data,/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "124f1d5351104b7aa579f2fa84f9cf2a"
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:12 on dist-test-slave-bndk"
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.838964 24366 fs_report.cc:383] FS layout report
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data/data
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:51:12.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:51:12.840 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:51:12.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.847919 24366 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:51:12.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.850652 24366 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:51:12.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.850806 24366 kserver.cc:163] Server-wide thread pool size limit: 3276
18:51:12.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.855087 24366 rpc_server.cc:307] RPC server started. Bound to: 127.23.195.254:33103
18:51:12.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.855135 24469 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.23.195.254:33103 every 8 connection(s)
18:51:12.856 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.855858 24366 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/data/info.pb
18:51:12.857 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.856818 24470 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:51:12.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.859216 24470 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: Bootstrap starting.
18:51:12.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.859890 24470 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: Neither blocks nor log segments found. Creating new log.
18:51:12.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.860242 24470 log.cc:824] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: Log is configured to *not* fsync() on all Append() calls
18:51:12.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.860538 24335 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskCqFHaa/build/release/bin/kudu as pid 24366
18:51:12.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.860656 24335 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/master-0/wal/instance
18:51:12.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.861012 24470 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: No bootstrap required, opened a new log
18:51:12.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.863170 24470 raft_consensus.cc:348] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } }
18:51:12.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.863339 24470 raft_consensus.cc:374] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:51:12.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.863374 24470 raft_consensus.cc:729] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 124f1d5351104b7aa579f2fa84f9cf2a, State: Initialized, Role: FOLLOWER
18:51:12.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.863500 24470 consensus_queue.cc:260] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } }
18:51:12.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.864085 24470 raft_consensus.cc:388] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
18:51:12.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.864125 24470 raft_consensus.cc:482] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
18:51:12.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.864156 24470 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 0 FOLLOWER]: Advancing to term 1
18:51:12.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.864815 24470 raft_consensus.cc:504] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } }
18:51:12.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.864949 24470 leader_election.cc:302] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 124f1d5351104b7aa579f2fa84f9cf2a; no voters: 
18:51:12.865 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.865120 24470 leader_election.cc:288] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [CANDIDATE]: Term 1 election: Requested vote from peers 
18:51:12.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.865406 24470 sys_catalog.cc:564] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [sys.catalog]: configured and running, proceeding with master startup.
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.866791 24476 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 1 FOLLOWER]: Leader election won for term 1
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867033 24476 raft_consensus.cc:686] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [term 1 LEADER]: Becoming Leader. State: Replica: 124f1d5351104b7aa579f2fa84f9cf2a, State: Running, Role: LEADER
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867146 24476 consensus_queue.cc:237] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } }
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867468 24476 sys_catalog.cc:455] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } } }
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867539 24476 sys_catalog.cc:458] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [sys.catalog]: This master's current role is: LEADER
18:51:12.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867650 24476 sys_catalog.cc:455] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [sys.catalog]: SysCatalogTable state changed. Reason: New leader 124f1d5351104b7aa579f2fa84f9cf2a. Latest consensus state: current_term: 1 leader_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "124f1d5351104b7aa579f2fa84f9cf2a" member_type: VOTER last_known_addr { host: "127.23.195.254" port: 33103 } } }
18:51:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.867697 24476 sys_catalog.cc:458] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a [sys.catalog]: This master's current role is: LEADER
18:51:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.868295 24492 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:51:12.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:12.868353 24492 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:51:12.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.868897 24498 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
18:51:12.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.869076 24498 catalog_manager.cc:1484] Initializing Kudu cluster ID...
18:51:12.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.870878 24498 catalog_manager.cc:1347] Generated new cluster ID: f894a006879f4cbeb15ca2d1ca78ca67
18:51:12.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.870942 24498 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
18:51:12.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:12 dist-test-slave-bndk krb5kdc[24350](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474272, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.23.195.254@KRBTEST.COM
18:51:12.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.891093 24498 catalog_manager.cc:1370] Generated new certificate authority record
18:51:12.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.891758 24498 catalog_manager.cc:1504] Loading token signing keys...
18:51:12.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.896953 24498 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: Generated new TSK 0
18:51:12.897 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.897193 24498 catalog_manager.cc:1514] Initializing in-progress tserver states...
18:51:12.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.23.195.193@KRBTEST.COM; defaulting to no policy
18:51:12.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:12.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.23.195.193@KRBTEST.COM" created.
18:51:12.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:12.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.193.keytab.
18:51:12.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.193.keytab.
18:51:12.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:12.932950 24335 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:12.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/logs
18:51:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data/info.pb
18:51:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:12.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:51:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:51:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:51:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:51:12.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.193:0
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.193
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.193
18:51:12.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.193.keytab
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.193
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:12.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:12.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:51:13.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.020815 24507 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.021103 24507 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:51:13.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.021127 24507 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:51:13.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.021154 24507 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:51:13.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.022652 24507 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:51:13.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.022728 24507 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.23.195.193
18:51:13.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.024467 24507 tablet_server_runner.cc:78] Tablet server non-default flags:
18:51:13.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:13.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.193.keytab
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.193
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.193:0
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:13.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data/info.pb
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.193
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.24507
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:51:13.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.193
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/logs
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:51:13.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:51:13.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:51:13.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 17:59:43 UTC on ccycloud.quasar-xuakos.root.comops.site
18:51:13.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581133
18:51:13.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.024741 24507 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:51:13.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.025034 24507 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:51:13.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.030635 24518 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.030592 24521 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.030754 24523 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.031152 24507 server_base.cc:1034] running on GCE node
18:51:13.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.031474 24507 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:51:13.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.031805 24507 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:51:13.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.033195 24507 hybrid_clock.cc:648] HybridClock initialized: now 1786474273033170 us; error 43 us; skew 500 ppm
18:51:13.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:51:13.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.036007 24507 init.cc:377] Logged in from keytab as kudu/127.23.195.193@KRBTEST.COM (short username kudu)
18:51:13.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.036559 24507 webserver.cc:460] Webserver started at http://127.23.195.193:44905/ using document root <none> and password file <none>
18:51:13.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.036854 24507 fs_manager.cc:359] Metadata directory not provided
18:51:13.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.036922 24507 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:51:13.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.037063 24507 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.038125 24507 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data/instance:
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1aeb65c8d34b4cb8b809819b87272706"
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.038503 24507 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal/instance:
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1aeb65c8d34b4cb8b809819b87272706"
18:51:13.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.040009 24507 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.040880 24533 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.041070 24507 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.041167 24507 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data,/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "1aeb65c8d34b4cb8b809819b87272706"
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.041273 24507 fs_report.cc:383] FS layout report
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal
18:51:13.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data/data
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:51:13.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:51:13.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.054800 24507 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:51:13.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.056984 24507 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057134 24507 kserver.cc:163] Server-wide thread pool size limit: 3276
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057466 24507 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057858 24507 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057894 24507 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057922 24507 ts_tablet_manager.cc:610] Registered 0 tablets
18:51:13.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.057938 24507 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:51:13.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.063699 24507 rpc_server.cc:307] RPC server started. Bound to: 127.23.195.193:41165
18:51:13.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.063759 24703 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.23.195.193:41165 every 8 connection(s)
18:51:13.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.064353 24507 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/data/info.pb
18:51:13.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.068984 24335 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskCqFHaa/build/release/bin/kudu as pid 24507
18:51:13.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.069078 24335 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal/instance
18:51:13.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.193@KRBTEST.COM for kudu/127.23.195.254@KRBTEST.COM
18:51:13.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.076076 24704 heartbeater.cc:347] Connected to a master server at 127.23.195.254:33103
18:51:13.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.076220 24704 heartbeater.cc:464] Registering TS with master...
18:51:13.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.076458 24704 heartbeater.cc:511] Master 127.23.195.254:33103 requested a full tablet report, sending...
18:51:13.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.077148 24419 ts_manager.cc:194] Registered new tserver with Master: 1aeb65c8d34b4cb8b809819b87272706 (127.23.195.193:41165)
18:51:13.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.078246 24419 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.23.195.193@KRBTEST.COM'} at 127.23.195.193:52765
18:51:13.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.23.195.194@KRBTEST.COM; defaulting to no policy
18:51:13.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:13.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.23.195.194@KRBTEST.COM" created.
18:51:13.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.194.keytab.
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.194.keytab.
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.103351 24335 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:51:13.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/logs
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data/info.pb
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:51:13.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.194:0
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.194
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.194
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.194.keytab
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.194
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:13.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:13.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:51:13.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.187987 24710 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.188258 24710 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:51:13.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.188278 24710 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:51:13.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.188300 24710 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:51:13.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.189495 24710 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:51:13.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.189545 24710 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.23.195.194
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.191061 24710 tablet_server_runner.cc:78] Tablet server non-default flags:
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.194.keytab
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.194
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.194:0
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:13.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data/info.pb
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.194
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.24710
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:51:13.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.194
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/logs
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 17:59:43 UTC on ccycloud.quasar-xuakos.root.comops.site
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581133
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.191290 24710 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:51:13.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.191494 24710 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:51:13.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.197391 24717 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.197542 24716 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.197970 24710 server_base.cc:1034] running on GCE node
18:51:13.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.197690 24721 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.198463 24710 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:51:13.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.198712 24710 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:51:13.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.199874 24710 hybrid_clock.cc:648] HybridClock initialized: now 1786474273199853 us; error 29 us; skew 500 ppm
18:51:13.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:51:13.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.203187 24710 init.cc:377] Logged in from keytab as kudu/127.23.195.194@KRBTEST.COM (short username kudu)
18:51:13.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.203743 24710 webserver.cc:460] Webserver started at http://127.23.195.194:36689/ using document root <none> and password file <none>
18:51:13.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.204033 24710 fs_manager.cc:359] Metadata directory not provided
18:51:13.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.204092 24710 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:51:13.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.204243 24710 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.205343 24710 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data/instance:
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc20aac95585490a8160eec9371642c2"
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.205708 24710 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal/instance:
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc20aac95585490a8160eec9371642c2"
18:51:13.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.207051 24710 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
18:51:13.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.207799 24734 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.207988 24710 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.208086 24710 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data,/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cc20aac95585490a8160eec9371642c2"
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.208158 24710 fs_report.cc:383] FS layout report
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data/data
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:51:13.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:51:13.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:51:13.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.221700 24710 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:51:13.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.224134 24710 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:51:13.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.224298 24710 kserver.cc:163] Server-wide thread pool size limit: 3276
18:51:13.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.224589 24710 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:51:13.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.225028 24710 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:51:13.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.225071 24710 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:51:13.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.225103 24710 ts_tablet_manager.cc:610] Registered 0 tablets
18:51:13.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.225118 24710 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:51:13.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.231613 24710 rpc_server.cc:307] RPC server started. Bound to: 127.23.195.194:37807
18:51:13.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.231662 24911 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.23.195.194:37807 every 8 connection(s)
18:51:13.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.232004 24710 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/data/info.pb
18:51:13.238 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.194@KRBTEST.COM for kudu/127.23.195.254@KRBTEST.COM
18:51:13.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.239073 24335 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskCqFHaa/build/release/bin/kudu as pid 24710
18:51:13.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.239176 24335 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal/instance
18:51:13.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.242028 24913 heartbeater.cc:347] Connected to a master server at 127.23.195.254:33103
18:51:13.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.242137 24913 heartbeater.cc:464] Registering TS with master...
18:51:13.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.242352 24913 heartbeater.cc:511] Master 127.23.195.254:33103 requested a full tablet report, sending...
18:51:13.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.243005 24419 ts_manager.cc:194] Registered new tserver with Master: cc20aac95585490a8160eec9371642c2 (127.23.195.194:37807)
18:51:13.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.243358 24419 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.23.195.194@KRBTEST.COM'} at 127.23.195.194:55225
18:51:13.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.23.195.195@KRBTEST.COM; defaulting to no policy
18:51:13.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:13.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.23.195.195@KRBTEST.COM" created.
18:51:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
18:51:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.195.keytab.
18:51:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.23.195.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.195.keytab.
18:51:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.269649 24335 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskCqFHaa/build/release/bin/kudu
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/logs
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data/info.pb
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.195:0
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.195
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.195
18:51:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.195.keytab
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.195
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:13.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
18:51:13.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.355577 24919 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.355814 24919 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
18:51:13.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.355830 24919 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:51:13.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.355852 24919 flags.cc:425] Enabled unsafe flag: --never_fsync=true
18:51:13.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.357064 24919 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
18:51:13.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.357123 24919 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.23.195.195
18:51:13.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.358775 24919 tablet_server_runner.cc:78] Tablet server non-default flags:
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.23.195.212:33609
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kudu_127.23.195.195.keytab
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.23.195.195
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.23.195.195:0
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data/info.pb
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.23.195.195
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:51:13.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.23.195.254:33103
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.24919
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.23.195.195
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/logs
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 17:59:43 UTC on ccycloud.quasar-xuakos.root.comops.site
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581133
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.359000 24919 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:51:13.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.359198 24919 file_cache.cc:493] Constructed file cache file cache with capacity 419430
18:51:13.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.364447 24926 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.364447 24930 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:13.364447 24925 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
18:51:13.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.364470 24919 server_base.cc:1034] running on GCE node
18:51:13.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.365367 24919 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:51:13.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.365638 24919 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:51:13.366 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.366808 24919 hybrid_clock.cc:648] HybridClock initialized: now 1786474273366789 us; error 28 us; skew 500 ppm
18:51:13.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
18:51:13.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.369710 24919 init.cc:377] Logged in from keytab as kudu/127.23.195.195@KRBTEST.COM (short username kudu)
18:51:13.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.370182 24919 webserver.cc:460] Webserver started at http://127.23.195.195:44569/ using document root <none> and password file <none>
18:51:13.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.370422 24919 fs_manager.cc:359] Metadata directory not provided
18:51:13.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.370458 24919 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:51:13.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.370579 24919 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
18:51:13.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.371652 24919 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data/instance:
18:51:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6285ba8cc8af43309b971ab0f12aca70"
18:51:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.371994 24919 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal/instance:
18:51:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6285ba8cc8af43309b971ab0f12aca70"
18:51:13.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.373448 24919 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
18:51:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.374223 24944 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:51:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.374537 24919 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:51:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.374640 24919 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data,/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "6285ba8cc8af43309b971ab0f12aca70"
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:51:13 on dist-test-slave-bndk"
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.374718 24919 fs_report.cc:383] FS layout report
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data/data
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:51:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:51:13.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.391259 24919 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
18:51:13.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.393831 24919 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:51:13.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.393986 24919 kserver.cc:163] Server-wide thread pool size limit: 3276
18:51:13.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.394272 24919 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
18:51:13.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.394724 24919 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:51:13.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.394775 24919 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:51:13.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.394812 24919 ts_tablet_manager.cc:610] Registered 0 tablets
18:51:13.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.394829 24919 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:51:13.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.401038 24919 rpc_server.cc:307] RPC server started. Bound to: 127.23.195.195:34645
18:51:13.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.401089 25110 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.23.195.195:34645 every 8 connection(s)
18:51:13.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.401472 24919 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/data/info.pb
18:51:13.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.405887 24335 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskCqFHaa/build/release/bin/kudu as pid 24919
18:51:13.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.405972 24335 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal/instance
18:51:13.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:13 dist-test-slave-bndk krb5kdc[24350](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474273, etypes {rep=17 tkt=17 ses=17}, kudu/127.23.195.195@KRBTEST.COM for kudu/127.23.195.254@KRBTEST.COM
18:51:13.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.411718 25115 heartbeater.cc:347] Connected to a master server at 127.23.195.254:33103
18:51:13.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.411819 25115 heartbeater.cc:464] Registering TS with master...
18:51:13.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.411973 25115 heartbeater.cc:511] Master 127.23.195.254:33103 requested a full tablet report, sending...
18:51:13.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.412359 24419 ts_manager.cc:194] Registered new tserver with Master: 6285ba8cc8af43309b971ab0f12aca70 (127.23.195.195:34645)
18:51:13.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.412796 24419 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.23.195.195@KRBTEST.COM'} at 127.23.195.195:57167
18:51:13.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:13.417981 24335 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
18:51:13.418 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:51:13.420 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

18:51:13.434 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

18:51:13.436 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:51:13.446 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.23.195.254"
      port: 33103
    }
    bound_http_address {
      host: "127.23.195.254"
      port: 44193
    }
  }
}

18:51:13.452 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

18:51:13.455 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.23.195.193"
      port: 41165
    }
    bound_http_address {
      host: "127.23.195.193"
      port: 44905
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.23.195.194"
      port: 37807
    }
    bound_http_address {
      host: "127.23.195.194"
      port: 36689
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.23.195.195"
      port: 34645
    }
    bound_http_address {
      host: "127.23.195.195"
      port: 44569
    }
  }
}

18:51:13.456 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:51:13.646 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/krb5kdc/krb5cc
18:51:13.670 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
18:51:13.833 [DEBUG - main] (Connection.java:748) [peer master-127.23.195.254:33103(127.23.195.254:33103)] connecting to peer
18:51:13.908 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.23.195.254:33103(127.23.195.254:33103)] Successfully connected to peer
18:51:13.988 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.23.195.254
18:51:14.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.079491 24704 heartbeater.cc:503] Master 127.23.195.254:33103 was elected leader, sending a full tablet report...
18:51:14.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 18:51:14 dist-test-slave-bndk krb5kdc[24350](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786474272, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.23.195.254@KRBTEST.COM
18:51:14.234 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xe1f0e27e, L:/127.0.0.1:54608 - R:/127.23.195.254:33103] using SASL/GSSAPI
18:51:14.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.244338 24913 heartbeater.cc:503] Master 127.23.195.254:33103 was elected leader, sending a full tablet report...
18:51:14.276 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:51:14.277 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=489), Traces: [0ms] refreshing cache from master, [31ms] Sub RPC ConnectToMaster: sending RPC to server master-127.23.195.254:33103, [456ms] Sub RPC ConnectToMaster: received response from server master-127.23.195.254:33103: OK, deferred=null) after lookup
18:51:14.299 [DEBUG - main] (Connection.java:575) [peer master-127.23.195.254:33103(127.23.195.254:33103)] disconnecting while in state READY
18:51:14.307 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.23.195.254:33103(127.23.195.254:33103)] handling channelInactive
18:51:14.308 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.23.195.254:33103(127.23.195.254:33103)] cleaning up while in state READY due to: connection closed
18:51:14.308 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.23.195.254:33103(127.23.195.254:33103) for tablet Kudu Master: connection closed
18:51:14.329 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.23.195.254:33103(127.23.195.254:33103)] connecting to peer
18:51:14.333 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.23.195.254:33103(127.23.195.254:33103)] Successfully connected to peer
18:51:14.404 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x914960b3, L:/127.0.0.1:54612 - R:/127.23.195.254:33103] using TOKEN/null
18:51:14.407 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:51:14.408 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=107), Traces: [0ms] sending RPC to server master-127.23.195.254:33103, [7ms] received response from server master-127.23.195.254:33103: Network error: connection closed, [7ms] delaying RPC due to: Network error: connection closed, [28ms] refreshing cache from master, [28ms] Sub RPC ConnectToMaster: sending RPC to server master-127.23.195.254:33103, [105ms] Sub RPC ConnectToMaster: received response from server master-127.23.195.254:33103: OK, deferred=Deferred@754751840(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
18:51:14.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.413681 25115 heartbeater.cc:503] Master 127.23.195.254:33103 was elected leader, sending a full tablet report...
18:51:14.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.486197 24419 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:54612:
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:51:14.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:51:14.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:14.487830 24419 catalog_manager.cc:6854] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table TestAuthnTokenReacquireOpen-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:51:14.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.498189 25010 tablet_service.cc:1467] Processing CreateTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]), partition=RANGE (key) PARTITION UNBOUNDED
18:51:14.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.498633 25010 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 5117bb2b64774f29a063a6f3e2f1c099. 1 dirs total, 0 dirs full, 0 dirs failed
18:51:14.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.502002 24609 tablet_service.cc:1467] Processing CreateTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]), partition=RANGE (key) PARTITION UNBOUNDED
18:51:14.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.502406 24609 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 5117bb2b64774f29a063a6f3e2f1c099. 1 dirs total, 0 dirs full, 0 dirs failed
18:51:14.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.504774 25139 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Bootstrap starting.
18:51:14.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.505085 24812 tablet_service.cc:1467] Processing CreateTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]), partition=RANGE (key) PARTITION UNBOUNDED
18:51:14.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.505507 24812 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 5117bb2b64774f29a063a6f3e2f1c099. 1 dirs total, 0 dirs full, 0 dirs failed
18:51:14.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.505791 25139 tablet_bootstrap.cc:654] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Neither blocks nor log segments found. Creating new log.
18:51:14.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.506126 25139 log.cc:824] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Log is configured to *not* fsync() on all Append() calls
18:51:14.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.508701 25139 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: No bootstrap required, opened a new log
18:51:14.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.508785 25139 ts_tablet_manager.cc:1397] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Time spent bootstrapping tablet: real 0.004s	user 0.000s	sys 0.002s
18:51:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.511921 25142 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Bootstrap starting.
18:51:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.511682 25139 raft_consensus.cc:348] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.512063 25139 raft_consensus.cc:374] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:51:14.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.512101 25139 raft_consensus.cc:729] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6285ba8cc8af43309b971ab0f12aca70, State: Initialized, Role: FOLLOWER
18:51:14.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.512737 25142 tablet_bootstrap.cc:654] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Neither blocks nor log segments found. Creating new log.
18:51:14.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.513059 25142 log.cc:824] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Log is configured to *not* fsync() on all Append() calls
18:51:14.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.513525 25139 consensus_queue.cc:260] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.513625 25143 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Bootstrap starting.
18:51:14.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.513866 25139 ts_tablet_manager.cc:1428] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Time spent starting tablet: real 0.005s	user 0.003s	sys 0.001s
18:51:14.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.514374 25143 tablet_bootstrap.cc:654] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Neither blocks nor log segments found. Creating new log.
18:51:14.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.515002 25143 log.cc:824] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Log is configured to *not* fsync() on all Append() calls
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.515969 25143 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: No bootstrap required, opened a new log
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.516049 25143 ts_tablet_manager.cc:1397] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Time spent bootstrapping tablet: real 0.004s	user 0.002s	sys 0.000s
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.516279 25142 tablet_bootstrap.cc:492] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: No bootstrap required, opened a new log
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.516345 25142 ts_tablet_manager.cc:1397] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Time spent bootstrapping tablet: real 0.005s	user 0.000s	sys 0.001s
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.518837 25143 raft_consensus.cc:348] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.518870 25142 raft_consensus.cc:348] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519034 25143 raft_consensus.cc:374] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519042 25142 raft_consensus.cc:374] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519075 25142 raft_consensus.cc:729] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 1aeb65c8d34b4cb8b809819b87272706, State: Initialized, Role: FOLLOWER
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519073 25143 raft_consensus.cc:729] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: cc20aac95585490a8160eec9371642c2, State: Initialized, Role: FOLLOWER
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519220 25142 consensus_queue.cc:260] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.519507 25142 ts_tablet_manager.cc:1428] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Time spent starting tablet: real 0.003s	user 0.002s	sys 0.001s
18:51:14.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.520037 25143 consensus_queue.cc:260] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.520355 25143 ts_tablet_manager.cc:1428] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Time spent starting tablet: real 0.004s	user 0.003s	sys 0.000s
18:51:14.523 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2f8afefb0c744ce7b35e7d3c34c09460
18:51:14.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:14.565776 24706 tablet.cc:2369] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:51:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.639871 25148 raft_consensus.cc:482] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:51:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.640012 25148 raft_consensus.cc:504] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.640372 25148 leader_election.cc:288] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 6285ba8cc8af43309b971ab0f12aca70 (127.23.195.195:34645), cc20aac95585490a8160eec9371642c2 (127.23.195.194:37807)
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.643774 24843 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "5117bb2b64774f29a063a6f3e2f1c099" candidate_uuid: "1aeb65c8d34b4cb8b809819b87272706" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cc20aac95585490a8160eec9371642c2" is_pre_election: true
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.643774 25040 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "5117bb2b64774f29a063a6f3e2f1c099" candidate_uuid: "1aeb65c8d34b4cb8b809819b87272706" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6285ba8cc8af43309b971ab0f12aca70" is_pre_election: true
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.643965 25040 raft_consensus.cc:2454] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1aeb65c8d34b4cb8b809819b87272706 in term 0.
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.643978 24843 raft_consensus.cc:2454] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 1aeb65c8d34b4cb8b809819b87272706 in term 0.
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.644207 24537 leader_election.cc:302] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 1aeb65c8d34b4cb8b809819b87272706, 6285ba8cc8af43309b971ab0f12aca70; no voters: 
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.644357 25148 raft_consensus.cc:2781] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.644414 25148 raft_consensus.cc:482] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:51:14.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.644429 25148 raft_consensus.cc:3037] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 0 FOLLOWER]: Advancing to term 1
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645087 25148 raft_consensus.cc:504] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645205 25148 leader_election.cc:288] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [CANDIDATE]: Term 1 election: Requested vote from peers 6285ba8cc8af43309b971ab0f12aca70 (127.23.195.195:34645), cc20aac95585490a8160eec9371642c2 (127.23.195.194:37807)
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645421 24843 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "5117bb2b64774f29a063a6f3e2f1c099" candidate_uuid: "1aeb65c8d34b4cb8b809819b87272706" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "cc20aac95585490a8160eec9371642c2"
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645447 25040 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "5117bb2b64774f29a063a6f3e2f1c099" candidate_uuid: "1aeb65c8d34b4cb8b809819b87272706" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6285ba8cc8af43309b971ab0f12aca70"
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645485 24843 raft_consensus.cc:3037] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 0 FOLLOWER]: Advancing to term 1
18:51:14.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.645536 25040 raft_consensus.cc:3037] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 0 FOLLOWER]: Advancing to term 1
18:51:14.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646095 24843 raft_consensus.cc:2454] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1aeb65c8d34b4cb8b809819b87272706 in term 1.
18:51:14.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646298 24534 leader_election.cc:302] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 1aeb65c8d34b4cb8b809819b87272706, cc20aac95585490a8160eec9371642c2; no voters: 
18:51:14.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646358 25040 raft_consensus.cc:2454] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 1aeb65c8d34b4cb8b809819b87272706 in term 1.
18:51:14.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646389 25148 raft_consensus.cc:2781] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 1 FOLLOWER]: Leader election won for term 1
18:51:14.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646574 25148 raft_consensus.cc:686] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 1 LEADER]: Becoming Leader. State: Replica: 1aeb65c8d34b4cb8b809819b87272706, State: Running, Role: LEADER
18:51:14.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.646675 25148 consensus_queue.cc:237] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } }
18:51:14.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:14.647470 24418 catalog_manager.cc:5495] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 reported cstate change: term changed from 0 to 1, leader changed from <none> to 1aeb65c8d34b4cb8b809819b87272706 (127.23.195.193). New cstate: current_term: 1 leader_uuid: "1aeb65c8d34b4cb8b809819b87272706" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "1aeb65c8d34b4cb8b809819b87272706" member_type: VOTER last_known_addr { host: "127.23.195.193" port: 41165 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 } health_report { overall_health: UNKNOWN } } }
18:51:14.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:14.652660 25116 tablet.cc:2369] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:51:14.655 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2f8afefb0c744ce7b35e7d3c34c09460
18:51:14.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:14.733384 24914 tablet.cc:2369] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:51:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.213370 25157 consensus_queue.cc:1035] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [LEADER]: Connected to new peer: Peer: permanent_uuid: "6285ba8cc8af43309b971ab0f12aca70" member_type: VOTER last_known_addr { host: "127.23.195.195" port: 34645 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:51:15.216 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.215817 25165 consensus_queue.cc:1035] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [LEADER]: Connected to new peer: Peer: permanent_uuid: "cc20aac95585490a8160eec9371642c2" member_type: VOTER last_known_addr { host: "127.23.195.194" port: 37807 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:51:15.660 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2f8afefb0c744ce7b35e7d3c34c09460
18:51:15.699 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 5117bb2b64774f29a063a6f3e2f1c099 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
18:51:15.708 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299991, tablet=5117bb2b64774f29a063a6f3e2f1c099@[1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)[L],6285ba8cc8af43309b971ab0f12aca70(127.23.195.195:34645),cc20aac95585490a8160eec9371642c2(127.23.195.194:37807)]}]
18:51:15.710 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC ScanRequest(scannerId=null, state=OPENING, attempt=1, KuduRpc(method=Scan, tablet=null, attempt=1, TimeoutTracker(timeout=60000, elapsed=20), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.23.195.254:33103, [9ms] Sub RPC GetTableLocations: received response from server master-127.23.195.254:33103: OK, deferred=null)) after lookup
18:51:15.722 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] connecting to peer
18:51:15.724 [DEBUG - kudu-nio-0] (Connection.java:757) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] Successfully connected to peer
18:51:15.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:15.748485 25173 fault_injection.cc:43] FAULT INJECTION ENABLED!
18:51:15.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:15.748560 25173 fault_injection.cc:44] THIS SERVER MAY CRASH!
18:51:15.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:51:15.748883 25173 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:43706: token signing key expired
18:51:15.755 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.23.195.193:41165 sent connection negotiation error: Not authorized: token signing key expired
18:51:15.757 [DEBUG - kudu-nio-0] (Connection.java:239) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] handling channelInactive
18:51:15.757 [DEBUG - kudu-nio-0] (Connection.java:709) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
18:51:15.761 [DEBUG - kudu-nio-0] (Connection.java:748) [peer master-127.23.195.254:33103(127.23.195.254:33103)] connecting to peer
18:51:15.763 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.23.195.254:33103(127.23.195.254:33103)] Successfully connected to peer
18:51:15.766 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.23.195.254
18:51:15.793 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xc0f5bf89, L:/127.0.0.1:54620 - R:/127.23.195.254:33103] using SASL/GSSAPI
18:51:15.796 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
18:51:15.797 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] connecting to peer
18:51:15.799 [DEBUG - kudu-nio-0] (Connection.java:757) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] Successfully connected to peer
18:51:15.821 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x1b7eccee, L:/127.0.0.1:43722 - R:/127.23.195.193:41165] using TOKEN/null
18:51:15.845 [DEBUG - kudu-nio-0] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=5117bb2b64774f29a063a6f3e2f1c099, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:51:15.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.859931 24419 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:54620:
18:51:15.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
18:51:15.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.860076 24419 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:54620:
18:51:15.860 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
18:51:15.861 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.861487 24419 catalog_manager.cc:5782] T 00000000000000000000000000000000 P 124f1d5351104b7aa579f2fa84f9cf2a: Sending DeleteTablet for 3 replicas of tablet 5117bb2b64774f29a063a6f3e2f1c099
18:51:15.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.862068 24609 tablet_service.cc:1514] Processing DeleteTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:51:15 UTC) from {username='kudu', principal='kudu/127.23.195.254@KRBTEST.COM'} at 127.0.0.1:43700
18:51:15.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.862069 25010 tablet_service.cc:1514] Processing DeleteTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:51:15 UTC) from {username='kudu', principal='kudu/127.23.195.254@KRBTEST.COM'} at 127.0.0.1:33414
18:51:15.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.863821 25185 tablet_replica.cc:330] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: stopping tablet replica
18:51:15.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.863991 25185 raft_consensus.cc:2229] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 1 FOLLOWER]: Raft consensus shutting down.
18:51:15.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.864069 25185 raft_consensus.cc:2258] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70 [term 1 FOLLOWER]: Raft consensus is shut down!
18:51:15.864 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.864635 25185 ts_tablet_manager.cc:1905] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Deleting tablet data with delete state TABLET_DATA_DELETED
18:51:15.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.866778 25185 ts_tablet_manager.cc:1918] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:51:15.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.866870 25185 log.cc:1196] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Deleting WAL directory at /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-2/wal/wals/5117bb2b64774f29a063a6f3e2f1c099
18:51:15.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.867201 25185 ts_tablet_manager.cc:1939] T 5117bb2b64774f29a063a6f3e2f1c099 P 6285ba8cc8af43309b971ab0f12aca70: Deleting consensus metadata
18:51:15.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.867501 24812 tablet_service.cc:1514] Processing DeleteTablet for tablet 5117bb2b64774f29a063a6f3e2f1c099 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 18:51:15 UTC) from {username='kudu', principal='kudu/127.23.195.254@KRBTEST.COM'} at 127.0.0.1:50570
18:51:15.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.867973 25190 tablet_replica.cc:330] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: stopping tablet replica
18:51:15.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.867954 24396 catalog_manager.cc:4841] TS 6285ba8cc8af43309b971ab0f12aca70 (127.23.195.195:34645): tablet 5117bb2b64774f29a063a6f3e2f1c099 (table TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]) successfully deleted
18:51:15.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.868706 25190 raft_consensus.cc:2229] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 1 FOLLOWER]: Raft consensus shutting down.
18:51:15.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.869015 25186 tablet_replica.cc:330] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: stopping tablet replica
18:51:15.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.869336 25186 raft_consensus.cc:2229] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 1 LEADER]: Raft consensus shutting down.
18:51:15.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.869630 25186 raft_consensus.cc:2258] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706 [term 1 FOLLOWER]: Raft consensus is shut down!
18:51:15.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.870121 25186 ts_tablet_manager.cc:1905] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Deleting tablet data with delete state TABLET_DATA_DELETED
18:51:15.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.870846 25190 raft_consensus.cc:2258] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2 [term 1 FOLLOWER]: Raft consensus is shut down!
18:51:15.871 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.871495 25190 ts_tablet_manager.cc:1905] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Deleting tablet data with delete state TABLET_DATA_DELETED
18:51:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.872102 25186 ts_tablet_manager.cc:1918] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:51:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.872349 25186 log.cc:1196] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Deleting WAL directory at /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-0/wal/wals/5117bb2b64774f29a063a6f3e2f1c099
18:51:15.872 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.872773 25186 ts_tablet_manager.cc:1939] T 5117bb2b64774f29a063a6f3e2f1c099 P 1aeb65c8d34b4cb8b809819b87272706: Deleting consensus metadata
18:51:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.873152 25190 ts_tablet_manager.cc:1918] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
18:51:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.873428 25190 log.cc:1196] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Deleting WAL directory at /tmp/dist-test-taskCqFHaa/test-tmp/mini-kudu-cluster5324102499039703398/ts-1/wal/wals/5117bb2b64774f29a063a6f3e2f1c099
18:51:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.873461 24394 catalog_manager.cc:4841] TS 1aeb65c8d34b4cb8b809819b87272706 (127.23.195.193:41165): tablet 5117bb2b64774f29a063a6f3e2f1c099 (table TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]) successfully deleted
18:51:15.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.873848 25190 ts_tablet_manager.cc:1939] T 5117bb2b64774f29a063a6f3e2f1c099 P cc20aac95585490a8160eec9371642c2: Deleting consensus metadata
18:51:15.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.874425 24394 catalog_manager.cc:4841] TS cc20aac95585490a8160eec9371642c2 (127.23.195.194:37807): tablet 5117bb2b64774f29a063a6f3e2f1c099 (table TestAuthnTokenReacquireOpen-table [id=2f8afefb0c744ce7b35e7d3c34c09460]) successfully deleted
18:51:15.877 [DEBUG - main] (Connection.java:575) [peer master-127.23.195.254:33103(127.23.195.254:33103)] disconnecting while in state READY
18:51:15.878 [DEBUG - main] (Connection.java:575) [peer master-127.23.195.254:33103(127.23.195.254:33103)] disconnecting while in state READY
18:51:15.878 [DEBUG - main] (Connection.java:575) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] disconnecting while in state READY
18:51:15.880 [DEBUG - kudu-nio-0] (Connection.java:239) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] handling channelInactive
18:51:15.880 [DEBUG - kudu-nio-0] (Connection.java:709) [peer 1aeb65c8d34b4cb8b809819b87272706(127.23.195.193:41165)] cleaning up while in state READY due to: connection closed
18:51:15.888 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:51:15.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.892868 24335 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskCqFHaa/build/release/bin/kudu with pid 24507
18:51:15.892 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.23.195.254:33103(127.23.195.254:33103)] handling channelInactive
18:51:15.900 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.23.195.254:33103(127.23.195.254:33103)] cleaning up while in state READY due to: connection closed
18:51:15.901 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.23.195.254:33103(127.23.195.254:33103)] handling channelInactive
18:51:15.901 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.23.195.254:33103(127.23.195.254:33103)] cleaning up while in state READY due to: connection closed
18:51:15.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.913065 24335 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskCqFHaa/build/release/bin/kudu with pid 24710
18:51:15.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.927403 24335 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskCqFHaa/build/release/bin/kudu with pid 24919
18:51:15.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:51:15.940398 24335 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskCqFHaa/build/release/bin/kudu with pid 24366
18:51:15.975 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:51:15Z chronyd exiting

Time: 5.284

OK (1 test)

