JUnit version 4.13.2
.06:16:04.787 [DEBUG - main] (TestNegotiationTLSv13.java:108) enabled TLS protocols: TLSv1.3 TLSv1.2 TLSv1.1 TLSv1
06:16:04.790 [DEBUG - main] (TestNegotiationTLSv13.java:110) supported TLS protocols: TLSv1.3 TLSv1.2 SSLv3 TLSv1.1 SSLv2Hello TLSv1
06:16:04.798 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskM_Ie06/test-tmp
06:16:04.801 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
06:16:04.803 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskM_Ie06/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
06:16:05.031 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 0
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709"
  extra_master_flags: "--time_source=system_unsync"
  extra_master_flags: "--rpc_tls_min_protocol=TLSv1.3"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

06:16:05.044 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:16:05.045 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:16:05.047 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.046662 12005 mini_oidc.cc:152] Starting JWKS server
06:16:05.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.047976 12005 webserver.cc:460] Webserver started at http://127.0.0.1:42639/ using document root <none> and password file <none>
06:16:05.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.048115 12005 mini_oidc.cc:189] Starting OIDC Discovery server
06:16:05.048 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.048342 12005 webserver.cc:460] Webserver started at http://127.0.0.1:40623/ using document root <none> and password file <none>
06:16:05.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:05Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
06:16:05.059 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:05Z Disabled control of system clock
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.062686 12005 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:05.063 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/logs
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data/info.pb
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:16:05.064 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:16:05.065 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:16:05.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:16:05.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.185.126:32891
06:16:05.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.185.126
06:16:05.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.185.84:36137
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.185.126:32891
06:16:05.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:16:05.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42639/jwks.json
06:16:05.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
06:16:05.068 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
06:16:05.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.147337 12029 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:16:05.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.147621 12029 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:16:05.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.147660 12029 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:16:05.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149049 12029 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:16:05.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149127 12029 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:16:05.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149149 12029 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:16:05.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149169 12029 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:16:05.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149186 12029 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:16:05.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.149204 12029 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:42639/jwks.json
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.150978 12029 master_runner.cc:386] Master server non-default flags:
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.185.84:36137
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data
06:16:05.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.185.126:32891
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.185.126:32891
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:16:05.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:42639/jwks.json
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data/info.pb
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.185.126
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:05.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12029
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/logs
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:16:05.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 05:25:39 UTC on ccycloud.quasar-efcgmt.root.comops.site
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581994
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.151270 12029 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:16:05.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.151688 12029 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:16:05.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.158053 12040 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
06:16:05.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.158064 12045 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
06:16:05.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.158041 12038 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
06:16:05.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.158526 12029 server_base.cc:1034] running on GCE node
06:16:05.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.158874 12029 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
06:16:05.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:05.158972 12029 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
06:16:05.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.159011 12029 hybrid_clock.cc:648] HybridClock initialized: now 1786515365159011 us; error 0 us; skew 500 ppm
06:16:05.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.160518 12029 webserver.cc:460] Webserver started at http://127.11.185.126:46087/ using document root <none> and password file <none>
06:16:05.160 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.160833 12029 fs_manager.cc:359] Metadata directory not provided
06:16:05.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.160923 12029 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:16:05.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.161082 12029 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:16:05.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.162199 12029 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data/instance:
06:16:05.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf36ab035eed4c6daa704cb06c992269"
06:16:05.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:05 on dist-test-slave-8hhm"
06:16:05.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.162616 12029 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal/instance:
06:16:05.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf36ab035eed4c6daa704cb06c992269"
06:16:05.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:05 on dist-test-slave-8hhm"
06:16:05.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.164292 12029 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.165177 12052 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.165396 12029 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.165480 12029 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data,/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "cf36ab035eed4c6daa704cb06c992269"
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:05 on dist-test-slave-8hhm"
06:16:05.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.165530 12029 fs_report.cc:383] FS layout report
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/wal
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster8121236488539421709/master-0/data/data
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:16:05.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:16:05.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:16:05.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:16:05.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:16:05.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:16:05.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:16:05.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Invalid argument: invalid minimum TLS protocol version (--rpc_tls_min_protocol): this platform does not support TLSv1.3
06:16:05.201 [DEBUG - main] (MiniKuduCluster.java:195) Response: error {
  code: RUNTIME_ERROR
  message: "failed to start masters: Unable to start Master at index 0: /tmp/dist-test-taskM_Ie06/build/release/bin/kudu: process exited with non-zero status 1"
}

06:16:05.223 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:05Z chronyd exiting
06:16:05.244 [INFO - main] (TestNegotiationTLSv13.java:145) server side doesn't support TLSv1.3
java.io.IOException: failed to start masters: Unable to start Master at index 0: /tmp/dist-test-taskM_Ie06/build/release/bin/kudu: process exited with non-zero status 1
	at org.apache.kudu.test.cluster.MiniKuduCluster.sendRequestToCluster(MiniKuduCluster.java:199) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.start(MiniKuduCluster.java:266) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.access$300(MiniKuduCluster.java:85) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster$MiniKuduClusterBuilder.build(MiniKuduCluster.java:883) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.client.TestNegotiationTLSv13.isTLSv13SupportedByServerSide(TestNegotiationTLSv13.java:133) [test/:?]
	at org.apache.kudu.client.TestNegotiationTLSv13.<init>(TestNegotiationTLSv13.java:157) [test/:?]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_362]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) [?:1.8.0_362]
	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [?:1.8.0_362]
	at java.lang.reflect.Constructor.newInstance(Constructor.java:423) [?:1.8.0_362]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:250) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:260) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$2.runReflectiveCall(BlockJUnit4ClassRunner.java:309) [junit-4.13.2.jar:4.13.2]
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.methodBlock(BlockJUnit4ClassRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36) [junit-4.13.2.jar:4.13.2]
06:16:05.252 [INFO - main] (RandomUtils.java:49) Using random seed: 1786515365252
06:16:05.259 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
06:16:05.302 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
06:16:05.302 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskM_Ie06/test-tmp
06:16:05.303 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
06:16:05.303 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskM_Ie06/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
06:16:05.305 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632"
  extra_master_flags: "--rpc-encryption=required"
  extra_master_flags: "--rpc_encrypt_loopback_connections"
  extra_master_flags: "--rpc-trace-negotiation"
  extra_tserver_flags: "--rpc-encryption=required"
  extra_tserver_flags: "--rpc_encrypt_loopback_connections"
  extra_tserver_flags: "--rpc-trace-negotiation"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

06:16:05.392 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:16:05.392 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

06:16:05.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.393139 12054 mini_oidc.cc:152] Starting JWKS server
06:16:05.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.394140 12054 webserver.cc:460] Webserver started at http://127.0.0.1:36049/ using document root <none> and password file <none>
06:16:05.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.394237 12054 mini_oidc.cc:189] Starting OIDC Discovery server
06:16:05.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:05.394398 12054 webserver.cc:460] Webserver started at http://127.0.0.1:36077/ using document root <none> and password file <none>
06:16:05.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
06:16:05.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/principal' for realm 'KRBTEST.COM',
06:16:05.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
06:16:05.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:05 dist-test-slave-8hhm krb5kdc[12070](info): setting up network...
06:16:05.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
06:16:05.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:05 dist-test-slave-8hhm krb5kdc[12070](info): set up 2 sockets
06:16:05.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:05 dist-test-slave-8hhm krb5kdc[12070](info): commencing operation
06:16:05.453 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
06:16:06.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.719946 12054 mini_kdc.cc:121] Time spent starting KDC: real 1.320s	user 0.005s	sys 0.001s
06:16:06.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
06:16:06.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:16:06.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
06:16:06.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
06:16:06.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:16:06.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
06:16:06.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
06:16:06.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:16:06.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
06:16:06.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
06:16:06.800 [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-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/test-user.keytab.
06:16:06.800 [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-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/test-user.keytab.
06:16:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:06 dist-test-slave-8hhm krb5kdc[12070](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515366, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:16:06.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
06:16:06.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:06Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
06:16:06.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:06Z Disabled control of system clock
06:16:06.830 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.11.197.190@KRBTEST.COM; defaulting to no policy
06:16:06.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:06.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.11.197.190@KRBTEST.COM" created.
06:16:06.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:06.847 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.190 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.190.keytab.
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.190 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.190.keytab.
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.848296 12054 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data
06:16:06.848 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:16:06.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:16:06.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:16:06.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:06.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:06.849 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/logs
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data/info.pb
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:06.850 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.190:36933
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.190
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.190.keytab
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.190
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:06.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.197.190:36933
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36049/jwks.json
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:16:06.852 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:16:06.853 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:16:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.939236 12091 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:16:06.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.939471 12091 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:16:06.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.939509 12091 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.940888 12091 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.940972 12091 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.941000 12091 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.941018 12091 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.941038 12091 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.941054 12091 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
06:16:06.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.941069 12091 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:36049/jwks.json
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.942921 12091 master_runner.cc:386] Master server non-default flags:
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal
06:16:06.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.11.197.190:36933
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.190.keytab
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.190
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:06.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
06:16:06.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.190:36933
06:16:06.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
06:16:06.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:16:06.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
06:16:06.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:36049/jwks.json
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data/info.pb
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.190
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:06.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12091
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/logs
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 05:25:39 UTC on ccycloud.quasar-efcgmt.root.comops.site
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581994
06:16:06.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.943209 12091 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:16:06.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.943480 12091 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:16:06.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.949939 12099 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
06:16:06.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.950001 12103 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
06:16:06.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.950088 12091 server_base.cc:1034] running on GCE node
06:16:06.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.950037 12106 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
06:16:06.950 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.950680 12091 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:16:06.951 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.951102 12091 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:16:06.952 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.952287 12091 hybrid_clock.cc:648] HybridClock initialized: now 1786515366952217 us; error 85 us; skew 500 ppm
06:16:06.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:06 dist-test-slave-8hhm krb5kdc[12070](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515366, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.190@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:16:06.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.957862 12091 init.cc:377] Logged in from keytab as kudu/127.11.197.190@KRBTEST.COM (short username kudu)
06:16:06.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.958457 12091 webserver.cc:460] Webserver started at http://127.11.197.190:44589/ using document root <none> and password file <none>
06:16:06.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.958762 12091 fs_manager.cc:359] Metadata directory not provided
06:16:06.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.958864 12091 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:16:06.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.959025 12091 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.960127 12091 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data/instance:
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "15301134baa14c288d56daea563afec4"
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:06 on dist-test-slave-8hhm"
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.960546 12091 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal/instance:
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "15301134baa14c288d56daea563afec4"
06:16:06.960 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:06 on dist-test-slave-8hhm"
06:16:06.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.962231 12091 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.963135 12117 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.963333 12091 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.963419 12091 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data,/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "15301134baa14c288d56daea563afec4"
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:06 on dist-test-slave-8hhm"
06:16:06.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.963490 12091 fs_report.cc:383] FS layout report
06:16:06.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:16:06.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal
06:16:06.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal
06:16:06.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data/data
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:16:06.965 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:16:06.977 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.977494 12091 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:16:06.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.980123 12091 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
06:16:06.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.980302 12091 kserver.cc:163] Server-wide thread pool size limit: 3276
06:16:06.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.984441 12091 rpc_server.cc:307] RPC server started. Bound to: 127.11.197.190:36933
06:16:06.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.984513 12206 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.197.190:36933 every 8 connection(s)
06:16:06.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.984929 12091 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/data/info.pb
06:16:06.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.985948 12208 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
06:16:06.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.986856 12054 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskM_Ie06/build/release/bin/kudu as pid 12091
06:16:06.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.987003 12054 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/master-0/wal/instance
06:16:06.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.988920 12208 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: Bootstrap starting.
06:16:06.989 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.989738 12208 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: Neither blocks nor log segments found. Creating new log.
06:16:06.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.990094 12208 log.cc:824] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: Log is configured to *not* fsync() on all Append() calls
06:16:06.990 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.990772 12208 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: No bootstrap required, opened a new log
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.992883 12208 raft_consensus.cc:348] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } }
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993034 12208 raft_consensus.cc:374] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993057 12208 raft_consensus.cc:729] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 15301134baa14c288d56daea563afec4, State: Initialized, Role: FOLLOWER
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993180 12208 consensus_queue.cc:260] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [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: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } }
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993304 12208 raft_consensus.cc:388] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
06:16:06.993 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993330 12208 raft_consensus.cc:482] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
06:16:06.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.993359 12208 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 0 FOLLOWER]: Advancing to term 1
06:16:06.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.994004 12208 raft_consensus.cc:504] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } }
06:16:06.994 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.994105 12208 leader_election.cc:302] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [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: 15301134baa14c288d56daea563afec4; no voters: 
06:16:06.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.994263 12208 leader_election.cc:288] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [CANDIDATE]: Term 1 election: Requested vote from peers 
06:16:06.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.994534 12208 sys_catalog.cc:564] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [sys.catalog]: configured and running, proceeding with master startup.
06:16:06.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.996335 12216 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 1 FOLLOWER]: Leader election won for term 1
06:16:06.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.996577 12234 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
06:16:06.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:06.997366 12234 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
06:16:06.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.997450 12216 raft_consensus.cc:686] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [term 1 LEADER]: Becoming Leader. State: Replica: 15301134baa14c288d56daea563afec4, State: Running, Role: LEADER
06:16:06.997 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.997562 12216 consensus_queue.cc:237] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [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: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } }
06:16:06.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.997864 12216 sys_catalog.cc:455] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "15301134baa14c288d56daea563afec4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } } }
06:16:06.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.997928 12216 sys_catalog.cc:458] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [sys.catalog]: This master's current role is: LEADER
06:16:06.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.998096 12216 sys_catalog.cc:455] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 15301134baa14c288d56daea563afec4. Latest consensus state: current_term: 1 leader_uuid: "15301134baa14c288d56daea563afec4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "15301134baa14c288d56daea563afec4" member_type: VOTER last_known_addr { host: "127.11.197.190" port: 36933 } } }
06:16:06.998 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.998154 12216 sys_catalog.cc:458] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4 [sys.catalog]: This master's current role is: LEADER
06:16:06.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:06.999249 12240 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
06:16:07.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.000324 12240 catalog_manager.cc:1484] Initializing Kudu cluster ID...
06:16:07.000 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:06 dist-test-slave-8hhm krb5kdc[12070](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515366, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.11.197.190@KRBTEST.COM
06:16:07.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.002418 12240 catalog_manager.cc:1347] Generated new cluster ID: a3260e0cf22743ac970464f9a1dd2f87
06:16:07.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.002467 12240 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
06:16:07.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.006546 12211 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.988703 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:41522 (local address 127.11.197.190:36933)
06:16:07.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.988920 (+   217us) server_negotiation.cc:206] Beginning negotiation
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.988929 (+     9us) server_negotiation.cc:399] Waiting for connection header
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.989152 (+   223us) server_negotiation.cc:407] Connection header received
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.990569 (+  1417us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.990576 (+     7us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.990623 (+    47us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.990747 (+   124us) server_negotiation.cc:226] Negotiated authn=SASL
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.992853 (+  2106us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.994633 (+  1780us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.996093 (+  1460us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.996870 (+   777us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:06.998292 (+  1422us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.001922 (+  3630us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.001927 (+     5us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.001928 (+     1us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.001955 (+    27us) server_negotiation.cc:922] calling sasl_server_start()
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.004232 (+  2277us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.004849 (+   617us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.004852 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.004852 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.004974 (+   122us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.005334 (+   360us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.005335 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.005336 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.005690 (+   354us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:16:07.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.005912 (+   222us) server_negotiation.cc:1035] Waiting for connection context
06:16:07.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.006193 (+   281us) server_negotiation.cc:299] Negotiation successful
06:16:07.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.006316 (+   123us) negotiation.cc:327] Negotiation complete: OK
06:16:07.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":173,"thread_start_us":100,"threads_started":1}
06:16:07.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.010514 12240 catalog_manager.cc:1370] Generated new certificate authority record
06:16:07.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.011462 12240 catalog_manager.cc:1504] Loading token signing keys...
06:16:07.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.020100 12240 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 15301134baa14c288d56daea563afec4: Generated new TSK 0
06:16:07.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.020319 12240 catalog_manager.cc:1514] Initializing in-progress tserver states...
06:16:07.035 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.11.197.129@KRBTEST.COM; defaulting to no policy
06:16:07.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.11.197.129@KRBTEST.COM" created.
06:16:07.055 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.129 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.129.keytab.
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.129 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.129.keytab.
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.056353 12054 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal
06:16:07.056 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/logs
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data/info.pb
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:16:07.057 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.129:0
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.129
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.129
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.129.keytab
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.129
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:16:07.058 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:16:07.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.146476 12246 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:16:07.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.146728 12246 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:16:07.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.146762 12246 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:16:07.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.148092 12246 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:16:07.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.148169 12246 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:16:07.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.148209 12246 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.197.129
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.149928 12246 tablet_server_runner.cc:78] Tablet server non-default flags:
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:16:07.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.129.keytab
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.129
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.129:0
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data/info.pb
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.129
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12246
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.129
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/logs
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:16:07.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 05:25:39 UTC on ccycloud.quasar-efcgmt.root.comops.site
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581994
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.150209 12246 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:16:07.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.150508 12246 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:16:07.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.156574 12261 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
06:16:07.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.156602 12254 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
06:16:07.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.156661 12256 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
06:16:07.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.157052 12246 server_base.cc:1034] running on GCE node
06:16:07.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.157683 12246 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:16:07.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.157965 12246 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:16:07.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.159134 12246 hybrid_clock.cc:648] HybridClock initialized: now 1786515367159115 us; error 36 us; skew 500 ppm
06:16:07.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.129@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:16:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.161913 12246 init.cc:377] Logged in from keytab as kudu/127.11.197.129@KRBTEST.COM (short username kudu)
06:16:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.162451 12246 webserver.cc:460] Webserver started at http://127.11.197.129:39793/ using document root <none> and password file <none>
06:16:07.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.162734 12246 fs_manager.cc:359] Metadata directory not provided
06:16:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.162833 12246 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:16:07.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.162974 12246 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:16:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.164081 12246 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data/instance:
06:16:07.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "72b2050b21194e0297fe5d08b98fffed"
06:16:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.164512 12246 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal/instance:
06:16:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "72b2050b21194e0297fe5d08b98fffed"
06:16:07.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.166253 12246 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.000s	sys 0.003s
06:16:07.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.167277 12272 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:16:07.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.167516 12246 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
06:16:07.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.167615 12246 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data,/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal
06:16:07.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "72b2050b21194e0297fe5d08b98fffed"
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.167686 12246 fs_report.cc:383] FS layout report
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data/data
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:16:07.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:16:07.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:16:07.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.197739 12246 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:16:07.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200026 12246 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
06:16:07.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200208 12246 kserver.cc:163] Server-wide thread pool size limit: 3276
06:16:07.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200507 12246 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:16:07.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200891 12246 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:16:07.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200956 12246 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:16:07.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.200994 12246 ts_tablet_manager.cc:610] Registered 0 tablets
06:16:07.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.201015 12246 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:16:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.207383 12246 rpc_server.cc:307] RPC server started. Bound to: 127.11.197.129:33347
06:16:07.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.207463 12460 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.197.129:33347 every 8 connection(s)
06:16:07.208 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.207849 12246 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/data/info.pb
06:16:07.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.214648 12054 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskM_Ie06/build/release/bin/kudu as pid 12246
06:16:07.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.129@KRBTEST.COM for kudu/127.11.197.190@KRBTEST.COM
06:16:07.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.214753 12054 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-0/wal/instance
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.218891 12211 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.208850 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.11.197.129:33351 (local address 127.11.197.190:36933)
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.208903 (+    53us) server_negotiation.cc:206] Beginning negotiation
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.208905 (+     2us) server_negotiation.cc:399] Waiting for connection header
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.209135 (+   230us) server_negotiation.cc:407] Connection header received
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210254 (+  1119us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210256 (+     2us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210268 (+    12us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210326 (+    58us) server_negotiation.cc:226] Negotiated authn=SASL
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210984 (+   658us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.211486 (+   502us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212567 (+  1081us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212769 (+   202us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212827 (+    58us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.215349 (+  2522us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:16:07.219 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.215350 (+     1us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.215351 (+     1us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.215358 (+     7us) server_negotiation.cc:922] calling sasl_server_start()
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217320 (+  1962us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217786 (+   466us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217788 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217788 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217858 (+    70us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218147 (+   289us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218149 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218149 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218272 (+   123us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218359 (+    87us) server_negotiation.cc:1035] Waiting for connection context
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218709 (+   350us) server_negotiation.cc:299] Negotiation successful
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218791 (+    82us) negotiation.cc:327] Negotiation complete: OK
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":28}
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.219058 12464 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.208726 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.11.197.190:36933 (local address 127.11.197.129:33351)
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.208964 (+   238us) negotiation.cc:107] Waiting for socket to connect
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.209016 (+    52us) client_negotiation.cc:174] Beginning negotiation
06:16:07.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210133 (+  1117us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210386 (+   253us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210390 (+     4us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210681 (+   291us) client_negotiation.cc:189] Negotiated authn=SASL
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210890 (+   209us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.210894 (+     4us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.211580 (+   686us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.211581 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212468 (+   887us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212471 (+     3us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212853 (+   382us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212854 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.212973 (+   119us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.213554 (+   581us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.213563 (+     9us) client_negotiation.cc:656] calling sasl_client_start()
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.215214 (+  1651us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217436 (+  2222us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217444 (+     8us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217446 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217687 (+   241us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217940 (+   253us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217941 (+     1us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.217941 (+     0us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218064 (+   123us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218356 (+   292us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218363 (+     7us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218518 (+   155us) client_negotiation.cc:769] Sending connection context
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218653 (+   135us) client_negotiation.cc:240] Negotiation successful
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.218764 (+   111us) negotiation.cc:327] Negotiation complete: OK
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":186,"thread_start_us":121,"threads_started":1}
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.220299 12461 heartbeater.cc:347] Connected to a master server at 127.11.197.190:36933
06:16:07.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.220399 12461 heartbeater.cc:464] Registering TS with master...
06:16:07.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.220613 12461 heartbeater.cc:511] Master 127.11.197.190:36933 requested a full tablet report, sending...
06:16:07.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.221302 12144 ts_manager.cc:194] Registered new tserver with Master: 72b2050b21194e0297fe5d08b98fffed (127.11.197.129:33347)
06:16:07.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.222266 12144 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.11.197.129@KRBTEST.COM'} at 127.11.197.129:33351
06:16:07.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.11.197.130@KRBTEST.COM; defaulting to no policy
06:16:07.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.11.197.130@KRBTEST.COM" created.
06:16:07.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.130 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.130.keytab.
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.130 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.130.keytab.
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.242362 12054 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/logs
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data/info.pb
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.130:0
06:16:07.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.130
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.130
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.130.keytab
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.130
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:16:07.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:16:07.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.328229 12470 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:16:07.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.328441 12470 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:16:07.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.328472 12470 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:16:07.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.329562 12470 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:16:07.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.329596 12470 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:16:07.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.329622 12470 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.197.130
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.331038 12470 tablet_server_runner.cc:78] Tablet server non-default flags:
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.130.keytab
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.130
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.130:0
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:16:07.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data/info.pb
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.130
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12470
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.130
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/logs
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 05:25:39 UTC on ccycloud.quasar-efcgmt.root.comops.site
06:16:07.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581994
06:16:07.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.331224 12470 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:16:07.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.331399 12470 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.336762 12470 server_base.cc:1034] running on GCE node
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.336717 12484 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
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.336728 12490 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
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.336738 12482 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
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.337262 12470 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:16:07.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.337529 12470 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:16:07.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.338662 12470 hybrid_clock.cc:648] HybridClock initialized: now 1786515367338637 us; error 45 us; skew 500 ppm
06:16:07.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.130@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:16:07.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.341351 12470 init.cc:377] Logged in from keytab as kudu/127.11.197.130@KRBTEST.COM (short username kudu)
06:16:07.341 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.341811 12470 webserver.cc:460] Webserver started at http://127.11.197.130:46617/ using document root <none> and password file <none>
06:16:07.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.342116 12470 fs_manager.cc:359] Metadata directory not provided
06:16:07.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.342196 12470 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:16:07.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.342334 12470 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:16:07.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.343357 12470 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data/instance:
06:16:07.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27906f0f8aba4496a02a5dcf9d2be24c"
06:16:07.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.343765 12470 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal/instance:
06:16:07.343 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27906f0f8aba4496a02a5dcf9d2be24c"
06:16:07.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.345250 12470 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.346191 12500 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.346351 12470 fs_manager.cc:725] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.001s
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.346437 12470 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data,/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "27906f0f8aba4496a02a5dcf9d2be24c"
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.346506 12470 fs_report.cc:383] FS layout report
06:16:07.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data/data
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:16:07.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:16:07.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.360736 12470 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:16:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.362890 12470 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
06:16:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363076 12470 kserver.cc:163] Server-wide thread pool size limit: 3276
06:16:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363368 12470 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:16:07.363 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363762 12470 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:16:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363822 12470 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:16:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363857 12470 ts_tablet_manager.cc:610] Registered 0 tablets
06:16:07.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.363873 12470 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:16:07.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.371076 12470 rpc_server.cc:307] RPC server started. Bound to: 127.11.197.130:38109
06:16:07.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.371117 12686 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.197.130:38109 every 8 connection(s)
06:16:07.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.371529 12470 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/data/info.pb
06:16:07.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.130@KRBTEST.COM for kudu/127.11.197.190@KRBTEST.COM
06:16:07.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.378736 12054 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskM_Ie06/build/release/bin/kudu as pid 12470
06:16:07.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.378844 12054 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-1/wal/instance
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.382114 12689 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372440 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.11.197.190:36933 (local address 127.11.197.130:41839)
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372612 (+   172us) negotiation.cc:107] Waiting for socket to connect
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372649 (+    37us) client_negotiation.cc:174] Beginning negotiation
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373721 (+  1072us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373994 (+   273us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373998 (+     4us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.374257 (+   259us) client_negotiation.cc:189] Negotiated authn=SASL
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.374448 (+   191us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.374452 (+     4us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.375159 (+   707us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.375160 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.375964 (+   804us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.375966 (+     2us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376371 (+   405us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376372 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376500 (+   128us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.377020 (+   520us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.377028 (+     8us) client_negotiation.cc:656] calling sasl_client_start()
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.378512 (+  1484us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380434 (+  1922us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380441 (+     7us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380443 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380786 (+   343us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381060 (+   274us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381061 (+     1us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381062 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381251 (+   189us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381631 (+   380us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381636 (+     5us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:16:07.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381763 (+   127us) client_negotiation.cc:769] Sending connection context
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381851 (+    88us) client_negotiation.cc:240] Negotiation successful
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381929 (+    78us) negotiation.cc:327] Negotiation complete: OK
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":135,"thread_start_us":92,"threads_started":1}
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.382130 12211 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372425 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.11.197.130:41839 (local address 127.11.197.190:36933)
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372469 (+    44us) server_negotiation.cc:206] Beginning negotiation
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372472 (+     3us) server_negotiation.cc:399] Waiting for connection header
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.372740 (+   268us) server_negotiation.cc:407] Connection header received
06:16:07.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373846 (+  1106us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373848 (+     2us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373862 (+    14us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.373914 (+    52us) server_negotiation.cc:226] Negotiated authn=SASL
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.374556 (+   642us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.375063 (+   507us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376078 (+  1015us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376278 (+   200us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.376351 (+    73us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.378741 (+  2390us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:16:07.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.378742 (+     1us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.378743 (+     1us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.378753 (+    10us) server_negotiation.cc:922] calling sasl_server_start()
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380326 (+  1573us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380888 (+   562us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380889 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380889 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.380947 (+    58us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381357 (+   410us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381359 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381359 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381543 (+   184us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381627 (+    84us) server_negotiation.cc:1035] Waiting for connection context
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.381930 (+   303us) server_negotiation.cc:299] Negotiation successful
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.382004 (+    74us) negotiation.cc:327] Negotiation complete: OK
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":19}
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.382707 12687 heartbeater.cc:347] Connected to a master server at 127.11.197.190:36933
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.382798 12687 heartbeater.cc:464] Registering TS with master...
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.382994 12687 heartbeater.cc:511] Master 127.11.197.190:36933 requested a full tablet report, sending...
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.384949 12144 ts_manager.cc:194] Registered new tserver with Master: 27906f0f8aba4496a02a5dcf9d2be24c (127.11.197.130:38109)
06:16:07.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.385495 12144 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.11.197.130@KRBTEST.COM'} at 127.11.197.130:41839
06:16:07.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.11.197.131@KRBTEST.COM; defaulting to no policy
06:16:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.11.197.131@KRBTEST.COM" created.
06:16:07.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
06:16:07.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.131 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.131.keytab.
06:16:07.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.11.197.131 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.131.keytab.
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.408169 12054 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskM_Ie06/build/release/bin/kudu
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/logs
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data/info.pb
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.131:0
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.131
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.131
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.131.keytab
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.131
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
06:16:07.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
06:16:07.410 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
06:16:07.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.492419 12695 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
06:16:07.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.492677 12695 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
06:16:07.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.492722 12695 flags.cc:425] Enabled unsafe flag: --never_fsync=true
06:16:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.493922 12695 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
06:16:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.493992 12695 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
06:16:07.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.494035 12695 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.11.197.131
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.495851 12695 tablet_server_runner.cc:78] Tablet server non-default flags:
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.11.197.148:43127
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kudu_127.11.197.131.keytab
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.11.197.131
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.11.197.131:0
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
06:16:07.496 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data/info.pb
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.11.197.131
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.11.197.190:36933
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.12695
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.11.197.131
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/logs
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
06:16:07.497 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 12 Aug 2026 05:25:39 UTC on ccycloud.quasar-efcgmt.root.comops.site
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4581994
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.496142 12695 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
06:16:07.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.496423 12695 file_cache.cc:493] Constructed file cache file cache with capacity 419430
06:16:07.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.503342 12704 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
06:16:07.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.503342 12711 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
06:16:07.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.503402 12706 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
06:16:07.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.503816 12695 server_base.cc:1034] running on GCE node
06:16:07.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.504295 12695 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
06:16:07.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.504649 12695 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
06:16:07.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.505823 12695 hybrid_clock.cc:648] HybridClock initialized: now 1786515367505811 us; error 29 us; skew 500 ppm
06:16:07.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.131@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
06:16:07.508 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.508723 12695 init.cc:377] Logged in from keytab as kudu/127.11.197.131@KRBTEST.COM (short username kudu)
06:16:07.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.509299 12695 webserver.cc:460] Webserver started at http://127.11.197.131:38815/ using document root <none> and password file <none>
06:16:07.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.509601 12695 fs_manager.cc:359] Metadata directory not provided
06:16:07.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.509684 12695 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
06:16:07.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.509826 12695 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.510874 12695 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data/instance:
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "487c0685f0524f85b24f862580fc1f40"
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.511304 12695 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal/instance:
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "487c0685f0524f85b24f862580fc1f40"
06:16:07.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.512821 12695 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
06:16:07.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.513769 12723 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.513996 12695 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.514125 12695 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data,/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "487c0685f0524f85b24f862580fc1f40"
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-12 06:16:07 on dist-test-slave-8hhm"
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.514211 12695 fs_report.cc:383] FS layout report
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data/data
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
06:16:07.514 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
06:16:07.522 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.522688 12695 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
06:16:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.524923 12695 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
06:16:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525107 12695 kserver.cc:163] Server-wide thread pool size limit: 3276
06:16:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525383 12695 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
06:16:07.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525758 12695 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
06:16:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525825 12695 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
06:16:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525859 12695 ts_tablet_manager.cc:610] Registered 0 tablets
06:16:07.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.525877 12695 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
06:16:07.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.532163 12695 rpc_server.cc:307] RPC server started. Bound to: 127.11.197.131:45179
06:16:07.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.532202 12914 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.11.197.131:45179 every 8 connection(s)
06:16:07.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.532629 12695 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/data/info.pb
06:16:07.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.533427 12054 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskM_Ie06/build/release/bin/kudu as pid 12695
06:16:07.533 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.533552 12054 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/ts-2/wal/instance
06:16:07.539 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Aug 12 06:16:07 dist-test-slave-8hhm krb5kdc[12070](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1786515367, etypes {rep=17 tkt=17 ses=17}, kudu/127.11.197.131@KRBTEST.COM for kudu/127.11.197.190@KRBTEST.COM
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.543107 12918 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533626 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.11.197.190:36933 (local address 127.11.197.131:36969)
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533814 (+   188us) negotiation.cc:107] Waiting for socket to connect
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533864 (+    50us) client_negotiation.cc:174] Beginning negotiation
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535194 (+  1330us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535424 (+   230us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535427 (+     3us) client_negotiation.cc:394] Received NEGOTIATE response from server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535695 (+   268us) client_negotiation.cc:189] Negotiated authn=SASL
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535893 (+   198us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535897 (+     4us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.536630 (+   733us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.536631 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537560 (+   929us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537563 (+     3us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537909 (+   346us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537910 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.538023 (+   113us) client_negotiation.cc:553] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.538628 (+   605us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.538636 (+     8us) client_negotiation.cc:656] calling sasl_client_start()
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.540056 (+  1420us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.541780 (+  1724us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.541787 (+     7us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.541788 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542022 (+   234us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542254 (+   232us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542254 (+     0us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542255 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542358 (+   103us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542610 (+   252us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542614 (+     4us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542738 (+   124us) client_negotiation.cc:769] Sending connection context
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542828 (+    90us) client_negotiation.cc:240] Negotiation successful
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542903 (+    75us) negotiation.cc:327] Negotiation complete: OK
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":142,"thread_start_us":103,"threads_started":1}
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.543143 12211 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533645 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.11.197.131:36969 (local address 127.11.197.190:36933)
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533694 (+    49us) server_negotiation.cc:206] Beginning negotiation
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533696 (+     2us) server_negotiation.cc:399] Waiting for connection header
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.533991 (+   295us) server_negotiation.cc:407] Connection header received
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535302 (+  1311us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535303 (+     1us) server_negotiation.cc:461] Received NEGOTIATE request from client
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535314 (+    11us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
06:16:07.544 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.535366 (+    52us) server_negotiation.cc:226] Negotiated authn=SASL
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.536017 (+   651us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.536535 (+   518us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537639 (+  1104us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537828 (+   189us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.537896 (+    68us) server_negotiation.cc:662] Negotiated TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 TLSv1.2 Kx=ECDH Au=RSA Enc=AESGCM(128) Mac=AEAD
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.540190 (+  2294us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.540191 (+     1us) server_negotiation.cc:881] Received SASL_INITIATE request from client
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.540192 (+     1us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.540202 (+    10us) server_negotiation.cc:922] calling sasl_server_start()
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.541671 (+  1469us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542117 (+   446us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542118 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542118 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542181 (+    63us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542432 (+   251us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542432 (+     0us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542432 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542543 (+   111us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.542599 (+    56us) server_negotiation.cc:1035] Waiting for connection context
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.543011 (+   412us) server_negotiation.cc:299] Negotiation successful
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0812 06:16:07.543077 (+    66us) negotiation.cc:327] Negotiation complete: OK
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":24}
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.543653 12916 heartbeater.cc:347] Connected to a master server at 127.11.197.190:36933
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.543736 12916 heartbeater.cc:464] Registering TS with master...
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.543883 12916 heartbeater.cc:511] Master 127.11.197.190:36933 requested a full tablet report, sending...
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.544312 12144 ts_manager.cc:194] Registered new tserver with Master: 487c0685f0524f85b24f862580fc1f40 (127.11.197.131:45179)
06:16:07.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.544651 12144 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.11.197.131@KRBTEST.COM'} at 127.11.197.131:36969
06:16:07.546 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.546582 12054 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
06:16:07.547 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
06:16:07.549 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

06:16:07.558 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_kdc_env_vars {
  env_vars {
    key: "KRB5CCNAME"
    value: "/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc"
  }
  env_vars {
    key: "KRB5_CONFIG"
    value: "/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5.conf"
  }
  env_vars {
    key: "KRB5_KDC_PROFILE"
    value: "/tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/kdc.conf"
  }
  env_vars {
    key: "KUDU_ENABLE_KRB5_REALM_FIX"
    value: "yes"
  }
}

06:16:07.559 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

06:16:07.568 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.197.190"
      port: 36933
    }
    bound_http_address {
      host: "127.11.197.190"
      port: 44589
    }
  }
}

06:16:07.572 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

06:16:07.574 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.11.197.129"
      port: 33347
    }
    bound_http_address {
      host: "127.11.197.129"
      port: 39793
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.11.197.130"
      port: 38109
    }
    bound_http_address {
      host: "127.11.197.130"
      port: 46617
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.11.197.131"
      port: 45179
    }
    bound_http_address {
      host: "127.11.197.131"
      port: 38815
    }
  }
}

06:16:07.574 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
06:16:07.793 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskM_Ie06/test-tmp/mini-kudu-cluster2748950138179335632/krb5kdc/krb5cc
06:16:07.803 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
06:16:07.816 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
06:16:07.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.819533 12054 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskM_Ie06/build/release/bin/kudu with pid 12246
06:16:07.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.840906 12123 connection.cc:535] server connection from 127.11.197.129:33351 recv error: Network error: failed to read from TLS socket (remote: 127.11.197.129:33351): Connection reset by peer (error 104)
06:16:07.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.841183 12054 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskM_Ie06/build/release/bin/kudu with pid 12470
06:16:07.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.858884 12121 connection.cc:535] server connection from 127.11.197.130:41839 recv error: Network error: failed to read from TLS socket (remote: 127.11.197.130:41839): Connection reset by peer (error 104)
06:16:07.859 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.859170 12054 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskM_Ie06/build/release/bin/kudu with pid 12695
06:16:07.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.879153 12121 connection.cc:535] server connection from 127.11.197.131:36969 recv error: Network error: failed to read from TLS socket (remote: 127.11.197.131:36969): Connection reset by peer (error 104)
06:16:07.879 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260812 06:16:07.879397 12054 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskM_Ie06/build/release/bin/kudu with pid 12091
06:16:07.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260812 06:16:07.890515 12067 connection.cc:535] client connection to 127.11.197.190:36933 recv error: Network error: failed to read from TLS socket (remote: 127.11.197.190:36933): Connection reset by peer (error 104)
06:16:07.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-12T06:16:07Z chronyd exiting

Time: 3.569

OK (1 test)

