JUnit version 4.13.2
.23:11:59.879 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783465919869
23:11:59.914 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
23:11:59.952 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
23:11:59.959 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskMbNw8m/test-tmp
23:11:59.987 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
23:11:59.990 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskMbNw8m/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
23:12:00.229 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079"
  extra_master_flags: "--webserver_require_spnego=false"
  extra_master_flags: "--authn_token_validity_seconds=1"
  extra_master_flags: "--rpc_default_keepalive_time_ms=120000"
  extra_tserver_flags: "--webserver_require_spnego=false"
  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 {
  }
}

23:12:00.247 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:12:00.248 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

23:12:00.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:00.249348 28749 mini_oidc.cc:150] Starting JWKS server
23:12:00.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:00.250061 28749 webserver.cc:534] Webserver started at http://127.0.0.1:37221/ using document root <none> and password file <none>
23:12:00.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:00.250154 28749 mini_oidc.cc:186] Starting OIDC Discovery server
23:12:00.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:00.250470 28749 webserver.cc:534] Webserver started at http://127.0.0.1:38205/ using document root <none> and password file <none>
23:12:00.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
23:12:00.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/principal' for realm 'KRBTEST.COM',
23:12:00.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
23:12:00.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:00 dist-test-slave-74ln krb5kdc[28759](info): setting up network...
23:12:00.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
23:12:00.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:00 dist-test-slave-74ln krb5kdc[28759](info): set up 2 sockets
23:12:00.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:00 dist-test-slave-74ln krb5kdc[28759](info): commencing operation
23:12:00.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
23:12:02.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.134632 28749 mini_kdc.cc:121] Time spent starting KDC: real 1.879s	user 0.000s	sys 0.006s
23:12:02.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
23:12:02.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
23:12:02.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
23:12:02.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
23:12:02.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
23:12:02.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
23:12:02.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
23:12:02.204 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
23:12:02.205 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
23:12:02.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
23:12:02.220 [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-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/test-user.keytab.
23:12:02.220 [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-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/test-user.keytab.
23:12:02.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
23:12:02.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
23:12:02.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:12:02Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
23:12:02.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:12:02Z Disabled control of system clock
23:12:02.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.28.19.126@KRBTEST.COM; defaulting to no policy
23:12:02.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.28.19.126@KRBTEST.COM" created.
23:12:02.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.28.19.126@KRBTEST.COM; defaulting to no policy
23:12:02.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.28.19.126@KRBTEST.COM" created.
23:12:02.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.297200 28749 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal
23:12:02.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data
23:12:02.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/logs
23:12:02.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data/info.pb
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:12:02.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.126:38657
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.126
23:12:02.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.126
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
23:12:02.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.19.126:38657
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:12:02.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37221/jwks.json
23:12:02.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
23:12:02.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
23:12:02.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
23:12:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.380169 28775 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:12:02.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.380355 28775 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:12:02.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.380378 28775 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:12:02.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382011 28775 flags.cc:432] Enabled experimental flag: --authn_token_validity_seconds=1
23:12:02.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382068 28775 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
23:12:02.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382082 28775 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:12:02.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382094 28775 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
23:12:02.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382104 28775 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
23:12:02.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382115 28775 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
23:12:02.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.382125 28775 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:37221/jwks.json
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.384872 28775 master_runner.cc:387] Master server non-default flags:
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data
23:12:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal
23:12:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
23:12:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
23:12:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.28.19.126:38657
23:12:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.126
23:12:02.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
23:12:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.126:38657
23:12:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
23:12:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:12:02.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
23:12:02.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:37221/jwks.json
23:12:02.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
23:12:02.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
23:12:02.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data/info.pb
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.126
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.28775
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/logs
23:12:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:12:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:22 UTC on e7f111948823
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16827
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.385113 28775 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.385252 28775 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.388288 28775 server_base.cc:1061] running on GCE node
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.388290 28780 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
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.388609 28781 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
23:12:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.389572 28783 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
23:12:02.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.389834 28775 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:12:02.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.390151 28775 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:12:02.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.392156 28775 hybrid_clock.cc:648] HybridClock initialized: now 1783465922392125 us; error 41 us; skew 500 ppm
23:12:02.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
23:12:02.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.395269 28775 init.cc:377] Logged in from keytab as kudu/127.28.19.126@KRBTEST.COM (short username kudu)
23:12:02.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.396193 28775 webserver.cc:534] Webserver started at http://127.28.19.126:35795/ using document root <none> and password file <none>
23:12:02.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.396540 28775 fs_manager.cc:362] Metadata directory not provided
23:12:02.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.396588 28775 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:12:02.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.396700 28775 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:12:02.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.398032 28775 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data/instance:
23:12:02.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6"
23:12:02.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.398375 28775 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal/instance:
23:12:02.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6"
23:12:02.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.399919 28775 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
23:12:02.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.401094 28790 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:12:02.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.401326 28775 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
23:12:02.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.401399 28775 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data,/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal
23:12:02.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6"
23:12:02.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.401468 28775 fs_report.cc:389] FS layout report
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data/data
23:12:02.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:12:02.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:12:02.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:12:02.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:12:02.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:12:02.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:12:02.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.417351 28775 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:12:02.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.419528 28775 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:12:02.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.419638 28775 kserver.cc:163] Server-wide thread pool size limit: 3276
23:12:02.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.423887 28775 rpc_server.cc:307] RPC server started. Bound to: 127.28.19.126:38657
23:12:02.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.423946 28844 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.19.126:38657 every 8 connection(s)
23:12:02.424 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.424319 28775 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/data/info.pb
23:12:02.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.425056 28845 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
23:12:02.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.428248 28845 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: Bootstrap starting.
23:12:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.429024 28845 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: Neither blocks nor log segments found. Creating new log.
23:12:02.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.429312 28845 log.cc:826] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: Log is configured to *not* fsync() on all Append() calls
23:12:02.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.430012 28845 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: No bootstrap required, opened a new log
23:12:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.431844 28845 raft_consensus.cc:359] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } }
23:12:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432020 28845 raft_consensus.cc:385] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:12:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432052 28845 raft_consensus.cc:740] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 607e3a2e6e9b4b8b80fb5b91d28b78f6, State: Initialized, Role: FOLLOWER
23:12:02.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432293 28845 consensus_queue.cc:260] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [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: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } }
23:12:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432364 28845 raft_consensus.cc:399] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
23:12:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432394 28845 raft_consensus.cc:493] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
23:12:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.432430 28845 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 0 FOLLOWER]: Advancing to term 1
23:12:02.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.433115 28845 raft_consensus.cc:515] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } }
23:12:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.433220 28845 leader_election.cc:304] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [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: 607e3a2e6e9b4b8b80fb5b91d28b78f6; no voters: 
23:12:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.433384 28845 leader_election.cc:290] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [CANDIDATE]: Term 1 election: Requested vote from peers 
23:12:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.433597 28845 sys_catalog.cc:565] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [sys.catalog]: configured and running, proceeding with master startup.
23:12:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434044 28849 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 1 FOLLOWER]: Leader election won for term 1
23:12:02.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434204 28849 raft_consensus.cc:697] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [term 1 LEADER]: Becoming Leader. State: Replica: 607e3a2e6e9b4b8b80fb5b91d28b78f6, State: Running, Role: LEADER
23:12:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434306 28849 consensus_queue.cc:237] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [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: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } }
23:12:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434499 28749 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskMbNw8m/build/release/bin/kudu as pid 28775
23:12:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434594 28749 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/master-0/wal/instance
23:12:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434635 28849 sys_catalog.cc:455] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } } }
23:12:02.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434702 28849 sys_catalog.cc:458] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [sys.catalog]: This master's current role is: LEADER
23:12:02.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434826 28849 sys_catalog.cc:455] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 607e3a2e6e9b4b8b80fb5b91d28b78f6. Latest consensus state: current_term: 1 leader_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "607e3a2e6e9b4b8b80fb5b91d28b78f6" member_type: VOTER last_known_addr { host: "127.28.19.126" port: 38657 } } }
23:12:02.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.434873 28849 sys_catalog.cc:458] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6 [sys.catalog]: This master's current role is: LEADER
23:12:02.437 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.436951 28854 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
23:12:02.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.437903 28854 catalog_manager.cc:1519] Initializing Kudu cluster ID...
23:12:02.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.439571 28854 catalog_manager.cc:1382] Generated new cluster ID: 208938b369ee427d983d20b1f1a78fb0
23:12:02.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.439625 28854 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
23:12:02.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.28.19.126@KRBTEST.COM
23:12:02.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.448354 28854 catalog_manager.cc:1405] Generated new certificate authority record
23:12:02.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.449541 28854 catalog_manager.cc:1539] Loading token signing keys...
23:12:02.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.460248 28854 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: Generated new TSK 0
23:12:02.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.460562 28854 catalog_manager.cc:1549] Initializing in-progress tserver states...
23:12:02.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.28.19.65@KRBTEST.COM; defaulting to no policy
23:12:02.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.28.19.65@KRBTEST.COM" created.
23:12:02.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.28.19.65@KRBTEST.COM; defaulting to no policy
23:12:02.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.28.19.65@KRBTEST.COM" created.
23:12:02.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.528039 28749 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/logs
23:12:02.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data/info.pb
23:12:02.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:12:02.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.65:0
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.65
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.65
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:02.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.65
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
23:12:02.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.534 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
23:12:02.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.614640 28874 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
23:12:02.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.614851 28874 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:12:02.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.614867 28874 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:12:02.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.614890 28874 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:12:02.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.617065 28874 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:12:02.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.617141 28874 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.19.65
23:12:02.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.618944 28874 tablet_server_runner.cc:78] Tablet server non-default flags:
23:12:02.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data
23:12:02.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal
23:12:02.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
23:12:02.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.65
23:12:02.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.65:0
23:12:02.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:12:02.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
23:12:02.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
23:12:02.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data/info.pb
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.65
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:12:02.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.28874
23:12:02.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:12:02.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:12:02.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.65
23:12:02.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/logs
23:12:02.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:12:02.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:22 UTC on e7f111948823
23:12:02.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16827
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.619159 28874 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.619299 28874 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.622531 28880 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
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.622687 28882 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
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.622538 28879 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
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.623744 28874 server_base.cc:1061] running on GCE node
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.623982 28874 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:12:02.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.624248 28874 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.625398 28874 hybrid_clock.cc:648] HybridClock initialized: now 1783465922625376 us; error 39 us; skew 500 ppm
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.628181 28874 init.cc:377] Logged in from keytab as kudu/127.28.19.65@KRBTEST.COM (short username kudu)
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.628616 28874 webserver.cc:534] Webserver started at http://127.28.19.65:39533/ using document root <none> and password file <none>
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.628787 28874 fs_manager.cc:362] Metadata directory not provided
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.628827 28874 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:12:02.634 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.628919 28874 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:12:02.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.629964 28874 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data/instance:
23:12:02.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0b3783e60b4e412d9889ed4214c0f603"
23:12:02.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.630270 28874 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal/instance:
23:12:02.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0b3783e60b4e412d9889ed4214c0f603"
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.631737 28874 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.632507 28890 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.632633 28874 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.000s
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.632676 28874 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data,/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal
23:12:02.636 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0b3783e60b4e412d9889ed4214c0f603"
23:12:02.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.632727 28874 fs_report.cc:389] FS layout report
23:12:02.638 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data/data
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:12:02.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:12:02.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:12:02.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.654031 28874 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:12:02.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.656523 28874 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:12:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.656790 28874 kserver.cc:163] Server-wide thread pool size limit: 3276
23:12:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.657112 28874 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:12:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.657517 28874 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:12:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.657567 28874 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:12:02.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.657599 28874 ts_tablet_manager.cc:616] Registered 0 tablets
23:12:02.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.657615 28874 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:12:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.664228 28874 rpc_server.cc:307] RPC server started. Bound to: 127.28.19.65:43561
23:12:02.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.664327 29007 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.19.65:43561 every 8 connection(s)
23:12:02.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.664551 28874 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/data/info.pb
23:12:02.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.666488 28749 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskMbNw8m/build/release/bin/kudu as pid 28874
23:12:02.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.666574 28749 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal/instance
23:12:02.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.65@KRBTEST.COM for kudu/127.28.19.126@KRBTEST.COM
23:12:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.28.19.66@KRBTEST.COM; defaulting to no policy
23:12:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.673875 29008 heartbeater.cc:344] Connected to a master server at 127.28.19.126:38657
23:12:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.673986 29008 heartbeater.cc:461] Registering TS with master...
23:12:02.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.674316 29008 heartbeater.cc:507] Master 127.28.19.126:38657 requested a full tablet report, sending...
23:12:02.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.675160 28808 ts_manager.cc:194] Registered new tserver with Master: 0b3783e60b4e412d9889ed4214c0f603 (127.28.19.65:43561)
23:12:02.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.28.19.66@KRBTEST.COM" created.
23:12:02.677 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.676703 28808 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.28.19.65@KRBTEST.COM'} at 127.28.19.65:44717
23:12:02.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.28.19.66@KRBTEST.COM; defaulting to no policy
23:12:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.28.19.66@KRBTEST.COM" created.
23:12:02.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.725636 28749 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/logs
23:12:02.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data/info.pb
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:12:02.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.66:0
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.66
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.66
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.66
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
23:12:02.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
23:12:02.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.808375 29015 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
23:12:02.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.808574 29015 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:12:02.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.808593 29015 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:12:02.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.808621 29015 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:12:02.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.810469 29015 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:12:02.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.810546 29015 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.19.66
23:12:02.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.812424 29015 tablet_server_runner.cc:78] Tablet server non-default flags:
23:12:02.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.66
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.66:0
23:12:02.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data/info.pb
23:12:02.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.66
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29015
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.815 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:12:02.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:12:02.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.66
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/logs
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:12:02.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:22 UTC on e7f111948823
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16827
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.812695 29015 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.812906 29015 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.816556 29021 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
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.816622 29015 server_base.cc:1061] running on GCE node
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.816769 29023 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
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:02.816927 29020 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
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.817139 29015 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.817389 29015 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:12:02.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.818528 29015 hybrid_clock.cc:648] HybridClock initialized: now 1783465922818499 us; error 46 us; skew 500 ppm
23:12:02.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
23:12:02.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.821954 29015 init.cc:377] Logged in from keytab as kudu/127.28.19.66@KRBTEST.COM (short username kudu)
23:12:02.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.822487 29015 webserver.cc:534] Webserver started at http://127.28.19.66:44443/ using document root <none> and password file <none>
23:12:02.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.822682 29015 fs_manager.cc:362] Metadata directory not provided
23:12:02.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.822741 29015 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:12:02.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.822839 29015 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:12:02.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.823959 29015 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data/instance:
23:12:02.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "98afa9d321b8465aa620a2d845ffcfa2"
23:12:02.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.824388 29015 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal/instance:
23:12:02.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "98afa9d321b8465aa620a2d845ffcfa2"
23:12:02.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.825930 29015 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
23:12:02.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.826759 29030 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:12:02.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.826959 29015 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
23:12:02.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.827018 29015 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data,/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal
23:12:02.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "98afa9d321b8465aa620a2d845ffcfa2"
23:12:02.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:02 on dist-test-slave-74ln"
23:12:02.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.827076 29015 fs_report.cc:389] FS layout report
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data/data
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:12:02.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:12:02.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:12:02.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:12:02.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:12:02.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:12:02.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:12:02.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.868222 29015 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.869997 29015 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870105 29015 kserver.cc:163] Server-wide thread pool size limit: 3276
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870283 29015 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870560 29015 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870591 29015 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870613 29015 ts_tablet_manager.cc:616] Registered 0 tablets
23:12:02.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.870625 29015 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:12:02.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.877836 29015 rpc_server.cc:307] RPC server started. Bound to: 127.28.19.66:32775
23:12:02.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.877873 29144 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.19.66:32775 every 8 connection(s)
23:12:02.878 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.878165 29015 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/data/info.pb
23:12:02.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.882536 28749 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskMbNw8m/build/release/bin/kudu as pid 29015
23:12:02.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.882619 28749 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal/instance
23:12:02.884 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:02 dist-test-slave-74ln krb5kdc[28759](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.66@KRBTEST.COM for kudu/127.28.19.126@KRBTEST.COM
23:12:02.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.887691 29145 heartbeater.cc:344] Connected to a master server at 127.28.19.126:38657
23:12:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.887794 29145 heartbeater.cc:461] Registering TS with master...
23:12:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.887996 29145 heartbeater.cc:507] Master 127.28.19.126:38657 requested a full tablet report, sending...
23:12:02.888 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.888455 28808 ts_manager.cc:194] Registered new tserver with Master: 98afa9d321b8465aa620a2d845ffcfa2 (127.28.19.66:32775)
23:12:02.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.888976 28808 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.28.19.66@KRBTEST.COM'} at 127.28.19.66:47963
23:12:02.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.28.19.67@KRBTEST.COM; defaulting to no policy
23:12:02.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.28.19.67@KRBTEST.COM" created.
23:12:02.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.28.19.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for HTTP/127.28.19.67@KRBTEST.COM; defaulting to no policy
23:12:02.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "HTTP/127.28.19.67@KRBTEST.COM" created.
23:12:02.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal HTTP/127.28.19.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab.
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:02.932060 28749 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskMbNw8m/build/release/bin/kudu
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
23:12:02.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/logs
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data/info.pb
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
23:12:02.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.67:0
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.67
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.67
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.67
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:02.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=true
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_require_spnego=false
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:02.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
23:12:03.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.025410 29152 flags.cc:432] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
23:12:03.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.025651 29152 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
23:12:03.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.025666 29152 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
23:12:03.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.025689 29152 flags.cc:432] Enabled unsafe flag: --never_fsync=true
23:12:03.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.027423 29152 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
23:12:03.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.027495 29152 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.28.19.67
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.029796 29152 tablet_server_runner.cc:78] Tablet server non-default flags:
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.28.19.84:34839
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kudu.keytab
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.28.19.67
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.28.19.67:0
23:12:03.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data/info.pb
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.28.19.67
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.28.19.126:38657
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29152
23:12:03.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
23:12:03.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
23:12:03.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
23:12:03.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
23:12:03.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.28.19.67
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/logs
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
23:12:03.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 5090956cd8459f75ecce585332f90a8f50524d7f
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 07 Jul 2026 22:43:22 UTC on e7f111948823
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16827
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.030105 29152 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.030258 29152 file_cache.cc:492] Constructed file cache file cache with capacity 419430
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.033094 29157 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
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.033202 29158 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
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:03.033094 29160 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
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.033457 29152 server_base.cc:1061] running on GCE node
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.033588 29152 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
23:12:03.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.033768 29152 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
23:12:03.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.034900 29152 hybrid_clock.cc:648] HybridClock initialized: now 1783465923034875 us; error 36 us; skew 500 ppm
23:12:03.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:03 dist-test-slave-74ln krb5kdc[28759](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465923, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
23:12:03.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.037583 29152 init.cc:377] Logged in from keytab as kudu/127.28.19.67@KRBTEST.COM (short username kudu)
23:12:03.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.038000 29152 webserver.cc:534] Webserver started at http://127.28.19.67:36297/ using document root <none> and password file <none>
23:12:03.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.038192 29152 fs_manager.cc:362] Metadata directory not provided
23:12:03.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.038247 29152 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
23:12:03.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.038352 29152 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
23:12:03.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.039371 29152 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data/instance:
23:12:03.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86fdf1a4affe4ba59d9efdccf6f4d853"
23:12:03.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:03 on dist-test-slave-74ln"
23:12:03.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.039711 29152 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal/instance:
23:12:03.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86fdf1a4affe4ba59d9efdccf6f4d853"
23:12:03.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:03 on dist-test-slave-74ln"
23:12:03.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.041313 29152 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
23:12:03.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.042515 29167 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
23:12:03.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.042797 29152 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.042900 29152 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data,/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "86fdf1a4affe4ba59d9efdccf6f4d853"
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-07 23:12:03 on dist-test-slave-74ln"
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.042997 29152 fs_report.cc:389] FS layout report
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data/data
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
23:12:03.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
23:12:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
23:12:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
23:12:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
23:12:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
23:12:03.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
23:12:03.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.063055 29152 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
23:12:03.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.065239 29152 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
23:12:03.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.065378 29152 kserver.cc:163] Server-wide thread pool size limit: 3276
23:12:03.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.065694 29152 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
23:12:03.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.066068 29152 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
23:12:03.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.066107 29152 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
23:12:03.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.066136 29152 ts_tablet_manager.cc:616] Registered 0 tablets
23:12:03.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.066152 29152 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
23:12:03.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.071969 29152 rpc_server.cc:307] RPC server started. Bound to: 127.28.19.67:44413
23:12:03.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.072021 29281 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.28.19.67:44413 every 8 connection(s)
23:12:03.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.072340 29152 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/data/info.pb
23:12:03.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.076896 28749 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskMbNw8m/build/release/bin/kudu as pid 29152
23:12:03.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.076990 28749 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal/instance
23:12:03.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:03 dist-test-slave-74ln krb5kdc[28759](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783465923, etypes {rep=17 tkt=17 ses=17}, kudu/127.28.19.67@KRBTEST.COM for kudu/127.28.19.126@KRBTEST.COM
23:12:03.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.082255 29282 heartbeater.cc:344] Connected to a master server at 127.28.19.126:38657
23:12:03.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.082388 29282 heartbeater.cc:461] Registering TS with master...
23:12:03.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.082551 29282 heartbeater.cc:507] Master 127.28.19.126:38657 requested a full tablet report, sending...
23:12:03.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.083141 28808 ts_manager.cc:194] Registered new tserver with Master: 86fdf1a4affe4ba59d9efdccf6f4d853 (127.28.19.67:44413)
23:12:03.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.083551 28808 master_service.cc:502] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.28.19.67@KRBTEST.COM'} at 127.28.19.67:60309
23:12:03.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.089474 28749 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
23:12:03.090 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
23:12:03.091 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

23:12:03.103 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

23:12:03.104 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

23:12:03.112 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.19.126"
      port: 38657
    }
    bound_http_address {
      host: "127.28.19.126"
      port: 35795
    }
  }
}

23:12:03.115 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

23:12:03.117 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.28.19.65"
      port: 43561
    }
    bound_http_address {
      host: "127.28.19.65"
      port: 39533
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.28.19.66"
      port: 32775
    }
    bound_http_address {
      host: "127.28.19.66"
      port: 44443
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.28.19.67"
      port: 44413
    }
    bound_http_address {
      host: "127.28.19.67"
      port: 36297
    }
  }
}

23:12:03.117 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
23:12:03.308 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
23:12:03.331 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/krb5kdc/krb5cc
23:12:03.381 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
23:12:03.508 [DEBUG - main] (Connection.java:748) [peer master-127.28.19.126:38657(127.28.19.126:38657)] connecting to peer
23:12:03.591 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.28.19.126:38657(127.28.19.126:38657)] Successfully connected to peer
23:12:03.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.678036 29008 heartbeater.cc:499] Master 127.28.19.126:38657 was elected leader, sending a full tablet report...
23:12:03.722 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.28.19.126
23:12:03.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:03.889909 29145 heartbeater.cc:499] Master 127.28.19.126:38657 was elected leader, sending a full tablet report...
23:12:03.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 07 23:12:03 dist-test-slave-74ln krb5kdc[28759](info): TGS_REQ (1 etypes {17}) 127.0.0.1: ISSUE: authtime 1783465922, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.28.19.126@KRBTEST.COM
23:12:04.047 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xebfc39d9, L:/127.0.0.1:58276 - R:/127.28.19.126:38657] using SASL/GSSAPI
23:12:04.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.084687 29282 heartbeater.cc:499] Master 127.28.19.126:38657 was elected leader, sending a full tablet report...
23:12:04.091 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
23:12:04.091 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=630), Traces: [0ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.28.19.126:38657, [595ms] Sub RPC ConnectToMaster: received response from server master-127.28.19.126:38657: OK, deferred=null) after lookup
23:12:04.123 [DEBUG - main] (Connection.java:575) [peer master-127.28.19.126:38657(127.28.19.126:38657)] disconnecting while in state READY
23:12:04.131 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.28.19.126:38657(127.28.19.126:38657)] handling channelInactive
23:12:04.131 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.28.19.126:38657(127.28.19.126:38657)] cleaning up while in state READY due to: connection closed
23:12:04.132 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.28.19.126:38657(127.28.19.126:38657) for tablet Kudu Master: connection closed
23:12:04.150 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.28.19.126:38657(127.28.19.126:38657)] connecting to peer
23:12:04.154 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.28.19.126:38657(127.28.19.126:38657)] Successfully connected to peer
23:12:04.215 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd3bbf794, L:/127.0.0.1:58286 - R:/127.28.19.126:38657] using TOKEN/null
23:12:04.219 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
23:12:04.219 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=94), Traces: [0ms] sending RPC to server master-127.28.19.126:38657, [7ms] received response from server master-127.28.19.126:38657: Network error: connection closed, [7ms] delaying RPC due to: Network error: connection closed, [24ms] refreshing cache from master, [25ms] Sub RPC ConnectToMaster: sending RPC to server master-127.28.19.126:38657, [93ms] Sub RPC ConnectToMaster: received response from server master-127.28.19.126:38657: OK, deferred=Deferred@1862599194(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.293780 28808 catalog_manager.cc:2282] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:58286:
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
23:12:04.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
23:12:04.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
23:12:04.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:12:04.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:12:04.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
23:12:04.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
23:12:04.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:04.295989 28808 catalog_manager.cc:7076] 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.
23:12:04.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.309113 29216 tablet_service.cc:1511] Processing CreateTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]), partition=RANGE (key) PARTITION UNBOUNDED
23:12:04.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.309643 29216 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ad143f4f7d0c442c8fcccfbb2c289859. 1 dirs total, 0 dirs full, 0 dirs failed
23:12:04.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.314208 28941 tablet_service.cc:1511] Processing CreateTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]), partition=RANGE (key) PARTITION UNBOUNDED
23:12:04.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.314663 28941 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ad143f4f7d0c442c8fcccfbb2c289859. 1 dirs total, 0 dirs full, 0 dirs failed
23:12:04.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.315647 29301 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Bootstrap starting.
23:12:04.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.316320 29301 tablet_bootstrap.cc:654] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Neither blocks nor log segments found. Creating new log.
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.316619 29301 log.cc:826] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Log is configured to *not* fsync() on all Append() calls
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.317236 29301 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: No bootstrap required, opened a new log
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.317287 29301 ts_tablet_manager.cc:1403] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.317202 29079 tablet_service.cc:1511] Processing CreateTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]), partition=RANGE (key) PARTITION UNBOUNDED
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.317466 29079 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet ad143f4f7d0c442c8fcccfbb2c289859. 1 dirs total, 0 dirs full, 0 dirs failed
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.317777 29303 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Bootstrap starting.
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.318356 29303 tablet_bootstrap.cc:654] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Neither blocks nor log segments found. Creating new log.
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.318647 29303 log.cc:826] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Log is configured to *not* fsync() on all Append() calls
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.318938 29301 raft_consensus.cc:359] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319069 29301 raft_consensus.cc:385] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319095 29301 raft_consensus.cc:740] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 86fdf1a4affe4ba59d9efdccf6f4d853, State: Initialized, Role: FOLLOWER
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319235 29303 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: No bootstrap required, opened a new log
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319209 29301 consensus_queue.cc:260] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [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: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319290 29303 ts_tablet_manager.cc:1403] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.319423 29301 ts_tablet_manager.cc:1434] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.321173 29303 raft_consensus.cc:359] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.321311 29303 raft_consensus.cc:385] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.321343 29303 raft_consensus.cc:740] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0b3783e60b4e412d9889ed4214c0f603, State: Initialized, Role: FOLLOWER
23:12:04.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.321455 29303 consensus_queue.cc:260] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [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: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.321698 29303 ts_tablet_manager.cc:1434] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
23:12:04.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.322968 29306 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Bootstrap starting.
23:12:04.324 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:04.323941 29283 tablet.cc:2406] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:12:04.326 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.326357 29306 tablet_bootstrap.cc:654] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Neither blocks nor log segments found. Creating new log.
23:12:04.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.326988 29306 log.cc:826] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Log is configured to *not* fsync() on all Append() calls
23:12:04.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.328050 29306 tablet_bootstrap.cc:492] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: No bootstrap required, opened a new log
23:12:04.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.328150 29306 ts_tablet_manager.cc:1403] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Time spent bootstrapping tablet: real 0.005s	user 0.002s	sys 0.000s
23:12:04.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.329841 29306 raft_consensus.cc:359] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.330004 29306 raft_consensus.cc:385] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
23:12:04.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.330034 29306 raft_consensus.cc:740] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 98afa9d321b8465aa620a2d845ffcfa2, State: Initialized, Role: FOLLOWER
23:12:04.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.330157 29306 consensus_queue.cc:260] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [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: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.330411 29306 ts_tablet_manager.cc:1434] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Time spent starting tablet: real 0.002s	user 0.000s	sys 0.002s
23:12:04.335 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ac0404246d7e4136b28dfb6197efba0f
23:12:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:04.379720 29146 tablet.cc:2406] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:12:04.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:04.417058 29009 tablet.cc:2406] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Can't schedule compaction. Clean time has not been advanced past its initial value.
23:12:04.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.554399 29309 raft_consensus.cc:493] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
23:12:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.554574 29309 raft_consensus.cc:515] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.554965 29309 leader_election.cc:290] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 86fdf1a4affe4ba59d9efdccf6f4d853 (127.28.19.67:44413), 0b3783e60b4e412d9889ed4214c0f603 (127.28.19.65:43561)
23:12:04.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.559087 28961 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ad143f4f7d0c442c8fcccfbb2c289859" candidate_uuid: "98afa9d321b8465aa620a2d845ffcfa2" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0b3783e60b4e412d9889ed4214c0f603" is_pre_election: true
23:12:04.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.559293 28961 raft_consensus.cc:2468] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 98afa9d321b8465aa620a2d845ffcfa2 in term 0.
23:12:04.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.559811 29034 leader_election.cc:304] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [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: 0b3783e60b4e412d9889ed4214c0f603, 98afa9d321b8465aa620a2d845ffcfa2; no voters: 
23:12:04.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.560000 29309 raft_consensus.cc:2804] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Leader pre-election won for term 1
23:12:04.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.560052 29309 raft_consensus.cc:493] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
23:12:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.560098 29309 raft_consensus.cc:3060] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 0 FOLLOWER]: Advancing to term 1
23:12:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.560972 29309 raft_consensus.cc:515] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561136 29309 leader_election.cc:290] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [CANDIDATE]: Term 1 election: Requested vote from peers 86fdf1a4affe4ba59d9efdccf6f4d853 (127.28.19.67:44413), 0b3783e60b4e412d9889ed4214c0f603 (127.28.19.65:43561)
23:12:04.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561481 28961 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ad143f4f7d0c442c8fcccfbb2c289859" candidate_uuid: "98afa9d321b8465aa620a2d845ffcfa2" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0b3783e60b4e412d9889ed4214c0f603"
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561566 28961 raft_consensus.cc:3060] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 0 FOLLOWER]: Advancing to term 1
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561509 29236 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ad143f4f7d0c442c8fcccfbb2c289859" candidate_uuid: "98afa9d321b8465aa620a2d845ffcfa2" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" is_pre_election: true
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561674 29236 raft_consensus.cc:2468] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 98afa9d321b8465aa620a2d845ffcfa2 in term 0.
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561794 29235 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "ad143f4f7d0c442c8fcccfbb2c289859" candidate_uuid: "98afa9d321b8465aa620a2d845ffcfa2" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853"
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.561841 29235 raft_consensus.cc:3060] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 0 FOLLOWER]: Advancing to term 1
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562400 28961 raft_consensus.cc:2468] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 98afa9d321b8465aa620a2d845ffcfa2 in term 1.
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562608 29034 leader_election.cc:304] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [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: 0b3783e60b4e412d9889ed4214c0f603, 98afa9d321b8465aa620a2d845ffcfa2; no voters: 
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562641 29235 raft_consensus.cc:2468] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 98afa9d321b8465aa620a2d845ffcfa2 in term 1.
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562690 29309 raft_consensus.cc:2804] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 1 FOLLOWER]: Leader election won for term 1
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562822 29309 raft_consensus.cc:697] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 1 LEADER]: Becoming Leader. State: Replica: 98afa9d321b8465aa620a2d845ffcfa2, State: Running, Role: LEADER
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.562896 29309 consensus_queue.cc:237] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [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: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } }
23:12:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.563671 28808 catalog_manager.cc:5696] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 reported cstate change: term changed from 0 to 1, leader changed from <none> to 98afa9d321b8465aa620a2d845ffcfa2 (127.28.19.66). New cstate: current_term: 1 leader_uuid: "98afa9d321b8465aa620a2d845ffcfa2" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "98afa9d321b8465aa620a2d845ffcfa2" member_type: VOTER last_known_addr { host: "127.28.19.66" port: 32775 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 } health_report { overall_health: UNKNOWN } } }
23:12:04.653 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ac0404246d7e4136b28dfb6197efba0f
23:12:04.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.962564 29312 consensus_queue.cc:1048] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [LEADER]: Connected to new peer: Peer: permanent_uuid: "0b3783e60b4e412d9889ed4214c0f603" member_type: VOTER last_known_addr { host: "127.28.19.65" port: 43561 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:12:04.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:04.964939 29309 consensus_queue.cc:1048] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [LEADER]: Connected to new peer: Peer: permanent_uuid: "86fdf1a4affe4ba59d9efdccf6f4d853" member_type: VOTER last_known_addr { host: "127.28.19.67" port: 44413 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
23:12:05.658 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table ac0404246d7e4136b28dfb6197efba0f
23:12:05.679 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet ad143f4f7d0c442c8fcccfbb2c289859 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
23:12:05.685 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=ad143f4f7d0c442c8fcccfbb2c289859@[0b3783e60b4e412d9889ed4214c0f603(127.28.19.65:43561),86fdf1a4affe4ba59d9efdccf6f4d853(127.28.19.67:44413),98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)[L]]}]
23:12:05.696 [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=14), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.28.19.126:38657, [7ms] Sub RPC GetTableLocations: received response from server master-127.28.19.126:38657: OK, deferred=null)) after lookup
23:12:05.708 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] connecting to peer
23:12:05.711 [DEBUG - kudu-nio-2] (Connection.java:757) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] Successfully connected to peer
23:12:05.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:05.758559 29323 fault_injection.cc:43] FAULT INJECTION ENABLED!
23:12:05.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:05.758647 29323 fault_injection.cc:44] THIS SERVER MAY CRASH!
23:12:05.759 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:05.758980 29323 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:40854: token signing key expired
23:12:05.768 [DEBUG - kudu-nio-2] (Negotiator.java:352) peer /127.28.19.66:32775 sent connection negotiation error: Not authorized: token signing key expired
23:12:05.771 [DEBUG - kudu-nio-2] (Connection.java:239) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] handling channelInactive
23:12:05.771 [DEBUG - kudu-nio-2] (Connection.java:709) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
23:12:05.775 [DEBUG - kudu-nio-2] (Connection.java:748) [peer master-127.28.19.126:38657(127.28.19.126:38657)] connecting to peer
23:12:05.779 [DEBUG - kudu-nio-3] (Connection.java:757) [peer master-127.28.19.126:38657(127.28.19.126:38657)] Successfully connected to peer
23:12:05.787 [DEBUG - kudu-nio-3] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.28.19.126
23:12:05.830 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xbcc793aa, L:/127.0.0.1:40756 - R:/127.28.19.126:38657] using SASL/GSSAPI
23:12:05.833 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
23:12:05.835 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] connecting to peer
23:12:05.838 [DEBUG - kudu-nio-4] (Connection.java:757) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] Successfully connected to peer
23:12:05.863 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260707 23:12:05.863409 29323 negotiation.cc:343] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:40868: invalid token signature
23:12:05.865 [DEBUG - kudu-nio-4] (Negotiator.java:352) peer /127.28.19.66:32775 sent connection negotiation error: Not authorized: invalid token signature
23:12:05.867 [DEBUG - kudu-nio-4] (Connection.java:239) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] handling channelInactive
23:12:05.867 [DEBUG - kudu-nio-4] (Connection.java:709) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
23:12:05.869 [INFO - kudu-nio-3] (AsyncKuduClient.java:516) connect to master: received a new authn token
23:12:05.870 [DEBUG - kudu-nio-3] (Connection.java:748) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] connecting to peer
23:12:05.873 [DEBUG - kudu-nio-5] (Connection.java:757) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] Successfully connected to peer
23:12:05.911 [DEBUG - kudu-nio-5] (Negotiator.java:919) Authenticated connection [id: 0xabd7befb, L:/127.0.0.1:40884 - R:/127.28.19.66:32775] using TOKEN/null
23:12:05.933 [DEBUG - kudu-nio-5] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=ad143f4f7d0c442c8fcccfbb2c289859, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
23:12:05.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.947371 28808 catalog_manager.cc:2532] Servicing SoftDeleteTable request from {username='test-admin'} at 127.0.0.1:58286:
23:12:05.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
23:12:05.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.947520 28808 catalog_manager.cc:2780] Servicing DeleteTable request from {username='test-admin'} at 127.0.0.1:58286:
23:12:05.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
23:12:05.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.951932 28808 catalog_manager.cc:5983] T 00000000000000000000000000000000 P 607e3a2e6e9b4b8b80fb5b91d28b78f6: Sending DeleteTablet for 3 replicas of tablet ad143f4f7d0c442c8fcccfbb2c289859
23:12:05.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.952531 29079 tablet_service.cc:1558] Processing DeleteTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-07 23:12:05 UTC) from {username='kudu', principal='kudu/127.28.19.126@KRBTEST.COM'} at 127.0.0.1:37842
23:12:05.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.952509 29216 tablet_service.cc:1558] Processing DeleteTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-07 23:12:05 UTC) from {username='kudu', principal='kudu/127.28.19.126@KRBTEST.COM'} at 127.0.0.1:56748
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.952808 28941 tablet_service.cc:1558] Processing DeleteTablet for tablet ad143f4f7d0c442c8fcccfbb2c289859 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-07 23:12:05 UTC) from {username='kudu', principal='kudu/127.28.19.126@KRBTEST.COM'} at 127.0.0.1:47264
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.952745 29335 tablet_replica.cc:333] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: stopping tablet replica
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.953068 29335 raft_consensus.cc:2243] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 1 LEADER]: Raft consensus shutting down.
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.953192 29335 raft_consensus.cc:2272] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2 [term 1 FOLLOWER]: Raft consensus is shut down!
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.953455 29336 tablet_replica.cc:333] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: stopping tablet replica
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.953665 29337 tablet_replica.cc:333] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: stopping tablet replica
23:12:05.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.953840 29336 raft_consensus.cc:2243] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 1 FOLLOWER]: Raft consensus shutting down.
23:12:05.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.954066 29337 raft_consensus.cc:2243] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 1 FOLLOWER]: Raft consensus shutting down.
23:12:05.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.954175 29335 ts_tablet_manager.cc:1916] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Deleting tablet data with delete state TABLET_DATA_DELETED
23:12:05.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.954454 29336 raft_consensus.cc:2272] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853 [term 1 FOLLOWER]: Raft consensus is shut down!
23:12:05.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.954700 29337 raft_consensus.cc:2272] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603 [term 1 FOLLOWER]: Raft consensus is shut down!
23:12:05.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.955268 29336 ts_tablet_manager.cc:1916] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Deleting tablet data with delete state TABLET_DATA_DELETED
23:12:05.956 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.956605 29335 ts_tablet_manager.cc:1929] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
23:12:05.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.957340 29337 ts_tablet_manager.cc:1916] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Deleting tablet data with delete state TABLET_DATA_DELETED
23:12:05.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.957952 29336 ts_tablet_manager.cc:1929] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
23:12:05.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.958446 29336 log.cc:1199] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Deleting WAL directory at /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-2/wal/wals/ad143f4f7d0c442c8fcccfbb2c289859
23:12:05.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.959120 29335 log.cc:1199] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Deleting WAL directory at /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-1/wal/wals/ad143f4f7d0c442c8fcccfbb2c289859
23:12:05.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.959071 29336 ts_tablet_manager.cc:1950] T ad143f4f7d0c442c8fcccfbb2c289859 P 86fdf1a4affe4ba59d9efdccf6f4d853: Deleting consensus metadata
23:12:05.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.959834 29335 ts_tablet_manager.cc:1950] T ad143f4f7d0c442c8fcccfbb2c289859 P 98afa9d321b8465aa620a2d845ffcfa2: Deleting consensus metadata
23:12:05.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.959942 28794 catalog_manager.cc:5027] TS 86fdf1a4affe4ba59d9efdccf6f4d853 (127.28.19.67:44413): tablet ad143f4f7d0c442c8fcccfbb2c289859 (table TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]) successfully deleted
23:12:05.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.960669 28792 catalog_manager.cc:5027] TS 98afa9d321b8465aa620a2d845ffcfa2 (127.28.19.66:32775): tablet ad143f4f7d0c442c8fcccfbb2c289859 (table TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]) successfully deleted
23:12:05.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.960933 29337 ts_tablet_manager.cc:1929] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
23:12:05.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.961038 29337 log.cc:1199] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Deleting WAL directory at /tmp/dist-test-taskMbNw8m/test-tmp/mini-kudu-cluster2674404345783378079/ts-0/wal/wals/ad143f4f7d0c442c8fcccfbb2c289859
23:12:05.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.961367 29337 ts_tablet_manager.cc:1950] T ad143f4f7d0c442c8fcccfbb2c289859 P 0b3783e60b4e412d9889ed4214c0f603: Deleting consensus metadata
23:12:05.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.962700 28794 catalog_manager.cc:5027] TS 0b3783e60b4e412d9889ed4214c0f603 (127.28.19.65:43561): tablet ad143f4f7d0c442c8fcccfbb2c289859 (table TestAuthnTokenReacquireOpen-table [id=ac0404246d7e4136b28dfb6197efba0f]) successfully deleted
23:12:05.969 [DEBUG - main] (Connection.java:575) [peer master-127.28.19.126:38657(127.28.19.126:38657)] disconnecting while in state READY
23:12:05.970 [DEBUG - main] (Connection.java:575) [peer master-127.28.19.126:38657(127.28.19.126:38657)] disconnecting while in state READY
23:12:05.970 [DEBUG - main] (Connection.java:575) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] disconnecting while in state READY
23:12:05.971 [DEBUG - kudu-nio-3] (Connection.java:239) [peer master-127.28.19.126:38657(127.28.19.126:38657)] handling channelInactive
23:12:05.971 [DEBUG - kudu-nio-3] (Connection.java:709) [peer master-127.28.19.126:38657(127.28.19.126:38657)] cleaning up while in state READY due to: connection closed
23:12:05.977 [DEBUG - kudu-nio-5] (Connection.java:239) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] handling channelInactive
23:12:05.977 [DEBUG - kudu-nio-5] (Connection.java:709) [peer 98afa9d321b8465aa620a2d845ffcfa2(127.28.19.66:32775)] cleaning up while in state READY due to: connection closed
23:12:05.979 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.28.19.126:38657(127.28.19.126:38657)] handling channelInactive
23:12:05.980 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.28.19.126:38657(127.28.19.126:38657)] cleaning up while in state READY due to: connection closed
23:12:05.984 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
23:12:05.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:05.992502 28749 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskMbNw8m/build/release/bin/kudu with pid 28874
23:12:06.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:06.000725 28749 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskMbNw8m/build/release/bin/kudu with pid 29015
23:12:06.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:06.007831 28749 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskMbNw8m/build/release/bin/kudu with pid 29152
23:12:06.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260707 23:12:06.015376 28749 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskMbNw8m/build/release/bin/kudu with pid 28775
23:12:06.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-07T23:12:06Z chronyd exiting

Time: 6.205

OK (1 test)

