JUnit version 4.13.2
.07:57:01.783 [INFO - main] (RandomUtils.java:49) Using random seed: 1783497421777
07:57:01.798 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
07:57:01.852 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
07:57:01.860 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskOBAK8I/test-tmp
07:57:01.862 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
07:57:01.866 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskOBAK8I/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
07:57:02.108 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142"
  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 {
  }
}

07:57:02.126 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
07:57:02.127 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

07:57:02.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.128664 18029 mini_oidc.cc:152] Starting JWKS server
07:57:02.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.129925 18029 webserver.cc:460] Webserver started at http://127.0.0.1:42537/ using document root <none> and password file <none>
07:57:02.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.130077 18029 mini_oidc.cc:189] Starting OIDC Discovery server
07:57:02.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.130292 18029 webserver.cc:460] Webserver started at http://127.0.0.1:39499/ using document root <none> and password file <none>
07:57:02.179 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
07:57:02.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/principal' for realm 'KRBTEST.COM',
07:57:02.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
07:57:02.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-z6hh krb5kdc[18039](info): setting up network...
07:57:02.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
07:57:02.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-z6hh krb5kdc[18039](info): set up 2 sockets
07:57:02.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-z6hh krb5kdc[18039](info): commencing operation
07:57:02.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
07:57:03.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.173074 18029 mini_kdc.cc:121] Time spent starting KDC: real 1.031s	user 0.002s	sys 0.004s
07:57:03.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
07:57:03.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
07:57:03.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
07:57:03.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
07:57:03.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
07:57:03.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.248 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
07:57:03.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.263 [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-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/test-user.keytab.
07:57:03.263 [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-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/test-user.keytab.
07:57:03.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
07:57:03.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:03Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
07:57:03.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:03Z Disabled control of system clock
07:57:03.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.155.126@KRBTEST.COM; defaulting to no policy
07:57:03.293 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.155.126@KRBTEST.COM" created.
07:57:03.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.126.keytab.
07:57:03.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.126.keytab.
07:57:03.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.309053 18029 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal
07:57:03.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/logs
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data/info.pb
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.126:42209
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.126
07:57:03.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.126.keytab
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.126
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.155.126:42209
07:57:03.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:03.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42537/jwks.json
07:57:03.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
07:57:03.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000 with env {KRB5CCNAME=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:03.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.391440 18052 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:03.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.391649 18052 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:03.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.391674 18052 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:03.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392796 18052 flags.cc:425] Enabled experimental flag: --authn_token_validity_seconds=1
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392832 18052 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392848 18052 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392860 18052 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392874 18052 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392885 18052 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
07:57:03.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.392896 18052 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:42537/jwks.json
07:57:03.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.394346 18052 master_runner.cc:386] Master server non-default flags:
07:57:03.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --authn_token_validity_seconds=1
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.17.155.126:42209
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.126.keytab
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.126
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:03.395 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.126:42209
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42537/jwks.json
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.396 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:03.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:03.397 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data/info.pb
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.126
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18052
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:03.398 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/logs
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:03.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:03.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.394552 18052 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:03.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.394811 18052 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:03.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.401127 18058 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
07:57:03.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.401166 18060 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
07:57:03.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.401127 18057 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
07:57:03.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.401710 18052 server_base.cc:1034] running on GCE node
07:57:03.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.402038 18052 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:03.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.402426 18052 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:03.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.403602 18052 hybrid_clock.cc:648] HybridClock initialized: now 1783497423403572 us; error 38 us; skew 500 ppm
07:57:03.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.406383 18052 init.cc:377] Logged in from keytab as kudu/127.17.155.126@KRBTEST.COM (short username kudu)
07:57:03.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.406855 18052 webserver.cc:460] Webserver started at http://127.17.155.126:45613/ using document root <none> and password file <none>
07:57:03.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.407044 18052 fs_manager.cc:359] Metadata directory not provided
07:57:03.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.407083 18052 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:03.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.407174 18052 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:03.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.408392 18052 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data/instance:
07:57:03.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aeba7691dbb24720aa11940e7c807364"
07:57:03.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.408700 18052 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal/instance:
07:57:03.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aeba7691dbb24720aa11940e7c807364"
07:57:03.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.410027 18052 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
07:57:03.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.410722 18067 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.410878 18052 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.000s
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.410964 18052 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data,/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "aeba7691dbb24720aa11940e7c807364"
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.411033 18052 fs_report.cc:383] FS layout report
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:03.411 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data/data
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:03.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:03.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:03.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.430929 18052 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:03.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.433934 18052 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
07:57:03.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.434067 18052 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:03.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.438206 18052 rpc_server.cc:307] RPC server started. Bound to: 127.17.155.126:42209
07:57:03.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.438241 18119 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.17.155.126:42209 every 8 connection(s)
07:57:03.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.438555 18052 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/data/info.pb
07:57:03.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.439507 18120 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
07:57:03.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.441936 18120 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: Bootstrap starting.
07:57:03.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.442700 18120 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: Neither blocks nor log segments found. Creating new log.
07:57:03.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.443028 18120 log.cc:824] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: Log is configured to *not* fsync() on all Append() calls
07:57:03.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.443837 18120 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: No bootstrap required, opened a new log
07:57:03.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.444808 18029 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOBAK8I/build/release/bin/kudu as pid 18052
07:57:03.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.444938 18029 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/master-0/wal/instance
07:57:03.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.446189 18120 raft_consensus.cc:348] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } }
07:57:03.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.446662 18120 raft_consensus.cc:374] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
07:57:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.446761 18120 raft_consensus.cc:729] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: aeba7691dbb24720aa11940e7c807364, State: Initialized, Role: FOLLOWER
07:57:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.446910 18120 consensus_queue.cc:260] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [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: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } }
07:57:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.447005 18120 raft_consensus.cc:388] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
07:57:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.447039 18120 raft_consensus.cc:482] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
07:57:03.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.447081 18120 raft_consensus.cc:3037] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 0 FOLLOWER]: Advancing to term 1
07:57:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.448148 18120 raft_consensus.cc:504] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } }
07:57:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.448299 18120 leader_election.cc:302] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [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: aeba7691dbb24720aa11940e7c807364; no voters: 
07:57:03.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.448477 18120 leader_election.cc:288] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [CANDIDATE]: Term 1 election: Requested vote from peers 
07:57:03.449 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.448752 18120 sys_catalog.cc:564] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [sys.catalog]: configured and running, proceeding with master startup.
07:57:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.450066 18125 raft_consensus.cc:2781] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 1 FOLLOWER]: Leader election won for term 1
07:57:03.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.450587 18125 raft_consensus.cc:686] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [term 1 LEADER]: Becoming Leader. State: Replica: aeba7691dbb24720aa11940e7c807364, State: Running, Role: LEADER
07:57:03.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.450918 18125 consensus_queue.cc:237] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [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: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } }
07:57:03.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.451337 18138 sys_catalog.cc:455] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [sys.catalog]: SysCatalogTable state changed. Reason: New leader aeba7691dbb24720aa11940e7c807364. Latest consensus state: current_term: 1 leader_uuid: "aeba7691dbb24720aa11940e7c807364" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } } }
07:57:03.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.451428 18138 sys_catalog.cc:458] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [sys.catalog]: This master's current role is: LEADER
07:57:03.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.451771 18137 catalog_manager.cc:1558] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
07:57:03.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.451824 18126 sys_catalog.cc:455] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "aeba7691dbb24720aa11940e7c807364" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "aeba7691dbb24720aa11940e7c807364" member_type: VOTER last_known_addr { host: "127.17.155.126" port: 42209 } } }
07:57:03.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.451895 18126 sys_catalog.cc:458] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364 [sys.catalog]: This master's current role is: LEADER
07:57:03.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.451823 18137 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
07:57:03.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.452636 18141 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
07:57:03.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.452847 18141 catalog_manager.cc:1484] Initializing Kudu cluster ID...
07:57:03.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.454528 18141 catalog_manager.cc:1347] Generated new cluster ID: 3ad9ee904f354f818619c2030080663e
07:57:03.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.454581 18141 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
07:57:03.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.17.155.126@KRBTEST.COM
07:57:03.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.476414 18141 catalog_manager.cc:1370] Generated new certificate authority record
07:57:03.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.477172 18141 catalog_manager.cc:1504] Loading token signing keys...
07:57:03.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.495101 18141 catalog_manager.cc:5868] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: Generated new TSK 0
07:57:03.495 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.495330 18141 catalog_manager.cc:1514] Initializing in-progress tserver states...
07:57:03.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.155.65@KRBTEST.COM; defaulting to no policy
07:57:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.155.65@KRBTEST.COM" created.
07:57:03.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.65.keytab.
07:57:03.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.65.keytab.
07:57:03.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.523667 18029 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/logs
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data/info.pb
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:03.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:03.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:03.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.65:0
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.65
07:57:03.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.65
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.65.keytab
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.65
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.527 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:03.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.610321 18146 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.610575 18146 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.610600 18146 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:03.611 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.610631 18146 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.612123 18146 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:03.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.612231 18146 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.155.65
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.613885 18146 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.65.keytab
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.65
07:57:03.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.65:0
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data/info.pb
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.65
07:57:03.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18146
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.65
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/logs
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:03.616 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:03.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:03.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:03.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:03.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.614182 18146 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:03.617 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.614476 18146 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:03.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.620026 18152 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
07:57:03.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.620029 18151 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
07:57:03.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.620029 18154 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
07:57:03.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.620342 18146 server_base.cc:1034] running on GCE node
07:57:03.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.620560 18146 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:03.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.620828 18146 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:03.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.622000 18146 hybrid_clock.cc:648] HybridClock initialized: now 1783497423621982 us; error 27 us; skew 500 ppm
07:57:03.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.625360 18146 init.cc:377] Logged in from keytab as kudu/127.17.155.65@KRBTEST.COM (short username kudu)
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.625895 18146 webserver.cc:460] Webserver started at http://127.17.155.65:34791/ using document root <none> and password file <none>
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.626152 18146 fs_manager.cc:359] Metadata directory not provided
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.626202 18146 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.626327 18146 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.627544 18146 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data/instance:
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70561fbce6bc4946974c3a5262c3e3a9"
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.627952 18146 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal/instance:
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70561fbce6bc4946974c3a5262c3e3a9"
07:57:03.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.629596 18146 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
07:57:03.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.630458 18161 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:03.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.630620 18146 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
07:57:03.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.630700 18146 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data,/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70561fbce6bc4946974c3a5262c3e3a9"
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.630750 18146 fs_report.cc:383] FS layout report
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data/data
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:03.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:03.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:03.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:03.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:03.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.642702 18146 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:03.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.644994 18146 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
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645162 18146 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645355 18146 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645601 18146 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645625 18146 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645648 18146 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:03.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.645660 18146 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:03.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.651830 18146 rpc_server.cc:307] RPC server started. Bound to: 127.17.155.65:35791
07:57:03.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.651924 18274 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.17.155.65:35791 every 8 connection(s)
07:57:03.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.652308 18146 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/data/info.pb
07:57:03.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.653515 18029 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOBAK8I/build/release/bin/kudu as pid 18146
07:57:03.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.653611 18029 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal/instance
07:57:03.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.65@KRBTEST.COM for kudu/127.17.155.126@KRBTEST.COM
07:57:03.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.155.66@KRBTEST.COM; defaulting to no policy
07:57:03.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.155.66@KRBTEST.COM" created.
07:57:03.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.667203 18275 heartbeater.cc:347] Connected to a master server at 127.17.155.126:42209
07:57:03.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.667325 18275 heartbeater.cc:464] Registering TS with master...
07:57:03.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.667534 18275 heartbeater.cc:511] Master 127.17.155.126:42209 requested a full tablet report, sending...
07:57:03.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.668449 18084 ts_manager.cc:194] Registered new tserver with Master: 70561fbce6bc4946974c3a5262c3e3a9 (127.17.155.65:35791)
07:57:03.669 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.669265 18084 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.155.65@KRBTEST.COM'} at 127.17.155.65:33279
07:57:03.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.682 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.66.keytab.
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.66.keytab.
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.683058 18029 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:03.683 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/logs
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data/info.pb
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.684 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.66:0
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.66
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.66
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.66.keytab
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.66
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:03.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:03.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.767112 18280 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.767 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.767390 18280 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:03.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.767417 18280 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:03.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.767446 18280 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:03.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.768931 18280 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:03.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.769026 18280 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.155.66
07:57:03.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.770609 18280 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:03.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.66.keytab
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.66
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.66:0
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data/info.pb
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.66
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:03.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18280
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.66
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/logs
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.770882 18280 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:03.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.771164 18280 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:03.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.777298 18288 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
07:57:03.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.777385 18280 server_base.cc:1034] running on GCE node
07:57:03.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.777310 18285 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
07:57:03.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.777325 18286 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
07:57:03.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.777693 18280 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:03.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.777961 18280 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:03.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.781225 18280 hybrid_clock.cc:648] HybridClock initialized: now 1783497423781200 us; error 34 us; skew 500 ppm
07:57:03.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.784379 18280 init.cc:377] Logged in from keytab as kudu/127.17.155.66@KRBTEST.COM (short username kudu)
07:57:03.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.784914 18280 webserver.cc:460] Webserver started at http://127.17.155.66:45179/ using document root <none> and password file <none>
07:57:03.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.785149 18280 fs_manager.cc:359] Metadata directory not provided
07:57:03.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.785212 18280 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:03.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.785338 18280 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.786335 18280 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data/instance:
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "101a3d7063cd4dc18ce76388026fe703"
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.786635 18280 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal/instance:
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "101a3d7063cd4dc18ce76388026fe703"
07:57:03.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.787900 18280 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
07:57:03.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.788736 18295 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.788921 18280 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.788987 18280 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data,/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "101a3d7063cd4dc18ce76388026fe703"
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.789033 18280 fs_report.cc:383] FS layout report
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data/data
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:03.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:03.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.802278 18280 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:03.804 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.804529 18280 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
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.804642 18280 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.804828 18280 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.805073 18280 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.805096 18280 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.805119 18280 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:03.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.805130 18280 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:03.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.811579 18280 rpc_server.cc:307] RPC server started. Bound to: 127.17.155.66:45119
07:57:03.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.811628 18408 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.17.155.66:45119 every 8 connection(s)
07:57:03.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.811949 18280 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/data/info.pb
07:57:03.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.66@KRBTEST.COM for kudu/127.17.155.126@KRBTEST.COM
07:57:03.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.818723 18029 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOBAK8I/build/release/bin/kudu as pid 18280
07:57:03.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.818823 18029 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal/instance
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.823570 18409 heartbeater.cc:347] Connected to a master server at 127.17.155.126:42209
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.823690 18409 heartbeater.cc:464] Registering TS with master...
07:57:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.823884 18409 heartbeater.cc:511] Master 127.17.155.126:42209 requested a full tablet report, sending...
07:57:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.824338 18084 ts_manager.cc:194] Registered new tserver with Master: 101a3d7063cd4dc18ce76388026fe703 (127.17.155.66:45119)
07:57:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.824713 18084 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.155.66@KRBTEST.COM'} at 127.17.155.66:49311
07:57:03.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.17.155.67@KRBTEST.COM; defaulting to no policy
07:57:03.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.17.155.67@KRBTEST.COM" created.
07:57:03.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.67.keytab.
07:57:03.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.17.155.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.67.keytab.
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.845003 18029 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskOBAK8I/build/release/bin/kudu
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/logs
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data/info.pb
07:57:03.845 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.67:0
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.67
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.67
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.67.keytab
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.67
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.846 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5 with env {KRB5CCNAME=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:03.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.928990 18414 flags.cc:425] Enabled unsafe flag: --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.929184 18414 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:03.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.929199 18414 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:03.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.929219 18414 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:03.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.930281 18414 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:03.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.930327 18414 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.17.155.67
07:57:03.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.931804 18414 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.17.155.84:34725
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_inject_invalid_authn_token_ratio=0.5
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kudu_127.17.155.67.keytab
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.17.155.67
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.17.155.67:0
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_default_keepalive_time_ms=120000
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data/info.pb
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.17.155.67
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.17.155.126:42209
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.18414
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.17.155.67
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/logs
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.931981 18414 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.932144 18414 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.937300 18414 server_base.cc:1034] running on GCE node
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.937273 18420 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
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.937263 18419 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
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.937281 18422 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
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.937923 18414 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:03.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.938109 18414 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:03.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.939266 18414 hybrid_clock.cc:648] HybridClock initialized: now 1783497423939240 us; error 42 us; skew 500 ppm
07:57:03.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.941887 18414 init.cc:377] Logged in from keytab as kudu/127.17.155.67@KRBTEST.COM (short username kudu)
07:57:03.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.942381 18414 webserver.cc:460] Webserver started at http://127.17.155.67:45517/ using document root <none> and password file <none>
07:57:03.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.942675 18414 fs_manager.cc:359] Metadata directory not provided
07:57:03.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.942765 18414 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:03.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.942898 18414 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.944006 18414 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data/instance:
07:57:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3596644d64234224a1ffca6dc4b7b794"
07:57:03.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.944460 18414 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal/instance:
07:57:03.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3596644d64234224a1ffca6dc4b7b794"
07:57:03.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.946060 18414 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
07:57:03.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.946949 18429 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.948383 18414 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.948488 18414 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data,/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "3596644d64234224a1ffca6dc4b7b794"
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-z6hh"
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.948559 18414 fs_report.cc:383] FS layout report
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data/data
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:03.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:03.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.960134 18414 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:03.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.962435 18414 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
07:57:03.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.962613 18414 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:03.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.962885 18414 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.963301 18414 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.963356 18414 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.963390 18414 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:03.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.963411 18414 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.969367 18414 rpc_server.cc:307] RPC server started. Bound to: 127.17.155.67:36047
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.969408 18542 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.17.155.67:36047 every 8 connection(s)
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.969743 18414 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/data/info.pb
07:57:03.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.971138 18029 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskOBAK8I/build/release/bin/kudu as pid 18414
07:57:03.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.971211 18029 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal/instance
07:57:03.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-z6hh krb5kdc[18039](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.17.155.67@KRBTEST.COM for kudu/127.17.155.126@KRBTEST.COM
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979892 18543 heartbeater.cc:347] Connected to a master server at 127.17.155.126:42209
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979975 18543 heartbeater.cc:464] Registering TS with master...
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.980111 18543 heartbeater.cc:511] Master 127.17.155.126:42209 requested a full tablet report, sending...
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.980533 18084 ts_manager.cc:194] Registered new tserver with Master: 3596644d64234224a1ffca6dc4b7b794 (127.17.155.67:36047)
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.980878 18084 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.17.155.67@KRBTEST.COM'} at 127.17.155.67:60175
07:57:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.983479 18029 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
07:57:03.984 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
07:57:03.985 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

07:57:03.996 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

07:57:03.997 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

07:57:04.006 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.155.126"
      port: 42209
    }
    bound_http_address {
      host: "127.17.155.126"
      port: 45613
    }
  }
}

07:57:04.009 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

07:57:04.011 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.17.155.65"
      port: 35791
    }
    bound_http_address {
      host: "127.17.155.65"
      port: 34791
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.17.155.66"
      port: 45119
    }
    bound_http_address {
      host: "127.17.155.66"
      port: 45179
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.17.155.67"
      port: 36047
    }
    bound_http_address {
      host: "127.17.155.67"
      port: 45517
    }
  }
}

07:57:04.012 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
07:57:04.177 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/krb5kdc/krb5cc
07:57:04.200 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
07:57:04.384 [DEBUG - main] (Connection.java:748) [peer master-127.17.155.126:42209(127.17.155.126:42209)] connecting to peer
07:57:04.460 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.17.155.126:42209(127.17.155.126:42209)] Successfully connected to peer
07:57:04.554 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.17.155.126
07:57:04.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.670560 18275 heartbeater.cc:503] Master 127.17.155.126:42209 was elected leader, sending a full tablet report...
07:57:04.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-z6hh krb5kdc[18039](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.17.155.126@KRBTEST.COM
07:57:04.818 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x24bad6eb, L:/127.0.0.1:45640 - R:/127.17.155.126:42209] using SASL/GSSAPI
07:57:04.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.825832 18409 heartbeater.cc:503] Master 127.17.155.126:42209 was elected leader, sending a full tablet report...
07:57:04.856 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
07:57:04.857 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTabletServers, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=519), Traces: [0ms] refreshing cache from master, [33ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.155.126:42209, [489ms] Sub RPC ConnectToMaster: received response from server master-127.17.155.126:42209: OK, deferred=null) after lookup
07:57:04.875 [DEBUG - main] (Connection.java:575) [peer master-127.17.155.126:42209(127.17.155.126:42209)] disconnecting while in state READY
07:57:04.881 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.17.155.126:42209(127.17.155.126:42209)] handling channelInactive
07:57:04.881 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.17.155.126:42209(127.17.155.126:42209)] cleaning up while in state READY due to: connection closed
07:57:04.882 [INFO - kudu-nio-0] (AsyncKuduClient.java:2355) Invalidating location master-127.17.155.126:42209(127.17.155.126:42209) for tablet Kudu Master: connection closed
07:57:04.900 [DEBUG - pool-2-thread-1] (Connection.java:748) [peer master-127.17.155.126:42209(127.17.155.126:42209)] connecting to peer
07:57:04.902 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.17.155.126:42209(127.17.155.126:42209)] Successfully connected to peer
07:57:04.960 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0xeefadade, L:/127.0.0.1:37432 - R:/127.17.155.126:42209] using TOKEN/null
07:57:04.963 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
07:57:04.964 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=ListTables, tablet=Kudu Master, attempt=2, TimeoutTracker(timeout=50000, elapsed=87), Traces: [0ms] sending RPC to server master-127.17.155.126:42209, [5ms] received response from server master-127.17.155.126:42209: Network error: connection closed, [6ms] delaying RPC due to: Network error: connection closed, [23ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.17.155.126:42209, [86ms] Sub RPC ConnectToMaster: received response from server master-127.17.155.126:42209: OK, deferred=Deferred@666356856(state=PENDING, result=null, callback=wakeup thread main, errback=wakeup thread main)) after lookup
07:57:04.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.981828 18543 heartbeater.cc:503] Master 127.17.155.126:42209 was elected leader, sending a full tablet report...
07:57:05.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.026861 18084 catalog_manager.cc:1908] Servicing CreateTable request from {username='test-admin'} at 127.0.0.1:37432:
07:57:05.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "TestAuthnTokenReacquireOpen-table"
07:57:05.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
07:57:05.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
07:57:05.028 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column1_i"
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.029 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column2_i"
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: INT32
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column3_s"
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: true
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     encoding: DICT_ENCODING
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     compression: LZ4
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 4096
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "column4_b"
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: BOOL
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: false
07:57:05.030 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
07:57:05.031 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:05.028715 18084 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.
07:57:05.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.041065 18343 tablet_service.cc:1467] Processing CreateTablet for tablet 0a3088219aac4f3096f34bc82d37935e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]), partition=RANGE (key) PARTITION UNBOUNDED
07:57:05.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.041457 18343 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 0a3088219aac4f3096f34bc82d37935e. 1 dirs total, 0 dirs full, 0 dirs failed
07:57:05.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.048457 18559 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Bootstrap starting.
07:57:05.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.049436 18559 tablet_bootstrap.cc:654] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Neither blocks nor log segments found. Creating new log.
07:57:05.050 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.049986 18559 log.cc:824] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Log is configured to *not* fsync() on all Append() calls
07:57:05.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051291 18209 tablet_service.cc:1467] Processing CreateTablet for tablet 0a3088219aac4f3096f34bc82d37935e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]), partition=RANGE (key) PARTITION UNBOUNDED
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051501 18559 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: No bootstrap required, opened a new log
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051393 18477 tablet_service.cc:1467] Processing CreateTablet for tablet 0a3088219aac4f3096f34bc82d37935e (DEFAULT_TABLE table=TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]), partition=RANGE (key) PARTITION UNBOUNDED
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051561 18559 ts_tablet_manager.cc:1397] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Time spent bootstrapping tablet: real 0.003s	user 0.001s	sys 0.000s
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051630 18209 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 0a3088219aac4f3096f34bc82d37935e. 1 dirs total, 0 dirs full, 0 dirs failed
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.051700 18477 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 0a3088219aac4f3096f34bc82d37935e. 1 dirs total, 0 dirs full, 0 dirs failed
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.054263 18559 raft_consensus.cc:348] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.054450 18559 raft_consensus.cc:374] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.054489 18559 raft_consensus.cc:729] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 101a3d7063cd4dc18ce76388026fe703, State: Initialized, Role: FOLLOWER
07:57:05.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.054629 18559 consensus_queue.cc:260] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [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: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.055008 18559 ts_tablet_manager.cc:1428] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Time spent starting tablet: real 0.003s	user 0.004s	sys 0.000s
07:57:05.056 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2daf592dc66147e79ef8fe0c35048ed5
07:57:05.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.056865 18561 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Bootstrap starting.
07:57:05.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.057557 18561 tablet_bootstrap.cc:654] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Neither blocks nor log segments found. Creating new log.
07:57:05.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.057888 18561 log.cc:824] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Log is configured to *not* fsync() on all Append() calls
07:57:05.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.058251 18562 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Bootstrap starting.
07:57:05.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.059070 18562 tablet_bootstrap.cc:654] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Neither blocks nor log segments found. Creating new log.
07:57:05.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.059885 18561 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: No bootstrap required, opened a new log
07:57:05.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.059962 18561 ts_tablet_manager.cc:1397] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Time spent bootstrapping tablet: real 0.003s	user 0.001s	sys 0.000s
07:57:05.060 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.060220 18562 log.cc:824] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Log is configured to *not* fsync() on all Append() calls
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.061053 18562 tablet_bootstrap.cc:492] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: No bootstrap required, opened a new log
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.061115 18562 ts_tablet_manager.cc:1397] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062359 18561 raft_consensus.cc:348] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062482 18561 raft_consensus.cc:374] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062502 18561 raft_consensus.cc:729] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 70561fbce6bc4946974c3a5262c3e3a9, State: Initialized, Role: FOLLOWER
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062634 18561 consensus_queue.cc:260] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [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: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062911 18561 ts_tablet_manager.cc:1428] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Time spent starting tablet: real 0.003s	user 0.003s	sys 0.000s
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.062847 18562 raft_consensus.cc:348] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.063048 18562 raft_consensus.cc:374] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:05.063067 18410 tablet.cc:2369] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Can't schedule compaction. Clean time has not been advanced past its initial value.
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.063083 18562 raft_consensus.cc:729] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3596644d64234224a1ffca6dc4b7b794, State: Initialized, Role: FOLLOWER
07:57:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.063187 18562 consensus_queue.cc:260] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [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: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.063434 18562 ts_tablet_manager.cc:1428] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
07:57:05.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.072402 18566 raft_consensus.cc:482] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
07:57:05.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.072525 18566 raft_consensus.cc:504] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.073050 18566 leader_election.cc:288] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 101a3d7063cd4dc18ce76388026fe703 (127.17.155.66:45119), 3596644d64234224a1ffca6dc4b7b794 (127.17.155.67:36047)
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.077840 18363 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "0a3088219aac4f3096f34bc82d37935e" candidate_uuid: "70561fbce6bc4946974c3a5262c3e3a9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "101a3d7063cd4dc18ce76388026fe703" is_pre_election: true
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.078018 18363 raft_consensus.cc:2454] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 70561fbce6bc4946974c3a5262c3e3a9 in term 0.
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.078290 18163 leader_election.cc:302] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [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: 101a3d7063cd4dc18ce76388026fe703, 70561fbce6bc4946974c3a5262c3e3a9; no voters: 
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.078526 18566 raft_consensus.cc:2781] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Leader pre-election won for term 1
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.078609 18566 raft_consensus.cc:482] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
07:57:05.078 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.078635 18566 raft_consensus.cc:3037] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 0 FOLLOWER]: Advancing to term 1
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.079536 18566 raft_consensus.cc:504] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.079674 18566 leader_election.cc:288] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [CANDIDATE]: Term 1 election: Requested vote from peers 101a3d7063cd4dc18ce76388026fe703 (127.17.155.66:45119), 3596644d64234224a1ffca6dc4b7b794 (127.17.155.67:36047)
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.079895 18363 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "0a3088219aac4f3096f34bc82d37935e" candidate_uuid: "70561fbce6bc4946974c3a5262c3e3a9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "101a3d7063cd4dc18ce76388026fe703"
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.079983 18363 raft_consensus.cc:3037] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 0 FOLLOWER]: Advancing to term 1
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.080050 18497 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "0a3088219aac4f3096f34bc82d37935e" candidate_uuid: "70561fbce6bc4946974c3a5262c3e3a9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3596644d64234224a1ffca6dc4b7b794" is_pre_election: true
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.080305 18497 raft_consensus.cc:2454] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 70561fbce6bc4946974c3a5262c3e3a9 in term 0.
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.080381 18496 tablet_service.cc:1812] Received RequestConsensusVote() RPC: tablet_id: "0a3088219aac4f3096f34bc82d37935e" candidate_uuid: "70561fbce6bc4946974c3a5262c3e3a9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "3596644d64234224a1ffca6dc4b7b794"
07:57:05.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.080461 18496 raft_consensus.cc:3037] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 0 FOLLOWER]: Advancing to term 1
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.080861 18363 raft_consensus.cc:2454] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 70561fbce6bc4946974c3a5262c3e3a9 in term 1.
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.081028 18163 leader_election.cc:302] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [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: 101a3d7063cd4dc18ce76388026fe703, 70561fbce6bc4946974c3a5262c3e3a9; no voters: 
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.081105 18566 raft_consensus.cc:2781] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 1 FOLLOWER]: Leader election won for term 1
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.081254 18566 raft_consensus.cc:686] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 1 LEADER]: Becoming Leader. State: Replica: 70561fbce6bc4946974c3a5262c3e3a9, State: Running, Role: LEADER
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.081333 18496 raft_consensus.cc:2454] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 70561fbce6bc4946974c3a5262c3e3a9 in term 1.
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.081346 18566 consensus_queue.cc:237] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [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: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } }
07:57:05.082 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.082268 18083 catalog_manager.cc:5495] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 reported cstate change: term changed from 0 to 1, leader changed from <none> to 70561fbce6bc4946974c3a5262c3e3a9 (127.17.155.65). New cstate: current_term: 1 leader_uuid: "70561fbce6bc4946974c3a5262c3e3a9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "70561fbce6bc4946974c3a5262c3e3a9" member_type: VOTER last_known_addr { host: "127.17.155.65" port: 35791 } health_report { overall_health: HEALTHY } } }
07:57:05.091 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2daf592dc66147e79ef8fe0c35048ed5
07:57:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:05.153664 18276 tablet.cc:2369] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Can't schedule compaction. Clean time has not been advanced past its initial value.
07:57:05.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:05.220861 18544 tablet.cc:2369] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Can't schedule compaction. Clean time has not been advanced past its initial value.
07:57:05.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.537324 18566 consensus_queue.cc:1035] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "3596644d64234224a1ffca6dc4b7b794" member_type: VOTER last_known_addr { host: "127.17.155.67" port: 36047 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
07:57:05.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:05.539762 18566 consensus_queue.cc:1035] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "101a3d7063cd4dc18ce76388026fe703" member_type: VOTER last_known_addr { host: "127.17.155.66" port: 45119 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
07:57:06.095 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 2daf592dc66147e79ef8fe0c35048ed5
07:57:06.117 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 0a3088219aac4f3096f34bc82d37935e for table 'TestAuthnTokenReacquireOpen-table' with partition [<start>, <end>)
07:57:06.127 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299989, tablet=0a3088219aac4f3096f34bc82d37935e@[101a3d7063cd4dc18ce76388026fe703(127.17.155.66:45119),3596644d64234224a1ffca6dc4b7b794(127.17.155.67:36047),70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)[L]]}]
07:57:06.129 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC ScanRequest(scannerId=null, state=OPENING, attempt=1, KuduRpc(method=Scan, tablet=null, attempt=1, TimeoutTracker(timeout=60000, elapsed=20), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.17.155.126:42209, [8ms] Sub RPC GetTableLocations: received response from server master-127.17.155.126:42209: OK, deferred=null)) after lookup
07:57:06.147 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] connecting to peer
07:57:06.149 [DEBUG - kudu-nio-0] (Connection.java:757) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] Successfully connected to peer
07:57:06.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:06.171396 18578 negotiation.cc:344] Unauthorized connection attempt: Server connection negotiation failed: server connection from 127.0.0.1:56164: token expired
07:57:06.176 [DEBUG - kudu-nio-0] (Negotiator.java:352) peer /127.17.155.65:35791 sent connection negotiation error: Not authorized: token expired
07:57:06.178 [DEBUG - kudu-nio-0] (Connection.java:239) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] handling channelInactive
07:57:06.178 [DEBUG - kudu-nio-0] (Connection.java:709) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] cleaning up while in state NEGOTIATION_FAILED due to: connection closed
07:57:06.179 [DEBUG - kudu-nio-0] (Connection.java:748) [peer master-127.17.155.126:42209(127.17.155.126:42209)] connecting to peer
07:57:06.182 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.17.155.126:42209(127.17.155.126:42209)] Successfully connected to peer
07:57:06.184 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism GSSAPI chosen for peer 127.17.155.126
07:57:06.211 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x7a5d178e, L:/127.0.0.1:37442 - R:/127.17.155.126:42209] using SASL/GSSAPI
07:57:06.214 [INFO - kudu-nio-1] (AsyncKuduClient.java:516) connect to master: received a new authn token
07:57:06.215 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] connecting to peer
07:57:06.217 [DEBUG - kudu-nio-0] (Connection.java:757) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] Successfully connected to peer
07:57:06.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:06.236485 18578 fault_injection.cc:43] FAULT INJECTION ENABLED!
07:57:06.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:06.236569 18578 fault_injection.cc:44] THIS SERVER MAY CRASH!
07:57:06.237 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x4edaeae5, L:/127.0.0.1:56172 - R:/127.17.155.65:35791] using TOKEN/null
07:57:06.257 [DEBUG - kudu-nio-0] (AsyncKuduScanner.java:1374) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 0 rows, more = false) for scanner KuduScanner(table=TestAuthnTokenReacquireOpen-table, tablet=0a3088219aac4f3096f34bc82d37935e, scannerId=null, scanRequestTimeout=60000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
07:57:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.272037 18084 catalog_manager.cc:2461] Servicing SoftDeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:37442:
07:57:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
07:57:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.272179 18084 catalog_manager.cc:2645] Servicing DeleteTable request from {username='test-admin', principal='test-admin@KRBTEST.COM'} at 127.0.0.1:37442:
07:57:06.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) table { table_name: "TestAuthnTokenReacquireOpen-table" }
07:57:06.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.276547 18084 catalog_manager.cc:5782] T 00000000000000000000000000000000 P aeba7691dbb24720aa11940e7c807364: Sending DeleteTablet for 3 replicas of tablet 0a3088219aac4f3096f34bc82d37935e
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277053 18343 tablet_service.cc:1514] Processing DeleteTablet for tablet 0a3088219aac4f3096f34bc82d37935e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 07:57:06 UTC) from {username='kudu', principal='kudu/127.17.155.126@KRBTEST.COM'} at 127.0.0.1:58906
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277150 18209 tablet_service.cc:1514] Processing DeleteTablet for tablet 0a3088219aac4f3096f34bc82d37935e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 07:57:06 UTC) from {username='kudu', principal='kudu/127.17.155.126@KRBTEST.COM'} at 127.0.0.1:56160
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277323 18477 tablet_service.cc:1514] Processing DeleteTablet for tablet 0a3088219aac4f3096f34bc82d37935e with delete_type TABLET_DATA_DELETED (Table deleted at 2026-07-08 07:57:06 UTC) from {username='kudu', principal='kudu/127.17.155.126@KRBTEST.COM'} at 127.0.0.1:38558
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277388 18585 tablet_replica.cc:330] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: stopping tablet replica
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277529 18585 raft_consensus.cc:2229] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 1 FOLLOWER]: Raft consensus shutting down.
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277619 18585 raft_consensus.cc:2258] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703 [term 1 FOLLOWER]: Raft consensus is shut down!
07:57:06.277 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.277796 18586 tablet_replica.cc:330] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: stopping tablet replica
07:57:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.278043 18585 ts_tablet_manager.cc:1905] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Deleting tablet data with delete state TABLET_DATA_DELETED
07:57:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.278095 18586 raft_consensus.cc:2229] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 1 LEADER]: Raft consensus shutting down.
07:57:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.278216 18586 raft_consensus.cc:2258] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9 [term 1 FOLLOWER]: Raft consensus is shut down!
07:57:06.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.278585 18586 ts_tablet_manager.cc:1905] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Deleting tablet data with delete state TABLET_DATA_DELETED
07:57:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.279983 18585 ts_tablet_manager.cc:1918] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
07:57:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.280208 18585 log.cc:1196] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Deleting WAL directory at /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-1/wal/wals/0a3088219aac4f3096f34bc82d37935e
07:57:06.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.280675 18585 ts_tablet_manager.cc:1939] T 0a3088219aac4f3096f34bc82d37935e P 101a3d7063cd4dc18ce76388026fe703: Deleting consensus metadata
07:57:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.280920 18586 ts_tablet_manager.cc:1918] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
07:57:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.281108 18586 log.cc:1196] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Deleting WAL directory at /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-0/wal/wals/0a3088219aac4f3096f34bc82d37935e
07:57:06.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.281508 18586 ts_tablet_manager.cc:1939] T 0a3088219aac4f3096f34bc82d37935e P 70561fbce6bc4946974c3a5262c3e3a9: Deleting consensus metadata
07:57:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.282191 18069 catalog_manager.cc:4841] TS 101a3d7063cd4dc18ce76388026fe703 (127.17.155.66:45119): tablet 0a3088219aac4f3096f34bc82d37935e (table TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]) successfully deleted
07:57:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.282475 18068 catalog_manager.cc:4841] TS 70561fbce6bc4946974c3a5262c3e3a9 (127.17.155.65:35791): tablet 0a3088219aac4f3096f34bc82d37935e (table TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]) successfully deleted
07:57:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.282702 18587 tablet_replica.cc:330] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: stopping tablet replica
07:57:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.282842 18587 raft_consensus.cc:2229] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 1 FOLLOWER]: Raft consensus shutting down.
07:57:06.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.282925 18587 raft_consensus.cc:2258] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794 [term 1 FOLLOWER]: Raft consensus is shut down!
07:57:06.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.283314 18587 ts_tablet_manager.cc:1905] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Deleting tablet data with delete state TABLET_DATA_DELETED
07:57:06.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.284847 18587 ts_tablet_manager.cc:1918] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: tablet deleted with delete type TABLET_DATA_DELETED: last-logged OpId 1.1
07:57:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.284921 18587 log.cc:1196] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Deleting WAL directory at /tmp/dist-test-taskOBAK8I/test-tmp/mini-kudu-cluster484184819414511142/ts-2/wal/wals/0a3088219aac4f3096f34bc82d37935e
07:57:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.285157 18587 ts_tablet_manager.cc:1939] T 0a3088219aac4f3096f34bc82d37935e P 3596644d64234224a1ffca6dc4b7b794: Deleting consensus metadata
07:57:06.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.285590 18070 catalog_manager.cc:4841] TS 3596644d64234224a1ffca6dc4b7b794 (127.17.155.67:36047): tablet 0a3088219aac4f3096f34bc82d37935e (table TestAuthnTokenReacquireOpen-table [id=2daf592dc66147e79ef8fe0c35048ed5]) successfully deleted
07:57:06.289 [DEBUG - main] (Connection.java:575) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] disconnecting while in state READY
07:57:06.290 [DEBUG - main] (Connection.java:575) [peer master-127.17.155.126:42209(127.17.155.126:42209)] disconnecting while in state READY
07:57:06.290 [DEBUG - main] (Connection.java:575) [peer master-127.17.155.126:42209(127.17.155.126:42209)] disconnecting while in state READY
07:57:06.291 [DEBUG - kudu-nio-0] (Connection.java:239) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] handling channelInactive
07:57:06.291 [DEBUG - kudu-nio-0] (Connection.java:709) [peer 70561fbce6bc4946974c3a5262c3e3a9(127.17.155.65:35791)] cleaning up while in state READY due to: connection closed
07:57:06.294 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2704) Releasing all remaining resources
07:57:06.300 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.17.155.126:42209(127.17.155.126:42209)] handling channelInactive
07:57:06.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.300769 18029 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOBAK8I/build/release/bin/kudu with pid 18146
07:57:06.301 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.17.155.126:42209(127.17.155.126:42209)] cleaning up while in state READY due to: connection closed
07:57:06.301 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.17.155.126:42209(127.17.155.126:42209)] handling channelInactive
07:57:06.301 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.17.155.126:42209(127.17.155.126:42209)] cleaning up while in state READY due to: connection closed
07:57:06.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.306716 18029 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOBAK8I/build/release/bin/kudu with pid 18280
07:57:06.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.311307 18029 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOBAK8I/build/release/bin/kudu with pid 18414
07:57:06.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:06.316119 18029 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskOBAK8I/build/release/bin/kudu with pid 18052
07:57:06.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:06Z chronyd exiting

Time: 4.939

OK (1 test)

