JUnit version 4.13.2
.15:03:20.284 [INFO - main] (RandomUtils.java:49) Using random seed: 1786460600276
15:03:20.304 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
15:03:20.365 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
15:03:20.374 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskloImSs/test-tmp
15:03:20.377 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
15:03:20.381 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskloImSs/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
15:03:20.636 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966"
  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 {
  }
}

15:03:20.651 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:03:20.652 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

15:03:20.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:20.654342  5817 mini_oidc.cc:152] Starting JWKS server
15:03:20.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:20.656992  5817 webserver.cc:460] Webserver started at http://127.0.0.1:34337/ using document root <none> and password file <none>
15:03:20.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:20.657138  5817 mini_oidc.cc:189] Starting OIDC Discovery server
15:03:20.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:20.657454  5817 webserver.cc:460] Webserver started at http://127.0.0.1:41733/ using document root <none> and password file <none>
15:03:20.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
15:03:20.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/principal' for realm 'KRBTEST.COM',
15:03:20.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
15:03:20.717 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:20 dist-test-slave-jztv krb5kdc[5831](info): setting up network...
15:03:20.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
15:03:20.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:20 dist-test-slave-jztv krb5kdc[5831](info): set up 2 sockets
15:03:20.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:20 dist-test-slave-jztv krb5kdc[5831](info): commencing operation
15:03:20.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
15:03:21.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:21.920768  5817 mini_kdc.cc:121] Time spent starting KDC: real 1.256s	user 0.003s	sys 0.005s
15:03:21.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
15:03:21.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:03:21.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
15:03:21.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
15:03:21.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:03:21.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
15:03:21.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
15:03:21.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:03:21.988 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
15:03:22.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:03:22.006 [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-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/test-user.keytab.
15:03:22.006 [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-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/test-user.keytab.
15:03:22.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:03:22.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
15:03:22.032 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T15:03:22Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
15:03:22.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T15:03:22Z Disabled control of system clock
15:03:22.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.5.174.126@KRBTEST.COM; defaulting to no policy
15:03:22.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.5.174.126@KRBTEST.COM" created.
15:03:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.069 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.126.keytab.
15:03:22.070 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.126.keytab.
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.070863  5817 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:03:22.071 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:03:22.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:03:22.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/logs
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data/info.pb
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:03:22.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.126:44387
15:03:22.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.126
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.126.keytab
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.126
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.5.174.126:44387
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34337/jwks.json
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
15:03:22.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:03:22.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.197250  5857 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:03:22.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.197575  5857 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:03:22.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.197625  5857 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.201947  5857 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202028  5857 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202051  5857 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202069  5857 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202085  5857 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202102  5857 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:03:22.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.202116  5857 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:34337/jwks.json
15:03:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.208019  5857 master_runner.cc:386] Master server non-default flags:
15:03:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.5.174.126:44387
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.126.keytab
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.126
15:03:22.209 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.126:44387
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34337/jwks.json
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.211 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data/info.pb
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.126
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:03:22.212 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.5857
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/logs
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:03:22.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:59:13 UTC on ccycloud.quasar-sqcett.root.comops.site
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580140
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.209929  5857 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:03:22.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.211256  5857 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:03:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.221338  5865 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
15:03:22.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.221333  5866 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
15:03:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.221442  5857 server_base.cc:1034] running on GCE node
15:03:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.221333  5868 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
15:03:22.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.222311  5857 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:03:22.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.223547  5857 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:03:22.224 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.224745  5857 hybrid_clock.cc:648] HybridClock initialized: now 1786460602224763 us; error 87 us; skew 500 ppm
15:03:22.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:03:22.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.227963  5857 init.cc:377] Logged in from keytab as kudu/127.5.174.126@KRBTEST.COM (short username kudu)
15:03:22.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.228958  5857 webserver.cc:460] Webserver started at http://127.5.174.126:38041/ using document root <none> and password file <none>
15:03:22.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.229612  5857 fs_manager.cc:359] Metadata directory not provided
15:03:22.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.229681  5857 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:03:22.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.230068  5857 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:03:22.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.232260  5857 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data/instance:
15:03:22.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "99ab9b8845404eb2984fa1576e57da69"
15:03:22.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.232829  5857 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal/instance:
15:03:22.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "99ab9b8845404eb2984fa1576e57da69"
15:03:22.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.236831  5857 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:03:22.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.239666  5878 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:03:22.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.241178  5857 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
15:03:22.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.241364  5857 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data,/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal
15:03:22.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "99ab9b8845404eb2984fa1576e57da69"
15:03:22.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.241500  5857 fs_report.cc:383] FS layout report
15:03:22.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:03:22.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data/data
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:03:22.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:03:22.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:03:22.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:03:22.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:03:22.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.259229  5857 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:03:22.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.262997  5857 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
15:03:22.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.263230  5857 kserver.cc:163] Server-wide thread pool size limit: 3276
15:03:22.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.271142  5857 rpc_server.cc:307] RPC server started. Bound to: 127.5.174.126:44387
15:03:22.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.271456  5966 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.5.174.126:44387 every 8 connection(s)
15:03:22.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.272310  5857 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/data/info.pb
15:03:22.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.275507  5968 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
15:03:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.280848  5817 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskloImSs/build/debug/bin/kudu as pid 5857
15:03:22.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.281075  5817 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/master-0/wal/instance
15:03:22.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.282372  5968 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: Bootstrap starting.
15:03:22.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.285918  5968 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: Neither blocks nor log segments found. Creating new log.
15:03:22.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.287431  5968 log.cc:824] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: Log is configured to *not* fsync() on all Append() calls
15:03:22.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.289826  5968 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: No bootstrap required, opened a new log
15:03:22.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.293836  5968 raft_consensus.cc:348] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } }
15:03:22.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.294147  5968 raft_consensus.cc:374] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:03:22.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.294206  5968 raft_consensus.cc:729] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 99ab9b8845404eb2984fa1576e57da69, State: Initialized, Role: FOLLOWER
15:03:22.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.294930  5968 consensus_queue.cc:260] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [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: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } }
15:03:22.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.295702  5968 raft_consensus.cc:388] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
15:03:22.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.295782  5968 raft_consensus.cc:482] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
15:03:22.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.295883  5968 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 0 FOLLOWER]: Advancing to term 1
15:03:22.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.296954  5968 raft_consensus.cc:504] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } }
15:03:22.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.297392  5968 leader_election.cc:302] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [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: 99ab9b8845404eb2984fa1576e57da69; no voters: 
15:03:22.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.297827  5968 leader_election.cc:288] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [CANDIDATE]: Term 1 election: Requested vote from peers 
15:03:22.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.297941  5979 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 1 FOLLOWER]: Leader election won for term 1
15:03:22.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.299206  5979 raft_consensus.cc:686] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [term 1 LEADER]: Becoming Leader. State: Replica: 99ab9b8845404eb2984fa1576e57da69, State: Running, Role: LEADER
15:03:22.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.299629  5968 sys_catalog.cc:564] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [sys.catalog]: configured and running, proceeding with master startup.
15:03:22.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.299795  5979 consensus_queue.cc:237] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [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: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } }
15:03:22.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.301090  5979 sys_catalog.cc:455] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 99ab9b8845404eb2984fa1576e57da69. Latest consensus state: current_term: 1 leader_uuid: "99ab9b8845404eb2984fa1576e57da69" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } } }
15:03:22.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.301445  5979 sys_catalog.cc:458] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [sys.catalog]: This master's current role is: LEADER
15:03:22.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.5.174.126@KRBTEST.COM
15:03:22.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.303707  5995 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
15:03:22.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.303714  5981 sys_catalog.cc:455] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "99ab9b8845404eb2984fa1576e57da69" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "99ab9b8845404eb2984fa1576e57da69" member_type: VOTER last_known_addr { host: "127.5.174.126" port: 44387 } } }
15:03:22.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.303879  5981 sys_catalog.cc:458] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69 [sys.catalog]: This master's current role is: LEADER
15:03:22.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.307336  5995 catalog_manager.cc:1484] Initializing Kudu cluster ID...
15:03:22.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.313401  5995 catalog_manager.cc:1347] Generated new cluster ID: bfd3298cfae04ab08705fd755d10117d
15:03:22.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.313472  5995 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
15:03:22.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.344033  5995 catalog_manager.cc:1370] Generated new certificate authority record
15:03:22.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.345153  5995 catalog_manager.cc:1504] Loading token signing keys...
15:03:22.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.353495  5995 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: Generated new TSK 0
15:03:22.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.354418  5995 catalog_manager.cc:1514] Initializing in-progress tserver states...
15:03:22.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.5.174.65@KRBTEST.COM; defaulting to no policy
15:03:22.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.5.174.65@KRBTEST.COM" created.
15:03:22.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.65.keytab.
15:03:22.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.65.keytab.
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.389902  5817 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/logs
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data/info.pb
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:03:22.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:03:22.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.65:0
15:03:22.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.65
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.65
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.65.keytab
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.65
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:03:22.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:03:22.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.516382  6012 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
15:03:22.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.516672  6012 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:03:22.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.516692  6012 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:03:22.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.516781  6012 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:03:22.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.521215  6012 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:03:22.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.521414  6012 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.5.174.65
15:03:22.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.527604  6012 tablet_server_runner.cc:78] Tablet server non-default flags:
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.65.keytab
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.65
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.65:0
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:03:22.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data/info.pb
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.65
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.6012
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.65
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/logs
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:03:22.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:03:22.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:03:22.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:59:13 UTC on ccycloud.quasar-sqcett.root.comops.site
15:03:22.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580140
15:03:22.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.528772  6012 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:03:22.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.529908  6012 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:03:22.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.540437  6022 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
15:03:22.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.540436  6020 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
15:03:22.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.540436  6024 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
15:03:22.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.540723  6012 server_base.cc:1034] running on GCE node
15:03:22.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.541227  6012 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:03:22.542 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.542114  6012 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:03:22.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.543675  6012 hybrid_clock.cc:648] HybridClock initialized: now 1786460602543602 us; error 90 us; skew 500 ppm
15:03:22.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:03:22.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.547020  6012 init.cc:377] Logged in from keytab as kudu/127.5.174.65@KRBTEST.COM (short username kudu)
15:03:22.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.548285  6012 webserver.cc:460] Webserver started at http://127.5.174.65:46573/ using document root <none> and password file <none>
15:03:22.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.549017  6012 fs_manager.cc:359] Metadata directory not provided
15:03:22.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.549109  6012 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:03:22.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.549350  6012 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.552002  6012 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data/instance:
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "11b877e9bf40448f98a6fe998dba81dc"
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.552703  6012 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal/instance:
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "11b877e9bf40448f98a6fe998dba81dc"
15:03:22.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.556778  6012 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
15:03:22.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.559496  6035 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.560899  6012 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.561033  6012 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data,/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "11b877e9bf40448f98a6fe998dba81dc"
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.561131  6012 fs_report.cc:383] FS layout report
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data/data
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:03:22.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:03:22.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:03:22.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.590341  6012 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:03:22.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.593684  6012 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
15:03:22.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.593868  6012 kserver.cc:163] Server-wide thread pool size limit: 3276
15:03:22.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.594487  6012 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:03:22.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.595638  6012 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:03:22.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.595692  6012 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:03:22.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.595736  6012 ts_tablet_manager.cc:610] Registered 0 tablets
15:03:22.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.595752  6012 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:03:22.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.606191  6012 rpc_server.cc:307] RPC server started. Bound to: 127.5.174.65:34607
15:03:22.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.606290  6198 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.5.174.65:34607 every 8 connection(s)
15:03:22.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.607437  6012 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/data/info.pb
15:03:22.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.608672  5817 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskloImSs/build/debug/bin/kudu as pid 6012
15:03:22.609 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.608801  5817 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal/instance
15:03:22.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.65@KRBTEST.COM for kudu/127.5.174.126@KRBTEST.COM
15:03:22.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.5.174.66@KRBTEST.COM; defaulting to no policy
15:03:22.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.5.174.66@KRBTEST.COM" created.
15:03:22.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.628101  6199 heartbeater.cc:347] Connected to a master server at 127.5.174.126:44387
15:03:22.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.628412  6199 heartbeater.cc:464] Registering TS with master...
15:03:22.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.629266  6199 heartbeater.cc:511] Master 127.5.174.126:44387 requested a full tablet report, sending...
15:03:22.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.631134  5907 ts_manager.cc:194] Registered new tserver with Master: 11b877e9bf40448f98a6fe998dba81dc (127.5.174.65:34607)
15:03:22.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.632392  5907 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.5.174.65@KRBTEST.COM'} at 127.5.174.65:45253
15:03:22.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.66.keytab.
15:03:22.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.66.keytab.
15:03:22.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.646102  5817 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal
15:03:22.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/logs
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data/info.pb
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.66:0
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.66
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.66
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.66.keytab
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.66
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.649 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:03:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.769109  6207 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
15:03:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.769381  6207 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:03:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.769402  6207 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:03:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.769443  6207 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:03:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.773552  6207 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:03:22.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.773656  6207 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.5.174.66
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.778949  6207 tablet_server_runner.cc:78] Tablet server non-default flags:
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.66.keytab
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.66
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.66:0
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:03:22.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data/info.pb
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.66
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.6207
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.66
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/logs
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:03:22.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:59:13 UTC on ccycloud.quasar-sqcett.root.comops.site
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580140
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.780035  6207 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:03:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.781015  6207 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:03:22.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.791136  6216 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
15:03:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.791235  6207 server_base.cc:1034] running on GCE node
15:03:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.791142  6213 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
15:03:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:22.791152  6214 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
15:03:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.792438  6207 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:03:22.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.793268  6207 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:03:22.794 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.794471  6207 hybrid_clock.cc:648] HybridClock initialized: now 1786460602794418 us; error 48 us; skew 500 ppm
15:03:22.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:03:22.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.804462  6207 init.cc:377] Logged in from keytab as kudu/127.5.174.66@KRBTEST.COM (short username kudu)
15:03:22.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.805560  6207 webserver.cc:460] Webserver started at http://127.5.174.66:41455/ using document root <none> and password file <none>
15:03:22.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.806124  6207 fs_manager.cc:359] Metadata directory not provided
15:03:22.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.806290  6207 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:03:22.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.806595  6207 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.808995  6207 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data/instance:
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b9cff140b51d46fb9874ad6bbc3818ea"
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.809536  6207 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal/instance:
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b9cff140b51d46fb9874ad6bbc3818ea"
15:03:22.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.813715  6207 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.002s	sys 0.004s
15:03:22.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.816427  6227 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.817970  6207 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.000s	sys 0.002s
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.818089  6207 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data,/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b9cff140b51d46fb9874ad6bbc3818ea"
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:22 on dist-test-slave-jztv"
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.818217  6207 fs_report.cc:383] FS layout report
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data/data
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:03:22.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:03:22.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:03:22.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.832816  6207 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:03:22.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.836485  6207 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
15:03:22.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.836658  6207 kserver.cc:163] Server-wide thread pool size limit: 3276
15:03:22.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.837394  6207 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:03:22.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.838328  6207 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:03:22.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.838384  6207 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:03:22.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.838428  6207 ts_tablet_manager.cc:610] Registered 0 tablets
15:03:22.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.838444  6207 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:03:22.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.848661  6207 rpc_server.cc:307] RPC server started. Bound to: 127.5.174.66:40211
15:03:22.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.848694  6422 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.5.174.66:40211 every 8 connection(s)
15:03:22.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.849787  6207 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/data/info.pb
15:03:22.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.853961  5817 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskloImSs/build/debug/bin/kudu as pid 6207
15:03:22.854 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.854094  5817 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal/instance
15:03:22.862 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:22 dist-test-slave-jztv krb5kdc[5831](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.66@KRBTEST.COM for kudu/127.5.174.126@KRBTEST.COM
15:03:22.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.5.174.67@KRBTEST.COM; defaulting to no policy
15:03:22.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.869588  6423 heartbeater.cc:347] Connected to a master server at 127.5.174.126:44387
15:03:22.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.869 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.5.174.67@KRBTEST.COM" created.
15:03:22.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.869884  6423 heartbeater.cc:464] Registering TS with master...
15:03:22.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.870536  6423 heartbeater.cc:511] Master 127.5.174.126:44387 requested a full tablet report, sending...
15:03:22.873 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.873271  5907 ts_manager.cc:194] Registered new tserver with Master: b9cff140b51d46fb9874ad6bbc3818ea (127.5.174.66:40211)
15:03:22.874 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.874328  5907 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.5.174.66@KRBTEST.COM'} at 127.5.174.66:43727
15:03:22.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:03:22.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.67.keytab.
15:03:22.889 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.5.174.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.67.keytab.
15:03:22.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:22.890475  5817 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskloImSs/build/debug/bin/kudu
15:03:22.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal
15:03:22.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/logs
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data/info.pb
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:22.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.67:0
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.67
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.67
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.67.keytab
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.67
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:22.892 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:22.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:22.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:03:23.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.009032  6431 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
15:03:23.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.009346  6431 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:03:23.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.009379  6431 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:03:23.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.009431  6431 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:03:23.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.013751  6431 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:03:23.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.013926  6431 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.5.174.67
15:03:23.019 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.019582  6431 tablet_server_runner.cc:78] Tablet server non-default flags:
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.5.174.84:43717
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kudu_127.5.174.67.keytab
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.5.174.67
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:03:23.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.5.174.67:0
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data/info.pb
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.5.174.67
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.5.174.126:44387
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.6431
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.5.174.67
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/logs
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:03:23.021 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 11 Aug 2026 13:59:13 UTC on ccycloud.quasar-sqcett.root.comops.site
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4580140
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.021000  6431 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:03:23.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.022461  6431 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:03:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.033262  6439 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
15:03:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.033253  6440 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
15:03:23.033 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.033434  6431 server_base.cc:1034] running on GCE node
15:03:23.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:23.033257  6448 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
15:03:23.034 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.034406  6431 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:03:23.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.035125  6431 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:03:23.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.036321  6431 hybrid_clock.cc:648] HybridClock initialized: now 1786460603036300 us; error 34 us; skew 500 ppm
15:03:23.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:23 dist-test-slave-jztv krb5kdc[5831](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460603, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:03:23.039 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.039307  6431 init.cc:377] Logged in from keytab as kudu/127.5.174.67@KRBTEST.COM (short username kudu)
15:03:23.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.040257  6431 webserver.cc:460] Webserver started at http://127.5.174.67:34463/ using document root <none> and password file <none>
15:03:23.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.040786  6431 fs_manager.cc:359] Metadata directory not provided
15:03:23.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.040844  6431 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:03:23.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.041025  6431 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.043005  6431 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data/instance:
15:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "be2f85d3747e454cb0233b82a42c6fb8"
15:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:23 on dist-test-slave-jztv"
15:03:23.043 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.043587  6431 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal/instance:
15:03:23.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "be2f85d3747e454cb0233b82a42c6fb8"
15:03:23.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:23 on dist-test-slave-jztv"
15:03:23.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.048640  6431 fs_manager.cc:691] Time spent creating directory manager: real 0.005s	user 0.005s	sys 0.000s
15:03:23.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.051785  6458 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:03:23.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.053620  6431 fs_manager.cc:725] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.000s
15:03:23.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.053766  6431 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data,/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "be2f85d3747e454cb0233b82a42c6fb8"
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 15:03:23 on dist-test-slave-jztv"
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.053879  6431 fs_report.cc:383] FS layout report
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data/data
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:03:23.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:03:23.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.080945  6431 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:03:23.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.084165  6431 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
15:03:23.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.084331  6431 kserver.cc:163] Server-wide thread pool size limit: 3276
15:03:23.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.084906  6431 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:03:23.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.085777  6431 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:03:23.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.085827  6431 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:03:23.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.085868  6431 ts_tablet_manager.cc:610] Registered 0 tablets
15:03:23.086 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.085883  6431 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:03:23.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.096093  6431 rpc_server.cc:307] RPC server started. Bound to: 127.5.174.67:35017
15:03:23.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.096184  6635 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.5.174.67:35017 every 8 connection(s)
15:03:23.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.096990  6431 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/data/info.pb
15:03:23.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.098775  5817 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskloImSs/build/debug/bin/kudu as pid 6431
15:03:23.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.098896  5817 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal/instance
15:03:23.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:23 dist-test-slave-jztv krb5kdc[5831](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460603, etypes {rep=17 tkt=17 ses=17}, kudu/127.5.174.67@KRBTEST.COM for kudu/127.5.174.126@KRBTEST.COM
15:03:23.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.112475  6636 heartbeater.cc:347] Connected to a master server at 127.5.174.126:44387
15:03:23.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.112756  6636 heartbeater.cc:464] Registering TS with master...
15:03:23.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.113391  6636 heartbeater.cc:511] Master 127.5.174.126:44387 requested a full tablet report, sending...
15:03:23.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.114609  5907 ts_manager.cc:194] Registered new tserver with Master: be2f85d3747e454cb0233b82a42c6fb8 (127.5.174.67:35017)
15:03:23.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.115167  5907 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.5.174.67@KRBTEST.COM'} at 127.5.174.67:39617
15:03:23.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.126015  5817 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
15:03:23.127 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:03:23.128 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

15:03:23.144 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

15:03:23.146 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

15:03:23.155 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.5.174.126"
      port: 44387
    }
    bound_http_address {
      host: "127.5.174.126"
      port: 38041
    }
  }
}

15:03:23.162 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

15:03:23.165 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.5.174.65"
      port: 34607
    }
    bound_http_address {
      host: "127.5.174.65"
      port: 46573
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.5.174.66"
      port: 40211
    }
    bound_http_address {
      host: "127.5.174.66"
      port: 41455
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.5.174.67"
      port: 35017
    }
    bound_http_address {
      host: "127.5.174.67"
      port: 34463
    }
  }
}

15:03:23.165 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
15:03:23.400 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/krb5kdc/krb5cc
15:03:23.416 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
15:03:23.565 [DEBUG - main] (Connection.java:748) [peer master-127.5.174.126:44387(127.5.174.126:44387)] connecting to peer
15:03:23.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.635085  6199 heartbeater.cc:503] Master 127.5.174.126:44387 was elected leader, sending a full tablet report...
15:03:23.700 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.5.174.126:44387(127.5.174.126:44387)] Successfully connected to peer
15:03:23.795 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.5.174.126
15:03:23.877 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:23.877060  6423 heartbeater.cc:503] Master 127.5.174.126:44387 was elected leader, sending a full tablet report...
15:03:24.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 11 15:03:24 dist-test-slave-jztv krb5kdc[5831](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786460602, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.5.174.126@KRBTEST.COM
15:03:24.069 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x3ab8b5a9, L:/127.0.0.1:56150 - R:/127.5.174.126:44387] using SASL/GSSAPI
15:03:24.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.117268  6636 heartbeater.cc:503] Master 127.5.174.126:44387 was elected leader, sending a full tablet report...
15:03:24.121 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
15:03:24.122 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=605), Traces: [0ms] refreshing cache from master, [34ms] Sub RPC ConnectToMaster: sending RPC to server master-127.5.174.126:44387, [566ms] Sub RPC ConnectToMaster: received response from server master-127.5.174.126:44387: OK, deferred=null) after lookup
15:03:24.145 [DEBUG - main] (Connection.java:575) [peer master-127.5.174.126:44387(127.5.174.126:44387)] disconnecting while in state READY
15:03:24.153 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.5.174.126:44387(127.5.174.126:44387)] handling channelInactive
15:03:24.154 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.5.174.126:44387(127.5.174.126:44387)] cleaning up while in state READY due to: connection closed
15:03:24.155 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.5.174.126:44387(127.5.174.126:44387) for tablet Kudu Master: connection closed
15:03:24.159 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.5.174.126:44387(127.5.174.126:44387)] connecting to peer
15:03:24.163 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.5.174.126:44387(127.5.174.126:44387)] Successfully connected to peer
15:03:24.223 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xd61fb814, L:/127.0.0.1:56164 - R:/127.5.174.126:44387] using TOKEN/null
15:03:24.227 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
15:03:24.228 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=81), Traces: [0ms] sending RPC to server master-127.5.174.126:44387, [8ms] received response from server master-127.5.174.126:44387: Network error: connection closed, [9ms] delaying RPC due to: Network error: connection closed, [12ms] refreshing cache from master, [13ms] Sub RPC ConnectToMaster: sending RPC to server master-127.5.174.126:44387, [80ms] Sub RPC ConnectToMaster: received response from server master-127.5.174.126:44387: OK, deferred=Deferred@640334011(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
15:03:24.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.311594  5907 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:56164:
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
15:03:24.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:03:24.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
15:03:24.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
15:03:24.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:24.315120  5907 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.
15:03:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.339596  6108 tablet_service.cc:1467] Processing CreateTablet for tablet 03c0948d55aa4becbde3359733714541 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]), partition=RANGE (key) PARTITION UNBOUNDED
15:03:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.339596  6307 tablet_service.cc:1467] Processing CreateTablet for tablet 03c0948d55aa4becbde3359733714541 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]), partition=RANGE (key) PARTITION UNBOUNDED
15:03:24.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.340824  6307 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 03c0948d55aa4becbde3359733714541. 1 dirs total, 0 dirs full, 0 dirs failed
15:03:24.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.341177  6108 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 03c0948d55aa4becbde3359733714541. 1 dirs total, 0 dirs full, 0 dirs failed
15:03:24.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.349475  6667 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Bootstrap starting.
15:03:24.349 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.349354  6528 tablet_service.cc:1467] Processing CreateTablet for tablet 03c0948d55aa4becbde3359733714541 (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]), partition=RANGE (key) PARTITION UNBOUNDED
15:03:24.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.350564  6528 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 03c0948d55aa4becbde3359733714541. 1 dirs total, 0 dirs full, 0 dirs failed
15:03:24.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.350643  6668 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Bootstrap starting.
15:03:24.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.351962  6667 tablet_bootstrap.cc:654] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Neither blocks nor log segments found. Creating new log.
15:03:24.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.353008  6667 log.cc:824] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Log is configured to *not* fsync() on all Append() calls
15:03:24.353 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table faa3032855314943a251596d55265cf3
15:03:24.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.353140  6668 tablet_bootstrap.cc:654] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Neither blocks nor log segments found. Creating new log.
15:03:24.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.353922  6668 log.cc:824] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Log is configured to *not* fsync() on all Append() calls
15:03:24.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.355468  6667 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: No bootstrap required, opened a new log
15:03:24.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.355679  6667 ts_tablet_manager.cc:1397] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Time spent bootstrapping tablet: real 0.006s	user 0.005s	sys 0.000s
15:03:24.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.358567  6671 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Bootstrap starting.
15:03:24.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.360502  6667 raft_consensus.cc:348] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.360790  6667 raft_consensus.cc:374] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:03:24.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.360819  6671 tablet_bootstrap.cc:654] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Neither blocks nor log segments found. Creating new log.
15:03:24.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.360862  6667 raft_consensus.cc:729] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 11b877e9bf40448f98a6fe998dba81dc, State: Initialized, Role: FOLLOWER
15:03:24.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.361377  6667 consensus_queue.cc:260] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [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: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.361616  6671 log.cc:824] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Log is configured to *not* fsync() on all Append() calls
15:03:24.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.362564  6667 ts_tablet_manager.cc:1428] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Time spent starting tablet: real 0.007s	user 0.008s	sys 0.000s
15:03:24.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.363724  6668 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: No bootstrap required, opened a new log
15:03:24.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.364109  6668 ts_tablet_manager.cc:1397] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Time spent bootstrapping tablet: real 0.014s	user 0.005s	sys 0.000s
15:03:24.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.364553  6671 tablet_bootstrap.cc:492] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: No bootstrap required, opened a new log
15:03:24.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.364887  6671 ts_tablet_manager.cc:1397] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Time spent bootstrapping tablet: real 0.006s	user 0.005s	sys 0.000s
15:03:24.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.369922  6671 raft_consensus.cc:348] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.370460  6671 raft_consensus.cc:374] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:03:24.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.370718  6671 raft_consensus.cc:729] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: be2f85d3747e454cb0233b82a42c6fb8, State: Initialized, Role: FOLLOWER
15:03:24.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.371073  6668 raft_consensus.cc:348] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.371483  6668 raft_consensus.cc:374] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:03:24.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.371413  6671 consensus_queue.cc:260] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [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: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.371770  6668 raft_consensus.cc:729] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b9cff140b51d46fb9874ad6bbc3818ea, State: Initialized, Role: FOLLOWER
15:03:24.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.372370  6668 consensus_queue.cc:260] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [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: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.372594  6671 ts_tablet_manager.cc:1428] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Time spent starting tablet: real 0.008s	user 0.006s	sys 0.000s
15:03:24.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.373435  6668 ts_tablet_manager.cc:1428] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Time spent starting tablet: real 0.009s	user 0.000s	sys 0.006s
15:03:24.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.539113  6680 raft_consensus.cc:482] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
15:03:24.540 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.539408  6680 raft_consensus.cc:504] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.540863  6680 leader_election.cc:288] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 11b877e9bf40448f98a6fe998dba81dc (127.5.174.65:34607), be2f85d3747e454cb0233b82a42c6fb8 (127.5.174.67:35017)
15:03:24.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.546604  6135 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "03c0948d55aa4becbde3359733714541" candidate_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "11b877e9bf40448f98a6fe998dba81dc" is_pre_election: true
15:03:24.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.546625  6562 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "03c0948d55aa4becbde3359733714541" candidate_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "be2f85d3747e454cb0233b82a42c6fb8" is_pre_election: true
15:03:24.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.546914  6562 raft_consensus.cc:2454] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b9cff140b51d46fb9874ad6bbc3818ea in term 0.
15:03:24.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.546938  6135 raft_consensus.cc:2454] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate b9cff140b51d46fb9874ad6bbc3818ea in term 0.
15:03:24.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.547389  6236 leader_election.cc:302] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [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: b9cff140b51d46fb9874ad6bbc3818ea, be2f85d3747e454cb0233b82a42c6fb8; no voters: 
15:03:24.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.547693  6680 raft_consensus.cc:2781] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Leader pre-election won for term 1
15:03:24.547 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.547813  6680 raft_consensus.cc:482] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
15:03:24.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.547864  6680 raft_consensus.cc:3037] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 0 FOLLOWER]: Advancing to term 1
15:03:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.548892  6680 raft_consensus.cc:504] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.549294  6680 leader_election.cc:288] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [CANDIDATE]: Term 1 election: Requested vote from peers 11b877e9bf40448f98a6fe998dba81dc (127.5.174.65:34607), be2f85d3747e454cb0233b82a42c6fb8 (127.5.174.67:35017)
15:03:24.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.549747  6135 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "03c0948d55aa4becbde3359733714541" candidate_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "11b877e9bf40448f98a6fe998dba81dc"
15:03:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.549844  6562 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "03c0948d55aa4becbde3359733714541" candidate_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "be2f85d3747e454cb0233b82a42c6fb8"
15:03:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.549925  6135 raft_consensus.cc:3037] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 0 FOLLOWER]: Advancing to term 1
15:03:24.550 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.549962  6562 raft_consensus.cc:3037] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 0 FOLLOWER]: Advancing to term 1
15:03:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.551005  6562 raft_consensus.cc:2454] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b9cff140b51d46fb9874ad6bbc3818ea in term 1.
15:03:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.551095  6135 raft_consensus.cc:2454] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate b9cff140b51d46fb9874ad6bbc3818ea in term 1.
15:03:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.551337  6236 leader_election.cc:302] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [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: b9cff140b51d46fb9874ad6bbc3818ea, be2f85d3747e454cb0233b82a42c6fb8; no voters: 
15:03:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.551542  6680 raft_consensus.cc:2781] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 1 FOLLOWER]: Leader election won for term 1
15:03:24.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.551777  6680 raft_consensus.cc:686] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 1 LEADER]: Becoming Leader. State: Replica: b9cff140b51d46fb9874ad6bbc3818ea, State: Running, Role: LEADER
15:03:24.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.552392  6680 consensus_queue.cc:237] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [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: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } }
15:03:24.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.555538  5898 catalog_manager.cc:5495] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea reported cstate change: term changed from 0 to 1, leader changed from <none> to b9cff140b51d46fb9874ad6bbc3818ea (127.5.174.66). New cstate: current_term: 1 leader_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "b9cff140b51d46fb9874ad6bbc3818ea" member_type: VOTER last_known_addr { host: "127.5.174.66" port: 40211 } health_report { overall_health: HEALTHY } } }
15:03:24.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:24.604840  6424 tablet.cc:2369] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:03:24.605 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table faa3032855314943a251596d55265cf3
15:03:24.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:24.608595  6637 tablet.cc:2369] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:03:24.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:24.609964  6200 tablet.cc:2369] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Can't schedule compaction. Clean time has not been advanced past its initial value.
15:03:24.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.962741  6680 consensus_queue.cc:1035] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [LEADER]: Connected to new peer: Peer: permanent_uuid: "be2f85d3747e454cb0233b82a42c6fb8" member_type: VOTER last_known_addr { host: "127.5.174.67" port: 35017 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:03:24.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:24.969406  6687 consensus_queue.cc:1035] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [LEADER]: Connected to new peer: Peer: permanent_uuid: "11b877e9bf40448f98a6fe998dba81dc" member_type: VOTER last_known_addr { host: "127.5.174.65" port: 34607 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
15:03:25.610 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table faa3032855314943a251596d55265cf3
15:03:25.637 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 03c0948d55aa4becbde3359733714541 for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
15:03:25.648 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299989, tablet=03c0948d55aa4becbde3359733714541@[11b877e9bf40448f98a6fe998dba81dc(127.5.174.65:34607),b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)[L],be2f85d3747e454cb0233b82a42c6fb8(127.5.174.67:35017)]}]
15:03:25.650 [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=21), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.5.174.126:44387, [8ms] Sub RPC GetTableLocations: received response from server master-127.5.174.126:44387: OK, deferred=null)) after lookup
15:03:25.662 [DEBUG - kudu-nio-1] (Connection.java:748) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] connecting to peer
15:03:25.664 [DEBUG - kudu-nio-0] (Connection.java:757) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] Successfully connected to peer
15:03:25.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:25.692225  6701 fault_injection.cc:43] FAULT INJECTION ENABLED!
15:03:25.692 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:25.692343  6701 fault_injection.cc:44] THIS SERVER MAY CRASH!
15:03:25.693 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 15:03:25.692919  6701 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:43546: token signing key expired
15:03:25.699 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.5.174.66:40211 sent connection negotiation error: Not authorized: token signing key expired
15:03:25.700 [DEBUG - kudu-nio-0] (Connection.java:239) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] handling channelInactive
15:03:25.700 [DEBUG - kudu-nio-0] (Connection.java:709) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
15:03:25.704 [DEBUG - kudu-nio-0] (Connection.java:748) [peer master-127.5.174.126:44387(127.5.174.126:44387)] connecting to peer
15:03:25.707 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.5.174.126:44387(127.5.174.126:44387)] Successfully connected to peer
15:03:25.710 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.5.174.126
15:03:25.739 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xc63f3c00, L:/127.0.0.1:52698 - R:/127.5.174.126:44387] using SASL/GSSAPI
15:03:25.743 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
15:03:25.743 [DEBUG - kudu-nio-1] (Connection.java:748) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] connecting to peer
15:03:25.745 [DEBUG - kudu-nio-0] (Connection.java:757) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] Successfully connected to peer
15:03:25.768 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xa5510119, L:/127.0.0.1:43550 - R:/127.5.174.66:40211] using TOKEN/null
15:03:25.788 [DEBUG - kudu-nio-0] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=03c0948d55aa4becbde3359733714541, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
15:03:25.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.802790  5898 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52698:
15:03:25.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
15:03:25.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.803122  5898 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:52698:
15:03:25.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
15:03:25.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.806957  5898 catalog_manager.cc:5782] T 00000000000000000000000000000000 P 99ab9b8845404eb2984fa1576e57da69: Sending DeleteTablet for 3 replicas of tablet 03c0948d55aa4becbde3359733714541
15:03:25.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.808080  6528 tablet_service.cc:1514] Processing DeleteTablet for tablet 03c0948d55aa4becbde3359733714541 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 15:03:25 UTC) from {username='kudu', principal='kudu/127.5.174.126@KRBTEST.COM'} at 127.0.0.1:48362
15:03:25.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.808612  6709 tablet_replica.cc:330] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: stopping tablet replica
15:03:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.808995  6709 raft_consensus.cc:2229] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 1 FOLLOWER]: Raft consensus shutting down.
15:03:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.809283  6709 raft_consensus.cc:2258] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8 [term 1 FOLLOWER]: Raft consensus is shut down!
15:03:25.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.810832  6709 ts_tablet_manager.cc:1905] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Deleting tablet data with delete state TABLET_DATA_DELETED
15:03:25.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.811103  6307 tablet_service.cc:1514] Processing DeleteTablet for tablet 03c0948d55aa4becbde3359733714541 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 15:03:25 UTC) from {username='kudu', principal='kudu/127.5.174.126@KRBTEST.COM'} at 127.0.0.1:44710
15:03:25.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.811110  6108 tablet_service.cc:1514] Processing DeleteTablet for tablet 03c0948d55aa4becbde3359733714541 with delete_type TABLET_DATA_DELETED (Table deleted at 2026-08-11 15:03:25 UTC) from {username='kudu', principal='kudu/127.5.174.126@KRBTEST.COM'} at 127.0.0.1:46968
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.813925  6709 ts_tablet_manager.cc:1918] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.813947  6714 tablet_replica.cc:330] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: stopping tablet replica
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.814301  6709 log.cc:1196] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Deleting WAL directory at /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-2/wal/wals/03c0948d55aa4becbde3359733714541
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.814347  6714 raft_consensus.cc:2229] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 1 LEADER]: Raft consensus shutting down.
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.814754  6714 raft_consensus.cc:2258] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea [term 1 FOLLOWER]: Raft consensus is shut down!
15:03:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.814906  6709 ts_tablet_manager.cc:1939] T 03c0948d55aa4becbde3359733714541 P be2f85d3747e454cb0233b82a42c6fb8: Deleting consensus metadata
15:03:25.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.816332  6714 ts_tablet_manager.cc:1905] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Deleting tablet data with delete state TABLET_DATA_DELETED
15:03:25.816 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.816749  6711 tablet_replica.cc:330] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: stopping tablet replica
15:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.817222  6711 raft_consensus.cc:2229] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 1 FOLLOWER]: Raft consensus shutting down.
15:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.817258  5885 catalog_manager.cc:4841] TS be2f85d3747e454cb0233b82a42c6fb8 (127.5.174.67:35017): tablet 03c0948d55aa4becbde3359733714541 (table TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]) successfully deleted
15:03:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.817781  6711 raft_consensus.cc:2258] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc [term 1 FOLLOWER]: Raft consensus is shut down!
15:03:25.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.820612  6714 ts_tablet_manager.cc:1918] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
15:03:25.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.820720  6714 log.cc:1196] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Deleting WAL directory at /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-1/wal/wals/03c0948d55aa4becbde3359733714541
15:03:25.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.821043  6714 ts_tablet_manager.cc:1939] T 03c0948d55aa4becbde3359733714541 P b9cff140b51d46fb9874ad6bbc3818ea: Deleting consensus metadata
15:03:25.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.822494  5881 catalog_manager.cc:4841] TS b9cff140b51d46fb9874ad6bbc3818ea (127.5.174.66:40211): tablet 03c0948d55aa4becbde3359733714541 (table TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]) successfully deleted
15:03:25.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.823525  6711 ts_tablet_manager.cc:1905] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Deleting tablet data with delete state TABLET_DATA_DELETED
15:03:25.824 [DEBUG - main] (Connection.java:575) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] disconnecting while in state READY
15:03:25.825 [DEBUG - main] (Connection.java:575) [peer master-127.5.174.126:44387(127.5.174.126:44387)] disconnecting while in state READY
15:03:25.825 [DEBUG - main] (Connection.java:575) [peer master-127.5.174.126:44387(127.5.174.126:44387)] disconnecting while in state READY
15:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.826117  6711 ts_tablet_manager.cc:1918] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
15:03:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.826416  6711 log.cc:1196] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Deleting WAL directory at /tmp/dist-test-taskloImSs/test-tmp/mini-kudu-cluster1888938166855276966/ts-0/wal/wals/03c0948d55aa4becbde3359733714541
15:03:25.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.826898  6711 ts_tablet_manager.cc:1939] T 03c0948d55aa4becbde3359733714541 P 11b877e9bf40448f98a6fe998dba81dc: Deleting consensus metadata
15:03:25.827 [DEBUG - kudu-nio-0] (Connection.java:239) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] handling channelInactive
15:03:25.827 [DEBUG - kudu-nio-0] (Connection.java:709) [peer b9cff140b51d46fb9874ad6bbc3818ea(127.5.174.66:40211)] cleaning up while in state READY due to: connection closed
15:03:25.829 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.828927  5885 catalog_manager.cc:4841] TS 11b877e9bf40448f98a6fe998dba81dc (127.5.174.65:34607): tablet 03c0948d55aa4becbde3359733714541 (table TestAuthnTokenReacquireOpen-table [id=faa3032855314943a251596d55265cf3]) successfully deleted
15:03:25.832 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
15:03:25.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.833904  5817 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskloImSs/build/debug/bin/kudu with pid 6012
15:03:25.843 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.5.174.126:44387(127.5.174.126:44387)] handling channelInactive
15:03:25.843 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.5.174.126:44387(127.5.174.126:44387)] cleaning up while in state READY due to: connection closed
15:03:25.844 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.5.174.126:44387(127.5.174.126:44387)] handling channelInactive
15:03:25.844 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.5.174.126:44387(127.5.174.126:44387)] cleaning up while in state READY due to: connection closed
15:03:25.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.847872  5817 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskloImSs/build/debug/bin/kudu with pid 6207
15:03:25.867 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.867064  5817 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskloImSs/build/debug/bin/kudu with pid 6431
15:03:25.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 15:03:25.886509  5817 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskloImSs/build/debug/bin/kudu with pid 5857
15:03:25.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T15:03:25Z chronyd exiting

Time: 5.946

OK (1 test)

