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

14:28:45.112 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:28:45.113 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

14:28:45.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.115141  7523 mini_oidc.cc:152] Starting JWKS server
14:28:45.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.116560  7523 webserver.cc:460] Webserver started at http://127.0.0.1:43133/ using document root <none> and password file <none>
14:28:45.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.116689  7523 mini_oidc.cc:189] Starting OIDC Discovery server
14:28:45.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:45.116906  7523 webserver.cc:460] Webserver started at http://127.0.0.1:41233/ using document root <none> and password file <none>
14:28:45.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
14:28:45.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/principal' for realm 'KRBTEST.COM',
14:28:45.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
14:28:45.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:45 dist-test-slave-w4v5 krb5kdc[7535](info): setting up network...
14:28:45.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
14:28:45.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:45 dist-test-slave-w4v5 krb5kdc[7535](info): set up 2 sockets
14:28:45.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:45 dist-test-slave-w4v5 krb5kdc[7535](info): commencing operation
14:28:45.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
14:28:46.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.442808  7523 mini_kdc.cc:121] Time spent starting KDC: real 1.320s	user 0.002s	sys 0.004s
14:28:46.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
14:28:46.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:28:46.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
14:28:46.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
14:28:46.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:28:46.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
14:28:46.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
14:28:46.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:28:46.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
14:28:46.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
14:28:46.518 [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-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/test-user.keytab.
14:28:46.518 [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-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/test-user.keytab.
14:28:46.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:46 dist-test-slave-w4v5 krb5kdc[7535](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:28:46.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
14:28:46.538 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:46Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
14:28:46.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:46Z Disabled control of system clock
14:28:46.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.88.254@KRBTEST.COM; defaulting to no policy
14:28:46.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.88.254@KRBTEST.COM" created.
14:28:46.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.254 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.254.keytab.
14:28:46.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.254 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.254.keytab.
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.571769  7523 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/logs
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data/info.pb
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.254:43131
14:28:46.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.254
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.254.keytab
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.254
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.88.254:43131
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43133/jwks.json
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:28:46.577 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:28:46.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.656039  7556 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.656245  7556 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.656268  7556 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657334  7556 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657367  7556 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657382  7556 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657395  7556 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657407  7556 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
14:28:46.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657419  7556 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
14:28:46.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.657430  7556 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:43133/jwks.json
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.658839  7556 master_runner.cc:386] Master server non-default flags:
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal
14:28:46.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.7.88.254:43131
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.254.keytab
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.254
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.254:43131
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
14:28:46.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:43133/jwks.json
14:28:46.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:46.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data/info.pb
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.254
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7556
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/logs
14:28:46.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.659044  7556 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.659304  7556 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.665962  7567 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
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.665969  7556 server_base.cc:1034] running on GCE node
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.666010  7571 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
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.665973  7573 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
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.666438  7556 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.666765  7556 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.668 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.667946  7556 hybrid_clock.cc:648] HybridClock initialized: now 1786458526667883 us; error 79 us; skew 500 ppm
14:28:46.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:46 dist-test-slave-w4v5 krb5kdc[7535](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.254@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:28:46.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.670557  7556 init.cc:377] Logged in from keytab as kudu/127.7.88.254@KRBTEST.COM (short username kudu)
14:28:46.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.671059  7556 webserver.cc:460] Webserver started at http://127.7.88.254:35397/ using document root <none> and password file <none>
14:28:46.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.671305  7556 fs_manager.cc:359] Metadata directory not provided
14:28:46.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.671341  7556 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.671 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.671432  7556 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.672502  7556 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data/instance:
14:28:46.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "483da3bde8bf45c883820bacab16ca0c"
14:28:46.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.672825  7556 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal/instance:
14:28:46.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "483da3bde8bf45c883820bacab16ca0c"
14:28:46.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.674108  7556 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
14:28:46.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.674782  7586 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.674978  7556 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.001s
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675050  7556 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data,/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "483da3bde8bf45c883820bacab16ca0c"
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.675151  7556 fs_report.cc:383] FS layout report
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.675 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data/data
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.676 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.712815  7556 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.715354  7556 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.715476  7556 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.719547  7556 rpc_server.cc:307] RPC server started. Bound to: 127.7.88.254:43131
14:28:46.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.719604  7671 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.88.254:43131 every 8 connection(s)
14:28:46.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.719966  7556 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/data/info.pb
14:28:46.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.720966  7673 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:46.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.723312  7673 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: Bootstrap starting.
14:28:46.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.723999  7673 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: Neither blocks nor log segments found. Creating new log.
14:28:46.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.724246  7673 log.cc:824] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: Log is configured to *not* fsync() on all Append() calls
14:28:46.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.724911  7673 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: No bootstrap required, opened a new log
14:28:46.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726454  7673 raft_consensus.cc:348] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } }
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726588  7673 raft_consensus.cc:374] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726610  7673 raft_consensus.cc:729] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 483da3bde8bf45c883820bacab16ca0c, State: Initialized, Role: FOLLOWER
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726765  7673 consensus_queue.cc:260] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [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: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } }
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726850  7673 raft_consensus.cc:388] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726872  7673 raft_consensus.cc:482] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.726900  7673 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 0 FOLLOWER]: Advancing to term 1
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.727453  7673 raft_consensus.cc:504] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } }
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.727538  7673 leader_election.cc:302] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [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: 483da3bde8bf45c883820bacab16ca0c; no voters: 
14:28:46.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.727696  7673 leader_election.cc:288] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [CANDIDATE]: Term 1 election: Requested vote from peers 
14:28:46.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.727905  7677 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 1 FOLLOWER]: Leader election won for term 1
14:28:46.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.727973  7673 sys_catalog.cc:564] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [sys.catalog]: configured and running, proceeding with master startup.
14:28:46.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728010  7677 raft_consensus.cc:686] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [term 1 LEADER]: Becoming Leader. State: Replica: 483da3bde8bf45c883820bacab16ca0c, State: Running, Role: LEADER
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728080  7677 consensus_queue.cc:237] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [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: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } }
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728376  7677 sys_catalog.cc:455] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "483da3bde8bf45c883820bacab16ca0c" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } } }
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728451  7677 sys_catalog.cc:458] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [sys.catalog]: This master's current role is: LEADER
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728592  7677 sys_catalog.cc:455] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 483da3bde8bf45c883820bacab16ca0c. Latest consensus state: current_term: 1 leader_uuid: "483da3bde8bf45c883820bacab16ca0c" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "483da3bde8bf45c883820bacab16ca0c" member_type: VOTER last_known_addr { host: "127.7.88.254" port: 43131 } } }
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728654  7677 sys_catalog.cc:458] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c [sys.catalog]: This master's current role is: LEADER
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728883  7686 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.728965  7523 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskxaP0cp/build/release/bin/kudu as pid 7556
14:28:46.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.729075  7523 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/master-0/wal/instance
14:28:46.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.729372  7686 catalog_manager.cc:1484] Initializing Kudu cluster ID...
14:28:46.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.732867  7686 catalog_manager.cc:1347] Generated new cluster ID: 6663bc7bf2bf433ba64fb1f9f6bab06a
14:28:46.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.732924  7686 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
14:28:46.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:46 dist-test-slave-w4v5 krb5kdc[7535](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.88.254@KRBTEST.COM
14:28:46.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.767390  7686 catalog_manager.cc:1370] Generated new certificate authority record
14:28:46.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.768151  7686 catalog_manager.cc:1504] Loading token signing keys...
14:28:46.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.778797  7686 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: Generated new TSK 0
14:28:46.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.779021  7686 catalog_manager.cc:1514] Initializing in-progress tserver states...
14:28:46.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.88.193@KRBTEST.COM; defaulting to no policy
14:28:46.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.88.193@KRBTEST.COM" created.
14:28:46.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.193 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.193.keytab.
14:28:46.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.193 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.193.keytab.
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.809837  7523 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/logs
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data/info.pb
14:28:46.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:46.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.193:0
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.193
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.193
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.193.keytab
14:28:46.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.193
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:46.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:28:46.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.905134  7710 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:28:46.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.905382  7710 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:46.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.905411  7710 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:46.906 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.905437  7710 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:46.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.906929  7710 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:46.907 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.907017  7710 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.88.193
14:28:46.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.908670  7710 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.193.keytab
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.193
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.193:0
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data/info.pb
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.193
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7710
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.193
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/logs
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:46.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:46.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:46.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:46.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:46.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.908957  7710 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:46.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.909246  7710 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:46.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.915263  7721 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
14:28:46.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.915263  7726 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
14:28:46.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:46.915258  7720 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
14:28:46.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.915522  7710 server_base.cc:1034] running on GCE node
14:28:46.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.915722  7710 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:46.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.915957  7710 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:46.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.917143  7710 hybrid_clock.cc:648] HybridClock initialized: now 1786458526917116 us; error 39 us; skew 500 ppm
14:28:46.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:46 dist-test-slave-w4v5 krb5kdc[7535](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.193@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:28:46.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.920617  7710 init.cc:377] Logged in from keytab as kudu/127.7.88.193@KRBTEST.COM (short username kudu)
14:28:46.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.921154  7710 webserver.cc:460] Webserver started at http://127.7.88.193:33293/ using document root <none> and password file <none>
14:28:46.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.921434  7710 fs_manager.cc:359] Metadata directory not provided
14:28:46.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.921496  7710 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:46.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.921631  7710 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.922875  7710 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data/instance:
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2e7e9d18f4e4de2b9ed272c03066be9"
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.923309  7710 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal/instance:
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2e7e9d18f4e4de2b9ed272c03066be9"
14:28:46.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.925014  7710 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.002s	sys 0.000s
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.925899  7737 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.926105  7710 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.926200  7710 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data,/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "d2e7e9d18f4e4de2b9ed272c03066be9"
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:46 on dist-test-slave-w4v5"
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.926254  7710 fs_report.cc:383] FS layout report
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal
14:28:46.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data/data
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:46.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:46.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.937775  7710 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:46.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940102  7710 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:46.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940222  7710 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:46.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940402  7710 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:46.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940851  7710 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:46.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940896  7710 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:46.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940918  7710 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:46.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.940932  7710 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:46.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.947041  7710 rpc_server.cc:307] RPC server started. Bound to: 127.7.88.193:38823
14:28:46.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.947160  7900 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.88.193:38823 every 8 connection(s)
14:28:46.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.947414  7710 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/data/info.pb
14:28:46.954 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:46 dist-test-slave-w4v5 krb5kdc[7535](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.193@KRBTEST.COM for kudu/127.7.88.254@KRBTEST.COM
14:28:46.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.957252  7523 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskxaP0cp/build/release/bin/kudu as pid 7710
14:28:46.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.957356  7523 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal/instance
14:28:46.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.958424  7902 heartbeater.cc:347] Connected to a master server at 127.7.88.254:43131
14:28:46.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.958554  7902 heartbeater.cc:464] Registering TS with master...
14:28:46.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.958766  7902 heartbeater.cc:511] Master 127.7.88.254:43131 requested a full tablet report, sending...
14:28:46.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.959340  7617 ts_manager.cc:194] Registered new tserver with Master: d2e7e9d18f4e4de2b9ed272c03066be9 (127.7.88.193:38823)
14:28:46.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.960016  7617 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.88.193@KRBTEST.COM'} at 127.7.88.193:50219
14:28:46.966 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.88.194@KRBTEST.COM; defaulting to no policy
14:28:46.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.88.194@KRBTEST.COM" created.
14:28:46.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.194 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.194.keytab.
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.194 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.194.keytab.
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:46.984316  7523 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data
14:28:46.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/logs
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data/info.pb
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:46.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.194:0
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.194
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.194
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.194.keytab
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.194
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:46.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:28:47.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.073330  7910 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:28:47.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.073570  7910 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:47.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.073596  7910 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:47.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.073630  7910 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:47.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.074967  7910 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:47.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.075057  7910 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.88.194
14:28:47.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.076632  7910 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:47.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.194.keytab
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.194
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.194:0
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:28:47.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data/info.pb
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.194
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:47.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.7910
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.194
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/logs
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.076893  7910 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:47.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.077167  7910 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:47.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.083382  7922 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
14:28:47.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.083382  7919 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
14:28:47.083 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.083438  7910 server_base.cc:1034] running on GCE node
14:28:47.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.083403  7920 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
14:28:47.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.083799  7910 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:47.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.084069  7910 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:47.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.085227  7910 hybrid_clock.cc:648] HybridClock initialized: now 1786458527085196 us; error 46 us; skew 500 ppm
14:28:47.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:47 dist-test-slave-w4v5 krb5kdc[7535](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458527, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.194@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:28:47.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.088346  7910 init.cc:377] Logged in from keytab as kudu/127.7.88.194@KRBTEST.COM (short username kudu)
14:28:47.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.088842  7910 webserver.cc:460] Webserver started at http://127.7.88.194:42425/ using document root <none> and password file <none>
14:28:47.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.089100  7910 fs_manager.cc:359] Metadata directory not provided
14:28:47.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.089172  7910 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:47.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.089321  7910 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:47.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.090329  7910 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data/instance:
14:28:47.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f957951eeb874bffa5df82df5b811443"
14:28:47.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.090742  7910 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal/instance:
14:28:47.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f957951eeb874bffa5df82df5b811443"
14:28:47.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.092519  7910 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.001s	sys 0.003s
14:28:47.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.093614  7939 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.093863  7910 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.093971  7910 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data,/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f957951eeb874bffa5df82df5b811443"
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.094043  7910 fs_report.cc:383] FS layout report
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data/data
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:47.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:47.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:47.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.109787  7910 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:47.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.112480  7910 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:47.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.112654  7910 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:47.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.112920  7910 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:47.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.113328  7910 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:47.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.113373  7910 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:47.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.113406  7910 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:47.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.113425  7910 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:47.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.119921  7910 rpc_server.cc:307] RPC server started. Bound to: 127.7.88.194:38757
14:28:47.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.120010  8124 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.88.194:38757 every 8 connection(s)
14:28:47.120 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.120405  7910 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/data/info.pb
14:28:47.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.121865  7523 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskxaP0cp/build/release/bin/kudu as pid 7910
14:28:47.122 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.121994  7523 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal/instance
14:28:47.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:47 dist-test-slave-w4v5 krb5kdc[7535](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458527, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.194@KRBTEST.COM for kudu/127.7.88.254@KRBTEST.COM
14:28:47.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.7.88.195@KRBTEST.COM; defaulting to no policy
14:28:47.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.132700  8126 heartbeater.cc:347] Connected to a master server at 127.7.88.254:43131
14:28:47.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.132793  8126 heartbeater.cc:464] Registering TS with master...
14:28:47.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.132934  8126 heartbeater.cc:511] Master 127.7.88.254:43131 requested a full tablet report, sending...
14:28:47.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.133314  7617 ts_manager.cc:194] Registered new tserver with Master: f957951eeb874bffa5df82df5b811443 (127.7.88.194:38757)
14:28:47.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.133739  7617 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.88.194@KRBTEST.COM'} at 127.7.88.194:35735
14:28:47.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:47.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.7.88.195@KRBTEST.COM" created.
14:28:47.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
14:28:47.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.195 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.195.keytab.
14:28:47.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.7.88.195 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.195.keytab.
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.148136  7523 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskxaP0cp/build/release/bin/kudu
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/logs
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data/info.pb
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:47.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.195:0
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.195
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.195
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.195.keytab
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.195
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:47.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:47.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:47.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:47.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:47.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
14:28:47.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.239691  8134 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
14:28:47.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.239924  8134 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
14:28:47.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.239950  8134 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
14:28:47.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.239976  8134 flags.cc:425] Enabled unsafe flag: --never_fsync=true
14:28:47.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.241313  8134 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
14:28:47.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.241405  8134 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.7.88.195
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.242964  8134 tablet_server_runner.cc:78] Tablet server non-default flags:
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.7.88.212:44517
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
14:28:47.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kudu_127.7.88.195.keytab
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.7.88.195
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.7.88.195:0
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data/info.pb
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.7.88.195
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.7.88.254:43131
14:28:47.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.8134
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.7.88.195
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/logs
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:41:36 UTC on ccycloud.quasar-ebruqk.root.comops.site
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580675
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.243259  8134 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
14:28:47.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.243515  8134 file_cache.cc:493] Constructed file cache file cache with capacity 419430
14:28:47.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.248986  8142 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
14:28:47.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.248986  8141 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
14:28:47.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:47.249061  8145 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
14:28:47.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.249555  8134 server_base.cc:1034] running on GCE node
14:28:47.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.249815  8134 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
14:28:47.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.250118  8134 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
14:28:47.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.251286  8134 hybrid_clock.cc:648] HybridClock initialized: now 1786458527251257 us; error 39 us; skew 500 ppm
14:28:47.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:47 dist-test-slave-w4v5 krb5kdc[7535](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458527, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.195@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
14:28:47.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.253985  8134 init.cc:377] Logged in from keytab as kudu/127.7.88.195@KRBTEST.COM (short username kudu)
14:28:47.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.254534  8134 webserver.cc:460] Webserver started at http://127.7.88.195:42913/ using document root <none> and password file <none>
14:28:47.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.254807  8134 fs_manager.cc:359] Metadata directory not provided
14:28:47.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.254889  8134 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
14:28:47.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.255028  8134 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
14:28:47.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.256047  8134 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data/instance:
14:28:47.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1568bb97f024e208cf6c33ae6f907e1"
14:28:47.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.256455  8134 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal/instance:
14:28:47.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1568bb97f024e208cf6c33ae6f907e1"
14:28:47.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.258055  8134 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.258885  8155 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.259152  8134 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.259244  8134 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data,/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c1568bb97f024e208cf6c33ae6f907e1"
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 14:28:47 on dist-test-slave-w4v5"
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.259311  8134 fs_report.cc:383] FS layout report
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data/data
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
14:28:47.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
14:28:47.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.274875  8134 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
14:28:47.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277294  8134 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
14:28:47.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277410  8134 kserver.cc:163] Server-wide thread pool size limit: 3276
14:28:47.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277595  8134 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
14:28:47.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277904  8134 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
14:28:47.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277935  8134 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
14:28:47.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277957  8134 ts_tablet_manager.cc:610] Registered 0 tablets
14:28:47.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.277969  8134 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
14:28:47.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.284605  8134 rpc_server.cc:307] RPC server started. Bound to: 127.7.88.195:45983
14:28:47.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.284703  8355 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.7.88.195:45983 every 8 connection(s)
14:28:47.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.284933  8134 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/data/info.pb
14:28:47.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.290086  7523 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskxaP0cp/build/release/bin/kudu as pid 8134
14:28:47.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.290189  7523 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal/instance
14:28:47.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:47 dist-test-slave-w4v5 krb5kdc[7535](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458527, etypes {rep=17 tkt=17 ses=17}, kudu/127.7.88.195@KRBTEST.COM for kudu/127.7.88.254@KRBTEST.COM
14:28:47.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.294935  8356 heartbeater.cc:347] Connected to a master server at 127.7.88.254:43131
14:28:47.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.295056  8356 heartbeater.cc:464] Registering TS with master...
14:28:47.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.295295  8356 heartbeater.cc:511] Master 127.7.88.254:43131 requested a full tablet report, sending...
14:28:47.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.295780  7617 ts_manager.cc:194] Registered new tserver with Master: c1568bb97f024e208cf6c33ae6f907e1 (127.7.88.195:45983)
14:28:47.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.296124  7617 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.7.88.195@KRBTEST.COM'} at 127.7.88.195:38195
14:28:47.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.302487  7523 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
14:28:47.303 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
14:28:47.304 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

14:28:47.313 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

14:28:47.315 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

14:28:47.323 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.88.254"
      port: 43131
    }
    bound_http_address {
      host: "127.7.88.254"
      port: 35397
    }
  }
}

14:28:47.326 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

14:28:47.328 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.7.88.193"
      port: 38823
    }
    bound_http_address {
      host: "127.7.88.193"
      port: 33293
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.7.88.194"
      port: 38757
    }
    bound_http_address {
      host: "127.7.88.194"
      port: 42425
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.7.88.195"
      port: 45983
    }
    bound_http_address {
      host: "127.7.88.195"
      port: 42913
    }
  }
}

14:28:47.329 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
14:28:47.491 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/krb5kdc/krb5cc
14:28:47.510 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
14:28:47.659 [DEBUG - main] (Connection.java:748) [peer master-127.7.88.254:43131(127.7.88.254:43131)] connecting to peer
14:28:47.727 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.7.88.254:43131(127.7.88.254:43131)] Successfully connected to peer
14:28:47.801 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.7.88.254
14:28:47.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:47.961206  7902 heartbeater.cc:503] Master 127.7.88.254:43131 was elected leader, sending a full tablet report...
14:28:47.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 14:28:47 dist-test-slave-w4v5 krb5kdc[7535](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786458526, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.7.88.254@KRBTEST.COM
14:28:48.007 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xdcd17479, L:/127.0.0.1:42826 - R:/127.7.88.254:43131] using SASL/GSSAPI
14:28:48.045 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:28:48.047 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=432), Traces: [0ms] refreshing cache from master, [30ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.88.254:43131, [399ms] Sub RPC ConnectToMaster: received response from server master-127.7.88.254:43131: OK, deferred=null) after lookup
14:28:48.068 [DEBUG - main] (Connection.java:575) [peer master-127.7.88.254:43131(127.7.88.254:43131)] disconnecting while in state READY
14:28:48.074 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.7.88.254:43131(127.7.88.254:43131)] handling channelInactive
14:28:48.075 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.7.88.254:43131(127.7.88.254:43131)] cleaning up while in state READY due to: connection closed
14:28:48.076 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.7.88.254:43131(127.7.88.254:43131) for tablet Kudu Master: connection closed
14:28:48.096 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.7.88.254:43131(127.7.88.254:43131)] connecting to peer
14:28:48.100 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.88.254:43131(127.7.88.254:43131)] Successfully connected to peer
14:28:48.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.134618  8126 heartbeater.cc:503] Master 127.7.88.254:43131 was elected leader, sending a full tablet report...
14:28:48.167 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x177a4aa4, L:/127.0.0.1:42836 - R:/127.7.88.254:43131] using TOKEN/null
14:28:48.170 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
14:28:48.171 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=100), Traces: [0ms] sending RPC to server master-127.7.88.254:43131, [5ms] received response from server master-127.7.88.254:43131: Network error: connection closed, [6ms] delaying RPC due to: Network error: connection closed, [26ms] refreshing cache from master, [26ms] Sub RPC ConnectToMaster: sending RPC to server master-127.7.88.254:43131, [98ms] Sub RPC ConnectToMaster: received response from server master-127.7.88.254:43131: OK, deferred=Deferred@1552267434(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.247277  7617 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:42836:
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:48.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.251 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
14:28:48.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:48.249686  7617 catalog_manager.cc:6854] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table TestAuthnTokenReacquireOpen-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
14:28:48.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.258669  8245 tablet_service.cc:1467] Processing CreateTablet for tablet e08861f5f1cb44d28a4d7748de47757e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]), partition=RANGE (key) PARTITION UNBOUNDED
14:28:48.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.259116  8245 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e08861f5f1cb44d28a4d7748de47757e. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:48.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.259204  7809 tablet_service.cc:1467] Processing CreateTablet for tablet e08861f5f1cb44d28a4d7748de47757e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]), partition=RANGE (key) PARTITION UNBOUNDED
14:28:48.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.259548  7809 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e08861f5f1cb44d28a4d7748de47757e. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:48.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.262809  8381 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Bootstrap starting.
14:28:48.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.263832  8381 tablet_bootstrap.cc:654] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Neither blocks nor log segments found. Creating new log.
14:28:48.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.265539  8379 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Bootstrap starting.
14:28:48.265 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.265543  8381 log.cc:824] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Log is configured to *not* fsync() on all Append() calls
14:28:48.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.266357  8016 tablet_service.cc:1467] Processing CreateTablet for tablet e08861f5f1cb44d28a4d7748de47757e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]), partition=RANGE (key) PARTITION UNBOUNDED
14:28:48.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.266736  8016 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet e08861f5f1cb44d28a4d7748de47757e. 1 dirs total, 0 dirs full, 0 dirs failed
14:28:48.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.266868  8379 tablet_bootstrap.cc:654] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Neither blocks nor log segments found. Creating new log.
14:28:48.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.267256  8379 log.cc:824] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Log is configured to *not* fsync() on all Append() calls
14:28:48.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.267959  8379 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: No bootstrap required, opened a new log
14:28:48.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.268023  8379 ts_tablet_manager.cc:1397] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Time spent bootstrapping tablet: real 0.003s	user 0.001s	sys 0.000s
14:28:48.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.270484  8379 raft_consensus.cc:348] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.270671  8379 raft_consensus.cc:374] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:48.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.270705  8379 raft_consensus.cc:729] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c1568bb97f024e208cf6c33ae6f907e1, State: Initialized, Role: FOLLOWER
14:28:48.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.270819  8379 consensus_queue.cc:260] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [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: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.271095  8379 ts_tablet_manager.cc:1428] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Time spent starting tablet: real 0.003s	user 0.003s	sys 0.000s
14:28:48.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.271235  8356 heartbeater.cc:503] Master 127.7.88.254:43131 was elected leader, sending a full tablet report...
14:28:48.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.272807  8387 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Bootstrap starting.
14:28:48.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.273715  8387 tablet_bootstrap.cc:654] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Neither blocks nor log segments found. Creating new log.
14:28:48.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.274186  8387 log.cc:824] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Log is configured to *not* fsync() on all Append() calls
14:28:48.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.275022  8387 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: No bootstrap required, opened a new log
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.275270  8387 ts_tablet_manager.cc:1397] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.277357  8381 tablet_bootstrap.cc:492] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: No bootstrap required, opened a new log
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.277424  8381 ts_tablet_manager.cc:1397] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Time spent bootstrapping tablet: real 0.015s	user 0.002s	sys 0.000s
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.277945  8387 raft_consensus.cc:348] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.278115  8387 raft_consensus.cc:374] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:48.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.278151  8387 raft_consensus.cc:729] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f957951eeb874bffa5df82df5b811443, State: Initialized, Role: FOLLOWER
14:28:48.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.278755  8387 consensus_queue.cc:260] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [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: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.279088  8387 ts_tablet_manager.cc:1428] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Time spent starting tablet: real 0.004s	user 0.003s	sys 0.000s
14:28:48.279 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a64e19169a3e4a12821491d2b963fbbc
14:28:48.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.280642  8381 raft_consensus.cc:348] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.280995  8381 raft_consensus.cc:374] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
14:28:48.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.281189  8381 raft_consensus.cc:729] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: d2e7e9d18f4e4de2b9ed272c03066be9, State: Initialized, Role: FOLLOWER
14:28:48.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.281499  8381 consensus_queue.cc:260] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [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: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.281948  8381 ts_tablet_manager.cc:1428] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Time spent starting tablet: real 0.004s	user 0.004s	sys 0.000s
14:28:48.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:48.285841  8357 tablet.cc:2369] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:28:48.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.330758  8393 raft_consensus.cc:482] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
14:28:48.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.330871  8393 raft_consensus.cc:504] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.331290  8393 leader_election.cc:288] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers c1568bb97f024e208cf6c33ae6f907e1 (127.7.88.195:45983), f957951eeb874bffa5df82df5b811443 (127.7.88.194:38757)
14:28:48.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.335703  8279 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e08861f5f1cb44d28a4d7748de47757e" candidate_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c1568bb97f024e208cf6c33ae6f907e1" is_pre_election: true
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.335781  8053 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e08861f5f1cb44d28a4d7748de47757e" candidate_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f957951eeb874bffa5df82df5b811443" is_pre_election: true
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.335875  8279 raft_consensus.cc:2454] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d2e7e9d18f4e4de2b9ed272c03066be9 in term 0.
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.335937  8053 raft_consensus.cc:2454] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate d2e7e9d18f4e4de2b9ed272c03066be9 in term 0.
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.336126  7744 leader_election.cc:302] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [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: c1568bb97f024e208cf6c33ae6f907e1, d2e7e9d18f4e4de2b9ed272c03066be9; no voters: 
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.336277  8393 raft_consensus.cc:2781] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Leader pre-election won for term 1
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.336354  8393 raft_consensus.cc:482] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
14:28:48.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.336377  8393 raft_consensus.cc:3037] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 0 FOLLOWER]: Advancing to term 1
14:28:48.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.337260  8393 raft_consensus.cc:504] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.337390  8393 leader_election.cc:288] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [CANDIDATE]: Term 1 election: Requested vote from peers c1568bb97f024e208cf6c33ae6f907e1 (127.7.88.195:45983), f957951eeb874bffa5df82df5b811443 (127.7.88.194:38757)
14:28:48.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.337558  8279 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e08861f5f1cb44d28a4d7748de47757e" candidate_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c1568bb97f024e208cf6c33ae6f907e1"
14:28:48.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.337648  8279 raft_consensus.cc:3037] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 0 FOLLOWER]: Advancing to term 1
14:28:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338443  8279 raft_consensus.cc:2454] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d2e7e9d18f4e4de2b9ed272c03066be9 in term 1.
14:28:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338568  8053 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "e08861f5f1cb44d28a4d7748de47757e" candidate_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f957951eeb874bffa5df82df5b811443"
14:28:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338645  7744 leader_election.cc:302] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [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: c1568bb97f024e208cf6c33ae6f907e1, d2e7e9d18f4e4de2b9ed272c03066be9; no voters: 
14:28:48.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338650  8053 raft_consensus.cc:3037] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 0 FOLLOWER]: Advancing to term 1
14:28:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338761  8393 raft_consensus.cc:2781] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 1 FOLLOWER]: Leader election won for term 1
14:28:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338908  8393 raft_consensus.cc:686] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 1 LEADER]: Becoming Leader. State: Replica: d2e7e9d18f4e4de2b9ed272c03066be9, State: Running, Role: LEADER
14:28:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.338992  8393 consensus_queue.cc:237] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [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: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } }
14:28:48.339 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.339545  8053 raft_consensus.cc:2454] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate d2e7e9d18f4e4de2b9ed272c03066be9 in term 1.
14:28:48.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.339861  7617 catalog_manager.cc:5495] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 reported cstate change: term changed from 0 to 1, leader changed from <none> to d2e7e9d18f4e4de2b9ed272c03066be9 (127.7.88.193). New cstate: current_term: 1 leader_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "d2e7e9d18f4e4de2b9ed272c03066be9" member_type: VOTER last_known_addr { host: "127.7.88.193" port: 38823 } health_report { overall_health: HEALTHY } } }
14:28:48.361 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a64e19169a3e4a12821491d2b963fbbc
14:28:48.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:48.371693  8128 tablet.cc:2369] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:28:48.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:48.449656  7903 tablet.cc:2369] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Can't schedule compaction. Clean time has not been advanced past its initial value.
14:28:48.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.817404  8393 consensus_queue.cc:1035] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "c1568bb97f024e208cf6c33ae6f907e1" member_type: VOTER last_known_addr { host: "127.7.88.195" port: 45983 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:28:48.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:48.819957  8398 consensus_queue.cc:1035] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "f957951eeb874bffa5df82df5b811443" member_type: VOTER last_known_addr { host: "127.7.88.194" port: 38757 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
14:28:49.365 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table a64e19169a3e4a12821491d2b963fbbc
14:28:49.400 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet e08861f5f1cb44d28a4d7748de47757e for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
14:28:49.407 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299993, tablet=e08861f5f1cb44d28a4d7748de47757e@[c1568bb97f024e208cf6c33ae6f907e1(127.7.88.195:45983),d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)[L],f957951eeb874bffa5df82df5b811443(127.7.88.194:38757)]}]
14:28:49.408 [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=15), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.7.88.254:43131, [7ms] Sub RPC GetTableLocations: received response from server master-127.7.88.254:43131: OK, deferred=null)) after lookup
14:28:49.419 [DEBUG - kudu-nio-1] (Connection.java:748) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] connecting to peer
14:28:49.421 [DEBUG - kudu-nio-0] (Connection.java:757) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] Successfully connected to peer
14:28:49.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.444237  8419 fault_injection.cc:43] FAULT INJECTION ENABLED!
14:28:49.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.444327  8419 fault_injection.cc:44] THIS SERVER MAY CRASH!
14:28:49.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.444626  8419 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56206: token signing key expired
14:28:49.449 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.7.88.193:38823 sent connection negotiation error: Not authorized: token signing key expired
14:28:49.450 [DEBUG - kudu-nio-0] (Connection.java:239) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] handling channelInactive
14:28:49.451 [DEBUG - kudu-nio-0] (Connection.java:709) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:28:49.454 [DEBUG - kudu-nio-0] (Connection.java:748) [peer master-127.7.88.254:43131(127.7.88.254:43131)] connecting to peer
14:28:49.456 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.7.88.254:43131(127.7.88.254:43131)] Successfully connected to peer
14:28:49.458 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.7.88.254
14:28:49.485 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x53b0b691, L:/127.0.0.1:42840 - R:/127.7.88.254:43131] using SASL/GSSAPI
14:28:49.488 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:28:49.489 [DEBUG - kudu-nio-1] (Connection.java:748) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] connecting to peer
14:28:49.490 [DEBUG - kudu-nio-0] (Connection.java:757) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] Successfully connected to peer
14:28:49.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.504774  8419 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56208: invalid token signature
14:28:49.505 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.7.88.193:38823 sent connection negotiation error: Not authorized: invalid token signature
14:28:49.506 [DEBUG - kudu-nio-0] (Connection.java:239) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] handling channelInactive
14:28:49.506 [DEBUG - kudu-nio-0] (Connection.java:709) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:28:49.509 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:28:49.509 [DEBUG - kudu-nio-1] (Connection.java:748) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] connecting to peer
14:28:49.510 [DEBUG - kudu-nio-1] (Connection.java:757) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] Successfully connected to peer
14:28:49.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.529949  8419 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56216: token signing key expired
14:28:49.530 [DEBUG - kudu-nio-1] (Negotiator.java:352) peer /127.7.88.193:38823 sent connection negotiation error: Not authorized: token signing key expired
14:28:49.531 [DEBUG - kudu-nio-1] (Connection.java:239) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] handling channelInactive
14:28:49.531 [DEBUG - kudu-nio-1] (Connection.java:709) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:28:49.533 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:28:49.534 [DEBUG - kudu-nio-1] (Connection.java:748) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] connecting to peer
14:28:49.537 [DEBUG - kudu-nio-0] (Connection.java:757) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] Successfully connected to peer
14:28:49.553 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 14:28:49.553006  8419 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56220: token expired
14:28:49.553 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.7.88.193:38823 sent connection negotiation error: Not authorized: token expired
14:28:49.554 [DEBUG - kudu-nio-0] (Connection.java:239) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] handling channelInactive
14:28:49.554 [DEBUG - kudu-nio-0] (Connection.java:709) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
14:28:49.557 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
14:28:49.558 [DEBUG - kudu-nio-1] (Connection.java:748) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] connecting to peer
14:28:49.558 [DEBUG - kudu-nio-1] (Connection.java:757) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] Successfully connected to peer
14:28:49.577 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xadc3d77f, L:/127.0.0.1:56226 - R:/127.7.88.193:38823] using TOKEN/null
14:28:49.595 [DEBUG - kudu-nio-1] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=e08861f5f1cb44d28a4d7748de47757e, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
14:28:49.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.607604  7617 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:42840:
14:28:49.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:28:49.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.607776  7617 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:42840:
14:28:49.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
14:28:49.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.609159  7617 catalog_manager.cc:5782] T 00000000000000000000000000000000 P 483da3bde8bf45c883820bacab16ca0c: Sending DeleteTablet for 3 replicas of tablet e08861f5f1cb44d28a4d7748de47757e
14:28:49.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.609627  8016 tablet_service.cc:1514] Processing DeleteTablet for tablet e08861f5f1cb44d28a4d7748de47757e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 14:28:49 UTC) from {username='kudu', principal='kudu/127.7.88.254@KRBTEST.COM'} at 127.0.0.1:42668
14:28:49.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.609679  8245 tablet_service.cc:1514] Processing DeleteTablet for tablet e08861f5f1cb44d28a4d7748de47757e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 14:28:49 UTC) from {username='kudu', principal='kudu/127.7.88.254@KRBTEST.COM'} at 127.0.0.1:39634
14:28:49.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.609869  7809 tablet_service.cc:1514] Processing DeleteTablet for tablet e08861f5f1cb44d28a4d7748de47757e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 14:28:49 UTC) from {username='kudu', principal='kudu/127.7.88.254@KRBTEST.COM'} at 127.0.0.1:56198
14:28:49.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.611550  8429 tablet_replica.cc:330] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: stopping tablet replica
14:28:49.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.612059  8433 tablet_replica.cc:330] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: stopping tablet replica
14:28:49.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.612062  8429 raft_consensus.cc:2229] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 1 FOLLOWER]: Raft consensus shutting down.
14:28:49.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.612159  8429 raft_consensus.cc:2258] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443 [term 1 FOLLOWER]: Raft consensus is shut down!
14:28:49.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.612617  8433 raft_consensus.cc:2229] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 1 LEADER]: Raft consensus shutting down.
14:28:49.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.612895  8433 raft_consensus.cc:2258] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9 [term 1 FOLLOWER]: Raft consensus is shut down!
14:28:49.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.613492  8433 ts_tablet_manager.cc:1905] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Deleting tablet data with delete state TABLET_DATA_DELETED
14:28:49.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.613831  8431 tablet_replica.cc:330] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: stopping tablet replica
14:28:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.614168  8431 raft_consensus.cc:2229] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 1 FOLLOWER]: Raft consensus shutting down.
14:28:49.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.614777  8431 raft_consensus.cc:2258] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1 [term 1 FOLLOWER]: Raft consensus is shut down!
14:28:49.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.615454  8429 ts_tablet_manager.cc:1905] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Deleting tablet data with delete state TABLET_DATA_DELETED
14:28:49.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.617835  8429 ts_tablet_manager.cc:1918] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:28:49.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.619992  8429 log.cc:1196] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Deleting WAL directory at /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-1/wal/wals/e08861f5f1cb44d28a4d7748de47757e
14:28:49.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.620471  8429 ts_tablet_manager.cc:1939] T e08861f5f1cb44d28a4d7748de47757e P f957951eeb874bffa5df82df5b811443: Deleting consensus metadata
14:28:49.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.621109  7592 catalog_manager.cc:4841] TS f957951eeb874bffa5df82df5b811443 (127.7.88.194:38757): tablet e08861f5f1cb44d28a4d7748de47757e (table TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]) successfully deleted
14:28:49.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.621481  8433 ts_tablet_manager.cc:1918] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:28:49.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.621554  8433 log.cc:1196] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Deleting WAL directory at /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-0/wal/wals/e08861f5f1cb44d28a4d7748de47757e
14:28:49.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.621836  8433 ts_tablet_manager.cc:1939] T e08861f5f1cb44d28a4d7748de47757e P d2e7e9d18f4e4de2b9ed272c03066be9: Deleting consensus metadata
14:28:49.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.622414  7592 catalog_manager.cc:4841] TS d2e7e9d18f4e4de2b9ed272c03066be9 (127.7.88.193:38823): tablet e08861f5f1cb44d28a4d7748de47757e (table TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]) successfully deleted
14:28:49.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.623175  8431 ts_tablet_manager.cc:1905] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Deleting tablet data with delete state TABLET_DATA_DELETED
14:28:49.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.624617  8431 ts_tablet_manager.cc:1918] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
14:28:49.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.624696  8431 log.cc:1196] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Deleting WAL directory at /tmp/dist-test-taskxaP0cp/test-tmp/mini-kudu-cluster5848943936114728165/ts-2/wal/wals/e08861f5f1cb44d28a4d7748de47757e
14:28:49.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.624943  8431 ts_tablet_manager.cc:1939] T e08861f5f1cb44d28a4d7748de47757e P c1568bb97f024e208cf6c33ae6f907e1: Deleting consensus metadata
14:28:49.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.625407  7592 catalog_manager.cc:4841] TS c1568bb97f024e208cf6c33ae6f907e1 (127.7.88.195:45983): tablet e08861f5f1cb44d28a4d7748de47757e (table TestAuthnTokenReacquireOpen-table [id=a64e19169a3e4a12821491d2b963fbbc]) successfully deleted
14:28:49.626 [DEBUG - main] (Connection.java:575) [peer master-127.7.88.254:43131(127.7.88.254:43131)] disconnecting while in state READY
14:28:49.628 [DEBUG - main] (Connection.java:575) [peer master-127.7.88.254:43131(127.7.88.254:43131)] disconnecting while in state READY
14:28:49.628 [DEBUG - main] (Connection.java:575) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] disconnecting while in state READY
14:28:49.629 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.88.254:43131(127.7.88.254:43131)] handling channelInactive
14:28:49.629 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.88.254:43131(127.7.88.254:43131)] cleaning up while in state READY due to: connection closed
14:28:49.631 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
14:28:49.633 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.7.88.254:43131(127.7.88.254:43131)] handling channelInactive
14:28:49.633 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.7.88.254:43131(127.7.88.254:43131)] cleaning up while in state READY due to: connection closed
14:28:49.634 [DEBUG - kudu-nio-1] (Connection.java:239) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] handling channelInactive
14:28:49.634 [DEBUG - kudu-nio-1] (Connection.java:709) [peer d2e7e9d18f4e4de2b9ed272c03066be9(127.7.88.193:38823)] cleaning up while in state READY due to: connection closed
14:28:49.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.636864  7523 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskxaP0cp/build/release/bin/kudu with pid 7710
14:28:49.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.650079  7523 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskxaP0cp/build/release/bin/kudu with pid 7910
14:28:49.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.666934  7523 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskxaP0cp/build/release/bin/kudu with pid 8134
14:28:49.678 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 14:28:49.677812  7523 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskxaP0cp/build/release/bin/kudu with pid 7556
14:28:49.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T14:28:49Z chronyd exiting

Time: 5.189

OK (1 test)

