JUnit version 4.13.2
.10:27:13.113 [INFO - main] (RandomUtils.java:49) Using random seed: 1783506433108
10:27:13.129 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
10:27:13.182 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
10:27:13.191 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskRyhUC6/test-tmp
10:27:13.193 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
10:27:13.197 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskRyhUC6/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
10:27:13.398 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914"
  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 {
  }
}

10:27:13.411 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
10:27:13.412 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

10:27:13.415 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:13.414404  9967 mini_oidc.cc:152] Starting JWKS server
10:27:13.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:13.417490  9967 webserver.cc:460] Webserver started at http://127.0.0.1:39435/ using document root <none> and password file <none>
10:27:13.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:13.417706  9967 mini_oidc.cc:189] Starting OIDC Discovery server
10:27:13.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:13.418036  9967 webserver.cc:460] Webserver started at http://127.0.0.1:41693/ using document root <none> and password file <none>
10:27:13.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
10:27:13.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/principal' for realm 'KRBTEST.COM',
10:27:13.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
10:27:13.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:13 dist-test-slave-c3lv krb5kdc[9977](info): setting up network...
10:27:13.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
10:27:13.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:13 dist-test-slave-c3lv krb5kdc[9977](info): set up 2 sockets
10:27:13.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:13 dist-test-slave-c3lv krb5kdc[9977](info): commencing operation
10:27:13.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
10:27:14.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.437541  9967 mini_kdc.cc:121] Time spent starting KDC: real 1.010s	user 0.000s	sys 0.006s
10:27:14.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
10:27:14.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
10:27:14.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
10:27:14.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
10:27:14.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
10:27:14.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
10:27:14.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
10:27:14.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
10:27:14.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
10:27:14.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
10:27:14.511 [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-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/test-user.keytab.
10:27:14.511 [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-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/test-user.keytab.
10:27:14.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:14 dist-test-slave-c3lv krb5kdc[9977](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
10:27:14.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
10:27:14.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T10:27:14Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
10:27:14.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T10:27:14Z Disabled control of system clock
10:27:14.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.9.187.254@KRBTEST.COM; defaulting to no policy
10:27:14.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:14.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.9.187.254@KRBTEST.COM" created.
10:27:14.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:14.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.254.keytab.
10:27:14.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.254.keytab.
10:27:14.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.558670  9967 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:14.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:14.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal
10:27:14.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data
10:27:14.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
10:27:14.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/logs
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data/info.pb
10:27:14.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
10:27:14.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.254:36109
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.254
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.254.keytab
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.254
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:14.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.187.254:36109
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39435/jwks.json
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
10:27:14.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
10:27:14.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.667963  9990 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
10:27:14.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.668227  9990 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
10:27:14.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.668273  9990 flags.cc:425] Enabled unsafe flag: --never_fsync=true
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672224  9990 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672271  9990 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672293  9990 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672309  9990 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672324  9990 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672339  9990 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
10:27:14.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.672353  9990 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39435/jwks.json
10:27:14.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.677460  9990 master_runner.cc:386] Master server non-default flags:
10:27:14.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.9.187.254:36109
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.254.keytab
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.254
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:14.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.254:36109
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39435/jwks.json
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:14.679 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data/info.pb
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.254
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
10:27:14.680 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.9990
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/logs
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
10:27:14.681 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 09:48:28 UTC on ccycloud.quasar-erdyzl.root.comops.site
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493122
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.678674  9990 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
10:27:14.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.679953  9990 file_cache.cc:493] Constructed file cache file cache with capacity 419430
10:27:14.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.689215  9996 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
10:27:14.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.689250  9995 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
10:27:14.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.689281  9998 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
10:27:14.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.689368  9990 server_base.cc:1034] running on GCE node
10:27:14.690 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.690333  9990 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
10:27:14.691 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.691532  9990 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
10:27:14.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.692723  9990 hybrid_clock.cc:648] HybridClock initialized: now 1783506434692694 us; error 40 us; skew 500 ppm
10:27:14.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:14 dist-test-slave-c3lv krb5kdc[9977](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
10:27:14.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.695436  9990 init.cc:377] Logged in from keytab as kudu/127.9.187.254@KRBTEST.COM (short username kudu)
10:27:14.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.696321  9990 webserver.cc:460] Webserver started at http://127.9.187.254:36883/ using document root <none> and password file <none>
10:27:14.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.696967  9990 fs_manager.cc:359] Metadata directory not provided
10:27:14.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.697058  9990 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
10:27:14.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.697295  9990 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
10:27:14.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.699206  9990 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data/instance:
10:27:14.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9696706236bc4242bb92fcf28a872e03"
10:27:14.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.699819  9990 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal/instance:
10:27:14.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9696706236bc4242bb92fcf28a872e03"
10:27:14.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.703596  9990 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.004s
10:27:14.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.706049 10005 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
10:27:14.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.707267  9990 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
10:27:14.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.707405  9990 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data,/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal
10:27:14.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9696706236bc4242bb92fcf28a872e03"
10:27:14.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.707510  9990 fs_report.cc:383] FS layout report
10:27:14.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
10:27:14.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal
10:27:14.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data/data
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
10:27:14.709 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
10:27:14.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
10:27:14.710 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
10:27:14.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.738142  9990 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
10:27:14.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.741406  9990 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
10:27:14.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.741640  9990 kserver.cc:163] Server-wide thread pool size limit: 3276
10:27:14.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.749006  9990 rpc_server.cc:307] RPC server started. Bound to: 127.9.187.254:36109
10:27:14.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.749266 10057 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.187.254:36109 every 8 connection(s)
10:27:14.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.750155  9990 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/data/info.pb
10:27:14.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.753118 10058 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
10:27:14.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.755637  9967 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu as pid 9990
10:27:14.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.755779  9967 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/master-0/wal/instance
10:27:14.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.758436 10058 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: Bootstrap starting.
10:27:14.761 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.761132 10058 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: Neither blocks nor log segments found. Creating new log.
10:27:14.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.761936 10058 log.cc:824] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: Log is configured to *not* fsync() on all Append() calls
10:27:14.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.764120 10058 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: No bootstrap required, opened a new log
10:27:14.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.768144 10058 raft_consensus.cc:348] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } }
10:27:14.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.768354 10058 raft_consensus.cc:374] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
10:27:14.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.768386 10058 raft_consensus.cc:729] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9696706236bc4242bb92fcf28a872e03, State: Initialized, Role: FOLLOWER
10:27:14.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.768795 10058 consensus_queue.cc:260] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [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: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } }
10:27:14.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.768970 10058 raft_consensus.cc:388] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
10:27:14.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.769013 10058 raft_consensus.cc:482] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
10:27:14.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.769078 10058 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 0 FOLLOWER]: Advancing to term 1
10:27:14.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.770013 10058 raft_consensus.cc:504] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } }
10:27:14.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.770362 10058 leader_election.cc:302] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [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: 9696706236bc4242bb92fcf28a872e03; no voters: 
10:27:14.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.770949 10058 leader_election.cc:288] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [CANDIDATE]: Term 1 election: Requested vote from peers 
10:27:14.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.771031 10063 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 1 FOLLOWER]: Leader election won for term 1
10:27:14.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.772198 10063 raft_consensus.cc:686] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [term 1 LEADER]: Becoming Leader. State: Replica: 9696706236bc4242bb92fcf28a872e03, State: Running, Role: LEADER
10:27:14.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.772501 10058 sys_catalog.cc:564] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [sys.catalog]: configured and running, proceeding with master startup.
10:27:14.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.772687 10063 consensus_queue.cc:237] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [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: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } }
10:27:14.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:14 dist-test-slave-c3lv krb5kdc[9977](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.9.187.254@KRBTEST.COM
10:27:14.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.774206 10065 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "9696706236bc4242bb92fcf28a872e03" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } } }
10:27:14.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.774334 10065 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [sys.catalog]: This master's current role is: LEADER
10:27:14.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.774220 10064 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 9696706236bc4242bb92fcf28a872e03. Latest consensus state: current_term: 1 leader_uuid: "9696706236bc4242bb92fcf28a872e03" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9696706236bc4242bb92fcf28a872e03" member_type: VOTER last_known_addr { host: "127.9.187.254" port: 36109 } } }
10:27:14.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.774621 10064 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03 [sys.catalog]: This master's current role is: LEADER
10:27:14.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.775259 10075 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
10:27:14.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.778796 10075 catalog_manager.cc:1484] Initializing Kudu cluster ID...
10:27:14.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.784251 10075 catalog_manager.cc:1347] Generated new cluster ID: ebce0b7389c74efaaaffce395553b5d8
10:27:14.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.784593 10075 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
10:27:14.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.793141 10075 catalog_manager.cc:1370] Generated new certificate authority record
10:27:14.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.794143 10075 catalog_manager.cc:1504] Loading token signing keys...
10:27:14.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.800037 10075 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: Generated new TSK 0
10:27:14.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.801066 10075 catalog_manager.cc:1514] Initializing in-progress tserver states...
10:27:14.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.9.187.193@KRBTEST.COM; defaulting to no policy
10:27:14.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:14.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.9.187.193@KRBTEST.COM" created.
10:27:14.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:14.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.193.keytab.
10:27:14.831 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.193.keytab.
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.831845  9967 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
10:27:14.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/logs
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data/info.pb
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
10:27:14.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:14.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:14.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.193:0
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.193
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.193
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.193.keytab
10:27:14.835 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.193
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:14.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
10:27:14.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.951894 10084 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
10:27:14.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.952189 10084 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
10:27:14.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.952226 10084 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
10:27:14.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.952279 10084 flags.cc:425] Enabled unsafe flag: --never_fsync=true
10:27:14.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.956465 10084 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
10:27:14.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.956619 10084 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.187.193
10:27:14.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.961724 10084 tablet_server_runner.cc:78] Tablet server non-default flags:
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.193.keytab
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.193
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.193:0
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:14.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data/info.pb
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.193
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10084
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:14.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.193
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/logs
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 09:48:28 UTC on ccycloud.quasar-erdyzl.root.comops.site
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493122
10:27:14.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.962970 10084 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
10:27:14.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.964272 10084 file_cache.cc:493] Constructed file cache file cache with capacity 419430
10:27:14.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.973953 10090 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
10:27:14.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.973974 10092 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
10:27:14.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.974020 10084 server_base.cc:1034] running on GCE node
10:27:14.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:14.974028 10089 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
10:27:14.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.977420 10084 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
10:27:14.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.978173 10084 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
10:27:14.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.979604 10084 hybrid_clock.cc:648] HybridClock initialized: now 1783506434979534 us; error 87 us; skew 500 ppm
10:27:14.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:14 dist-test-slave-c3lv krb5kdc[9977](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
10:27:14.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.983032 10084 init.cc:377] Logged in from keytab as kudu/127.9.187.193@KRBTEST.COM (short username kudu)
10:27:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.983908 10084 webserver.cc:460] Webserver started at http://127.9.187.193:41305/ using document root <none> and password file <none>
10:27:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.984421 10084 fs_manager.cc:359] Metadata directory not provided
10:27:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.984477 10084 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
10:27:14.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.984647 10084 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
10:27:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.986526 10084 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data/instance:
10:27:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b91186c63e024c8d97a6a2e3f67168b7"
10:27:14.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.987037 10084 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal/instance:
10:27:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b91186c63e024c8d97a6a2e3f67168b7"
10:27:14.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.990640 10084 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.002s
10:27:14.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.993084 10099 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
10:27:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.994458 10084 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
10:27:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.994549 10084 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data,/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal
10:27:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b91186c63e024c8d97a6a2e3f67168b7"
10:27:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:14 on dist-test-slave-c3lv"
10:27:14.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:14.994617 10084 fs_report.cc:383] FS layout report
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data/data
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
10:27:14.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
10:27:15.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.009716 10084 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
10:27:15.012 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.012548 10084 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
10:27:15.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.012699 10084 kserver.cc:163] Server-wide thread pool size limit: 3276
10:27:15.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.013365 10084 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
10:27:15.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.014130 10084 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
10:27:15.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.014175 10084 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
10:27:15.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.014222 10084 ts_tablet_manager.cc:610] Registered 0 tablets
10:27:15.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.014238 10084 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
10:27:15.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.023434 10084 rpc_server.cc:307] RPC server started. Bound to: 127.9.187.193:38197
10:27:15.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.023451 10212 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.187.193:38197 every 8 connection(s)
10:27:15.024 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.024528 10084 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/data/info.pb
10:27:15.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.028658  9967 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu as pid 10084
10:27:15.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.028779  9967 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal/instance
10:27:15.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:15 dist-test-slave-c3lv krb5kdc[9977](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.193@KRBTEST.COM for kudu/127.9.187.254@KRBTEST.COM
10:27:15.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.9.187.194@KRBTEST.COM; defaulting to no policy
10:27:15.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:15.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.9.187.194@KRBTEST.COM" created.
10:27:15.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.042176 10213 heartbeater.cc:347] Connected to a master server at 127.9.187.254:36109
10:27:15.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.042455 10213 heartbeater.cc:464] Registering TS with master...
10:27:15.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.043125 10213 heartbeater.cc:511] Master 127.9.187.254:36109 requested a full tablet report, sending...
10:27:15.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.044735 10022 ts_manager.cc:194] Registered new tserver with Master: b91186c63e024c8d97a6a2e3f67168b7 (127.9.187.193:38197)
10:27:15.046 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.046255 10022 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.9.187.193@KRBTEST.COM'} at 127.9.187.193:35919
10:27:15.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:15.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.194.keytab.
10:27:15.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.194.keytab.
10:27:15.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.057325  9967 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:15.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:15.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal
10:27:15.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data
10:27:15.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/logs
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data/info.pb
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
10:27:15.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.194:0
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.194
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.194
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.194.keytab
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.194
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:15.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:15.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:15.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:15.061 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
10:27:15.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.172010 10218 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
10:27:15.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.172309 10218 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
10:27:15.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.172341 10218 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
10:27:15.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.172397 10218 flags.cc:425] Enabled unsafe flag: --never_fsync=true
10:27:15.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.176874 10218 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
10:27:15.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.177065 10218 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.187.194
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.182025 10218 tablet_server_runner.cc:78] Tablet server non-default flags:
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.194.keytab
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.194
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:15.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.194:0
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data/info.pb
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.194
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10218
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.194
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/logs
10:27:15.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 09:48:28 UTC on ccycloud.quasar-erdyzl.root.comops.site
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493122
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.183333 10218 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
10:27:15.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.184711 10218 file_cache.cc:493] Constructed file cache file cache with capacity 419430
10:27:15.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.194067 10226 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
10:27:15.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.194053 10224 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
10:27:15.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.194067 10223 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
10:27:15.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.194244 10218 server_base.cc:1034] running on GCE node
10:27:15.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.194945 10218 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
10:27:15.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.195693 10218 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
10:27:15.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.196902 10218 hybrid_clock.cc:648] HybridClock initialized: now 1783506435196877 us; error 40 us; skew 500 ppm
10:27:15.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:15 dist-test-slave-c3lv krb5kdc[9977](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506435, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
10:27:15.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.200304 10218 init.cc:377] Logged in from keytab as kudu/127.9.187.194@KRBTEST.COM (short username kudu)
10:27:15.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.201344 10218 webserver.cc:460] Webserver started at http://127.9.187.194:41791/ using document root <none> and password file <none>
10:27:15.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.201987 10218 fs_manager.cc:359] Metadata directory not provided
10:27:15.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.202068 10218 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
10:27:15.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.202292 10218 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.204627 10218 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data/instance:
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "89e2a4df17354eabacda3ff31720265e"
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.205364 10218 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal/instance:
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "89e2a4df17354eabacda3ff31720265e"
10:27:15.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.209146 10218 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
10:27:15.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.211539 10233 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.213057 10218 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.213157 10218 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data,/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "89e2a4df17354eabacda3ff31720265e"
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.213275 10218 fs_report.cc:383] FS layout report
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data/data
10:27:15.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
10:27:15.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
10:27:15.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.227607 10218 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
10:27:15.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.231205 10218 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
10:27:15.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.231369 10218 kserver.cc:163] Server-wide thread pool size limit: 3276
10:27:15.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.231940 10218 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
10:27:15.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.232725 10218 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
10:27:15.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.232770 10218 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
10:27:15.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.232810 10218 ts_tablet_manager.cc:610] Registered 0 tablets
10:27:15.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.232879 10218 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
10:27:15.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.241781 10218 rpc_server.cc:307] RPC server started. Bound to: 127.9.187.194:32771
10:27:15.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.241799 10346 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.187.194:32771 every 8 connection(s)
10:27:15.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.242722 10218 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/data/info.pb
10:27:15.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.243757  9967 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu as pid 10218
10:27:15.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.243846  9967 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal/instance
10:27:15.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.9.187.195@KRBTEST.COM; defaulting to no policy
10:27:15.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:15.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.9.187.195@KRBTEST.COM" created.
10:27:15.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:15 dist-test-slave-c3lv krb5kdc[9977](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506435, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.194@KRBTEST.COM for kudu/127.9.187.254@KRBTEST.COM
10:27:15.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.262816 10347 heartbeater.cc:347] Connected to a master server at 127.9.187.254:36109
10:27:15.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.263098 10347 heartbeater.cc:464] Registering TS with master...
10:27:15.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.263674 10347 heartbeater.cc:511] Master 127.9.187.254:36109 requested a full tablet report, sending...
10:27:15.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.264786 10022 ts_manager.cc:194] Registered new tserver with Master: 89e2a4df17354eabacda3ff31720265e (127.9.187.194:32771)
10:27:15.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.265442 10022 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.9.187.194@KRBTEST.COM'} at 127.9.187.194:54393
10:27:15.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.195.keytab.
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.9.187.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.195.keytab.
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.271541  9967 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal
10:27:15.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/logs
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data/info.pb
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
10:27:15.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.195:0
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.195
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.195
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.195.keytab
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.195
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:15.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
10:27:15.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.382021 10352 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
10:27:15.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.382366 10352 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
10:27:15.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.382395 10352 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
10:27:15.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.382442 10352 flags.cc:425] Enabled unsafe flag: --never_fsync=true
10:27:15.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.386672 10352 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
10:27:15.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.386827 10352 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.9.187.195
10:27:15.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.392233 10352 tablet_server_runner.cc:78] Tablet server non-default flags:
10:27:15.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
10:27:15.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.9.187.212:44327
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kudu_127.9.187.195.keytab
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.9.187.195
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.9.187.195:0
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data/info.pb
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.9.187.195
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
10:27:15.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.9.187.254:36109
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.10352
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.9.187.195
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/logs
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 09:48:28 UTC on ccycloud.quasar-erdyzl.root.comops.site
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493122
10:27:15.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.393599 10352 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
10:27:15.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.394906 10352 file_cache.cc:493] Constructed file cache file cache with capacity 419430
10:27:15.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.404487 10357 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
10:27:15.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.404495 10360 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
10:27:15.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.404531 10352 server_base.cc:1034] running on GCE node
10:27:15.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:15.404495 10358 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
10:27:15.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.405391 10352 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
10:27:15.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.405977 10352 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
10:27:15.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.407130 10352 hybrid_clock.cc:648] HybridClock initialized: now 1783506435407113 us; error 37 us; skew 500 ppm
10:27:15.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:15 dist-test-slave-c3lv krb5kdc[9977](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506435, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
10:27:15.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.409991 10352 init.cc:377] Logged in from keytab as kudu/127.9.187.195@KRBTEST.COM (short username kudu)
10:27:15.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.410835 10352 webserver.cc:460] Webserver started at http://127.9.187.195:43839/ using document root <none> and password file <none>
10:27:15.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.411353 10352 fs_manager.cc:359] Metadata directory not provided
10:27:15.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.411407 10352 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
10:27:15.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.411566 10352 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
10:27:15.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.413614 10352 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data/instance:
10:27:15.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e72ad228a38647f1b78806e15303acec"
10:27:15.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.414137 10352 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal/instance:
10:27:15.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e72ad228a38647f1b78806e15303acec"
10:27:15.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.418994 10352 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.005s	sys 0.000s
10:27:15.422 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.421954 10367 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
10:27:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.423558 10352 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.004s	sys 0.000s
10:27:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.423687 10352 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data,/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal
10:27:15.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e72ad228a38647f1b78806e15303acec"
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 10:27:15 on dist-test-slave-c3lv"
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.423808 10352 fs_report.cc:383] FS layout report
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data/data
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
10:27:15.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
10:27:15.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.445698 10352 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
10:27:15.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.449273 10352 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
10:27:15.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.449488 10352 kserver.cc:163] Server-wide thread pool size limit: 3276
10:27:15.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.450174 10352 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
10:27:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.451030 10352 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
10:27:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.451102 10352 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
10:27:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.451157 10352 ts_tablet_manager.cc:610] Registered 0 tablets
10:27:15.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.451181 10352 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
10:27:15.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.459733 10352 rpc_server.cc:307] RPC server started. Bound to: 127.9.187.195:36711
10:27:15.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.459750 10480 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.9.187.195:36711 every 8 connection(s)
10:27:15.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.460621 10352 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/data/info.pb
10:27:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.468190  9967 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu as pid 10352
10:27:15.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.468291  9967 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal/instance
10:27:15.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:15 dist-test-slave-c3lv krb5kdc[9977](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506435, etypes {rep=17 tkt=17 ses=17}, kudu/127.9.187.195@KRBTEST.COM for kudu/127.9.187.254@KRBTEST.COM
10:27:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.475538 10481 heartbeater.cc:347] Connected to a master server at 127.9.187.254:36109
10:27:15.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.475767 10481 heartbeater.cc:464] Registering TS with master...
10:27:15.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.476193 10481 heartbeater.cc:511] Master 127.9.187.254:36109 requested a full tablet report, sending...
10:27:15.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.477164 10022 ts_manager.cc:194] Registered new tserver with Master: e72ad228a38647f1b78806e15303acec (127.9.187.195:36711)
10:27:15.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.477686 10022 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.9.187.195@KRBTEST.COM'} at 127.9.187.195:37191
10:27:15.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:15.482698  9967 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
10:27:15.483 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
10:27:15.484 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

10:27:15.494 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

10:27:15.496 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

10:27:15.508 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.9.187.254"
      port: 36109
    }
    bound_http_address {
      host: "127.9.187.254"
      port: 36883
    }
  }
}

10:27:15.511 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

10:27:15.514 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.9.187.193"
      port: 38197
    }
    bound_http_address {
      host: "127.9.187.193"
      port: 41305
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.9.187.194"
      port: 32771
    }
    bound_http_address {
      host: "127.9.187.194"
      port: 41791
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.9.187.195"
      port: 36711
    }
    bound_http_address {
      host: "127.9.187.195"
      port: 43839
    }
  }
}

10:27:15.514 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
10:27:15.669 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/krb5kdc/krb5cc
10:27:15.686 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
10:27:15.830 [DEBUG - main] (Connection.java:748) [peer master-127.9.187.254:36109(127.9.187.254:36109)] connecting to peer
10:27:15.894 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.9.187.254:36109(127.9.187.254:36109)] Successfully connected to peer
10:27:15.964 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.9.187.254
10:27:16.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.049149 10213 heartbeater.cc:503] Master 127.9.187.254:36109 was elected leader, sending a full tablet report...
10:27:16.123 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 10:27:16 dist-test-slave-c3lv krb5kdc[9977](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783506434, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.9.187.254@KRBTEST.COM
10:27:16.151 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x1acdf74e, L:/127.0.0.1:55964 - R:/127.9.187.254:36109] using SASL/GSSAPI
10:27:16.187 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
10:27:16.189 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=399), Traces: [0ms] refreshing cache from master, [27ms] Sub RPC ConnectToMaster: sending RPC to server master-127.9.187.254:36109, [369ms] Sub RPC ConnectToMaster: received response from server master-127.9.187.254:36109: OK, deferred=null) after lookup
10:27:16.213 [DEBUG - main] (Connection.java:575) [peer master-127.9.187.254:36109(127.9.187.254:36109)] disconnecting while in state READY
10:27:16.220 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.9.187.254:36109(127.9.187.254:36109)] handling channelInactive
10:27:16.221 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.9.187.254:36109(127.9.187.254:36109)] cleaning up while in state READY due to: connection closed
10:27:16.222 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.9.187.254:36109(127.9.187.254:36109) for tablet Kudu Master: connection closed
10:27:16.230 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.9.187.254:36109(127.9.187.254:36109)] connecting to peer
10:27:16.233 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.9.187.254:36109(127.9.187.254:36109)] Successfully connected to peer
10:27:16.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.267591 10347 heartbeater.cc:503] Master 127.9.187.254:36109 was elected leader, sending a full tablet report...
10:27:16.286 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x5894f7cd, L:/127.0.0.1:55966 - R:/127.9.187.254:36109] using TOKEN/null
10:27:16.289 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
10:27:16.290 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=76), Traces: [0ms] sending RPC to server master-127.9.187.254:36109, [7ms] received response from server master-127.9.187.254:36109: Network error: connection closed, [8ms] delaying RPC due to: Network error: connection closed, [16ms] refreshing cache from master, [16ms] Sub RPC ConnectToMaster: sending RPC to server master-127.9.187.254:36109, [74ms] Sub RPC ConnectToMaster: received response from server master-127.9.187.254:36109: OK, deferred=Deferred@1164384498(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.354183 10022 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:55966:
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.356 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
10:27:16.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
10:27:16.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
10:27:16.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:16.357723 10022 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.
10:27:16.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.380843 10415 tablet_service.cc:1467] Processing CreateTablet for tablet 63fe9c68862041a7ba04a3b071695656 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]), partition=RANGE (key) PARTITION UNBOUNDED
10:27:16.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.382300 10415 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 63fe9c68862041a7ba04a3b071695656. 1 dirs total, 0 dirs full, 0 dirs failed
10:27:16.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.382448 10147 tablet_service.cc:1467] Processing CreateTablet for tablet 63fe9c68862041a7ba04a3b071695656 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]), partition=RANGE (key) PARTITION UNBOUNDED
10:27:16.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.383451 10147 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 63fe9c68862041a7ba04a3b071695656. 1 dirs total, 0 dirs full, 0 dirs failed
10:27:16.390 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a502cac188784931b12e80df1d958be9
10:27:16.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.385638 10281 tablet_service.cc:1467] Processing CreateTablet for tablet 63fe9c68862041a7ba04a3b071695656 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]), partition=RANGE (key) PARTITION UNBOUNDED
10:27:16.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.386641 10281 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 63fe9c68862041a7ba04a3b071695656. 1 dirs total, 0 dirs full, 0 dirs failed
10:27:16.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.391119 10497 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Bootstrap starting.
10:27:16.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.392426 10498 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Bootstrap starting.
10:27:16.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.394208 10499 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Bootstrap starting.
10:27:16.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.395594 10497 tablet_bootstrap.cc:654] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Neither blocks nor log segments found. Creating new log.
10:27:16.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.396147 10498 tablet_bootstrap.cc:654] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Neither blocks nor log segments found. Creating new log.
10:27:16.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.396636 10499 tablet_bootstrap.cc:654] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Neither blocks nor log segments found. Creating new log.
10:27:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.396818 10497 log.cc:824] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Log is configured to *not* fsync() on all Append() calls
10:27:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.397100 10498 log.cc:824] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Log is configured to *not* fsync() on all Append() calls
10:27:16.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.397502 10499 log.cc:824] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Log is configured to *not* fsync() on all Append() calls
10:27:16.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.398797 10498 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: No bootstrap required, opened a new log
10:27:16.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.398792 10497 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: No bootstrap required, opened a new log
10:27:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.398981 10497 ts_tablet_manager.cc:1397] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Time spent bootstrapping tablet: real 0.008s	user 0.004s	sys 0.000s
10:27:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.399237 10499 tablet_bootstrap.cc:492] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: No bootstrap required, opened a new log
10:27:16.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.399302 10498 ts_tablet_manager.cc:1397] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
10:27:16.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.400205 10499 ts_tablet_manager.cc:1397] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Time spent bootstrapping tablet: real 0.006s	user 0.000s	sys 0.005s
10:27:16.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.403635 10497 raft_consensus.cc:348] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.403908 10497 raft_consensus.cc:374] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.403959 10497 raft_consensus.cc:729] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e72ad228a38647f1b78806e15303acec, State: Initialized, Role: FOLLOWER
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.403882 10498 raft_consensus.cc:348] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.404098 10498 raft_consensus.cc:374] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.404138 10498 raft_consensus.cc:729] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b91186c63e024c8d97a6a2e3f67168b7, State: Initialized, Role: FOLLOWER
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.404484 10497 consensus_queue.cc:260] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [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: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.404484 10498 consensus_queue.cc:260] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [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: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405210 10499 raft_consensus.cc:348] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405539 10498 ts_tablet_manager.cc:1428] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Time spent starting tablet: real 0.006s	user 0.006s	sys 0.000s
10:27:16.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405539 10497 ts_tablet_manager.cc:1428] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Time spent starting tablet: real 0.007s	user 0.007s	sys 0.000s
10:27:16.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405747 10499 raft_consensus.cc:374] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
10:27:16.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405880 10481 heartbeater.cc:503] Master 127.9.187.254:36109 was elected leader, sending a full tablet report...
10:27:16.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.405913 10499 raft_consensus.cc:729] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 89e2a4df17354eabacda3ff31720265e, State: Initialized, Role: FOLLOWER
10:27:16.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.406603 10499 consensus_queue.cc:260] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [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: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.410866 10499 ts_tablet_manager.cc:1428] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Time spent starting tablet: real 0.010s	user 0.006s	sys 0.000s
10:27:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.448948 10504 raft_consensus.cc:482] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
10:27:16.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.449146 10504 raft_consensus.cc:504] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.450346 10504 leader_election.cc:288] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 89e2a4df17354eabacda3ff31720265e (127.9.187.194:32771), b91186c63e024c8d97a6a2e3f67168b7 (127.9.187.193:38197)
10:27:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.455459 10167 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "63fe9c68862041a7ba04a3b071695656" candidate_uuid: "e72ad228a38647f1b78806e15303acec" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b91186c63e024c8d97a6a2e3f67168b7" is_pre_election: true
10:27:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.455457 10301 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "63fe9c68862041a7ba04a3b071695656" candidate_uuid: "e72ad228a38647f1b78806e15303acec" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "89e2a4df17354eabacda3ff31720265e" is_pre_election: true
10:27:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.455783 10167 raft_consensus.cc:2454] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e72ad228a38647f1b78806e15303acec in term 0.
10:27:16.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.455783 10301 raft_consensus.cc:2454] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate e72ad228a38647f1b78806e15303acec in term 0.
10:27:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.456245 10368 leader_election.cc:302] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [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: 89e2a4df17354eabacda3ff31720265e, e72ad228a38647f1b78806e15303acec; no voters: 
10:27:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.456501 10504 raft_consensus.cc:2781] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Leader pre-election won for term 1
10:27:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.456626 10504 raft_consensus.cc:482] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
10:27:16.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.456672 10504 raft_consensus.cc:3037] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 0 FOLLOWER]: Advancing to term 1
10:27:16.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.457651 10504 raft_consensus.cc:504] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.458012 10504 leader_election.cc:288] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [CANDIDATE]: Term 1 election: Requested vote from peers 89e2a4df17354eabacda3ff31720265e (127.9.187.194:32771), b91186c63e024c8d97a6a2e3f67168b7 (127.9.187.193:38197)
10:27:16.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.458294 10301 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "63fe9c68862041a7ba04a3b071695656" candidate_uuid: "e72ad228a38647f1b78806e15303acec" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "89e2a4df17354eabacda3ff31720265e"
10:27:16.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.458438 10301 raft_consensus.cc:3037] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 0 FOLLOWER]: Advancing to term 1
10:27:16.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.458470 10167 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "63fe9c68862041a7ba04a3b071695656" candidate_uuid: "e72ad228a38647f1b78806e15303acec" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b91186c63e024c8d97a6a2e3f67168b7"
10:27:16.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.458573 10167 raft_consensus.cc:3037] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 0 FOLLOWER]: Advancing to term 1
10:27:16.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.459725 10301 raft_consensus.cc:2454] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e72ad228a38647f1b78806e15303acec in term 1.
10:27:16.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.459725 10167 raft_consensus.cc:2454] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate e72ad228a38647f1b78806e15303acec in term 1.
10:27:16.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.460033 10368 leader_election.cc:302] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [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: b91186c63e024c8d97a6a2e3f67168b7, e72ad228a38647f1b78806e15303acec; no voters: 
10:27:16.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.460194 10504 raft_consensus.cc:2781] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 1 FOLLOWER]: Leader election won for term 1
10:27:16.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.460388 10504 raft_consensus.cc:686] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 1 LEADER]: Becoming Leader. State: Replica: e72ad228a38647f1b78806e15303acec, State: Running, Role: LEADER
10:27:16.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.460731 10504 consensus_queue.cc:237] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [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: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } }
10:27:16.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:16.462136 10482 tablet.cc:2369] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Can't schedule compaction. Clean time has not been advanced past its initial value.
10:27:16.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.464087 10022 catalog_manager.cc:5495] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec reported cstate change: term changed from 0 to 1, leader changed from <none> to e72ad228a38647f1b78806e15303acec (127.9.187.195). New cstate: current_term: 1 leader_uuid: "e72ad228a38647f1b78806e15303acec" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "e72ad228a38647f1b78806e15303acec" member_type: VOTER last_known_addr { host: "127.9.187.195" port: 36711 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 } health_report { overall_health: UNKNOWN } } }
10:27:16.476 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a502cac188784931b12e80df1d958be9
10:27:16.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:16.494467 10348 tablet.cc:2369] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Can't schedule compaction. Clean time has not been advanced past its initial value.
10:27:16.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:16.526719 10214 tablet.cc:2369] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Can't schedule compaction. Clean time has not been advanced past its initial value.
10:27:16.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.966539 10510 consensus_queue.cc:1035] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [LEADER]: Connected to new peer: Peer: permanent_uuid: "b91186c63e024c8d97a6a2e3f67168b7" member_type: VOTER last_known_addr { host: "127.9.187.193" port: 38197 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
10:27:16.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:16.972375 10515 consensus_queue.cc:1035] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [LEADER]: Connected to new peer: Peer: permanent_uuid: "89e2a4df17354eabacda3ff31720265e" member_type: VOTER last_known_addr { host: "127.9.187.194" port: 32771 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
10:27:17.480 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a502cac188784931b12e80df1d958be9
10:27:17.504 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 63fe9c68862041a7ba04a3b071695656 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
10:27:17.514 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299990, tablet=63fe9c68862041a7ba04a3b071695656@[89e2a4df17354eabacda3ff31720265e(127.9.187.194:32771),b91186c63e024c8d97a6a2e3f67168b7(127.9.187.193:38197),e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)[L]]}]
10:27:17.516 [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, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.9.187.254:36109, [8ms] Sub RPC GetTableLocations: received response from server master-127.9.187.254:36109: OK, deferred=null)) after lookup
10:27:17.532 [DEBUG - kudu-nio-1] (Connection.java:748) [peer e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)] connecting to peer
10:27:17.538 [DEBUG - kudu-nio-0] (Connection.java:757) [peer e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)] Successfully connected to peer
10:27:17.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:17.563417 10521 fault_injection.cc:43] FAULT INJECTION ENABLED!
10:27:17.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 10:27:17.563519 10521 fault_injection.cc:44] THIS SERVER MAY CRASH!
10:27:17.565 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xb7409b3e, L:/127.0.0.1:49002 - R:/127.9.187.195:36711] using TOKEN/null
10:27:17.590 [DEBUG - kudu-nio-0] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=63fe9c68862041a7ba04a3b071695656, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
10:27:17.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.605005 10020 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin'} at 127.0.0.1:55966:
10:27:17.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
10:27:17.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.605196 10020 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin'} at 127.0.0.1:55966:
10:27:17.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
10:27:17.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.608389 10020 catalog_manager.cc:5782] T 00000000000000000000000000000000 P 9696706236bc4242bb92fcf28a872e03: Sending DeleteTablet for 3 replicas of tablet 63fe9c68862041a7ba04a3b071695656
10:27:17.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.609386 10415 tablet_service.cc:1514] Processing DeleteTablet for tablet 63fe9c68862041a7ba04a3b071695656 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 10:27:17 UTC) from {username='kudu', principal='kudu/127.9.187.254@KRBTEST.COM'} at 127.0.0.1:48992
10:27:17.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.609390 10281 tablet_service.cc:1514] Processing DeleteTablet for tablet 63fe9c68862041a7ba04a3b071695656 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 10:27:17 UTC) from {username='kudu', principal='kudu/127.9.187.254@KRBTEST.COM'} at 127.0.0.1:58810
10:27:17.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.609944 10147 tablet_service.cc:1514] Processing DeleteTablet for tablet 63fe9c68862041a7ba04a3b071695656 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 10:27:17 UTC) from {username='kudu', principal='kudu/127.9.187.254@KRBTEST.COM'} at 127.0.0.1:38470
10:27:17.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.610399 10529 tablet_replica.cc:330] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: stopping tablet replica
10:27:17.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.611003 10529 raft_consensus.cc:2229] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 1 FOLLOWER]: Raft consensus shutting down.
10:27:17.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.611785 10529 raft_consensus.cc:2258] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7 [term 1 FOLLOWER]: Raft consensus is shut down!
10:27:17.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.612733 10528 tablet_replica.cc:330] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: stopping tablet replica
10:27:17.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.613116 10528 raft_consensus.cc:2229] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 1 LEADER]: Raft consensus shutting down.
10:27:17.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.613525 10528 raft_consensus.cc:2258] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec [term 1 FOLLOWER]: Raft consensus is shut down!
10:27:17.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.613873 10527 tablet_replica.cc:330] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: stopping tablet replica
10:27:17.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.613991 10529 ts_tablet_manager.cc:1905] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Deleting tablet data with delete state TABLET_DATA_DELETED
10:27:17.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.614171 10527 raft_consensus.cc:2229] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 1 FOLLOWER]: Raft consensus shutting down.
10:27:17.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.614420 10527 raft_consensus.cc:2258] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e [term 1 FOLLOWER]: Raft consensus is shut down!
10:27:17.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.615665 10528 ts_tablet_manager.cc:1905] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Deleting tablet data with delete state TABLET_DATA_DELETED
10:27:17.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.616688 10527 ts_tablet_manager.cc:1905] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Deleting tablet data with delete state TABLET_DATA_DELETED
10:27:17.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.618582 10528 ts_tablet_manager.cc:1918] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
10:27:17.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.618737 10529 ts_tablet_manager.cc:1918] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
10:27:17.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.618835 10528 log.cc:1196] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Deleting WAL directory at /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-2/wal/wals/63fe9c68862041a7ba04a3b071695656
10:27:17.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.619022 10529 log.cc:1196] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Deleting WAL directory at /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-0/wal/wals/63fe9c68862041a7ba04a3b071695656
10:27:17.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.619200 10528 ts_tablet_manager.cc:1939] T 63fe9c68862041a7ba04a3b071695656 P e72ad228a38647f1b78806e15303acec: Deleting consensus metadata
10:27:17.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.619475 10529 ts_tablet_manager.cc:1939] T 63fe9c68862041a7ba04a3b071695656 P b91186c63e024c8d97a6a2e3f67168b7: Deleting consensus metadata
10:27:17.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.620571 10008 catalog_manager.cc:4841] TS e72ad228a38647f1b78806e15303acec (127.9.187.195:36711): tablet 63fe9c68862041a7ba04a3b071695656 (table TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]) successfully deleted
10:27:17.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.620594 10006 catalog_manager.cc:4841] TS b91186c63e024c8d97a6a2e3f67168b7 (127.9.187.193:38197): tablet 63fe9c68862041a7ba04a3b071695656 (table TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]) successfully deleted
10:27:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.626431 10527 ts_tablet_manager.cc:1918] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
10:27:17.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.626708 10527 log.cc:1196] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Deleting WAL directory at /tmp/dist-test-taskRyhUC6/test-tmp/mini-kudu-cluster6950614852839295914/ts-1/wal/wals/63fe9c68862041a7ba04a3b071695656
10:27:17.627 [DEBUG - main] (Connection.java:575) [peer e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)] disconnecting while in state READY
10:27:17.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.627177 10527 ts_tablet_manager.cc:1939] T 63fe9c68862041a7ba04a3b071695656 P 89e2a4df17354eabacda3ff31720265e: Deleting consensus metadata
10:27:17.627 [DEBUG - main] (Connection.java:575) [peer master-127.9.187.254:36109(127.9.187.254:36109)] disconnecting while in state READY
10:27:17.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.630204 10006 catalog_manager.cc:4841] TS 89e2a4df17354eabacda3ff31720265e (127.9.187.194:32771): tablet 63fe9c68862041a7ba04a3b071695656 (table TestAuthnTokenReacquireOpen-table [id=a502cac188784931b12e80df1d958be9]) successfully deleted
10:27:17.631 [DEBUG - kudu-nio-0] (Connection.java:239) [peer e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)] handling channelInactive
10:27:17.631 [DEBUG - kudu-nio-0] (Connection.java:709) [peer e72ad228a38647f1b78806e15303acec(127.9.187.195:36711)] cleaning up while in state READY due to: connection closed
10:27:17.632 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
10:27:17.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.636334  9967 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu with pid 10084
10:27:17.637 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.9.187.254:36109(127.9.187.254:36109)] handling channelInactive
10:27:17.638 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.9.187.254:36109(127.9.187.254:36109)] cleaning up while in state READY due to: connection closed
10:27:17.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.642550  9967 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu with pid 10218
10:27:17.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.649741  9967 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu with pid 10352
10:27:17.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 10:27:17.654799  9967 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskRyhUC6/build/debug/bin/kudu with pid 9990
10:27:17.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T10:27:17Z chronyd exiting

Time: 4.856

OK (1 test)

