JUnit version 4.13.2
.15:57:23.868 [DEBUG - main] (TestNegotiationTLSv13.java:108) enabled TLS protocols: TLSv1.3 TLSv1.2 TLSv1.1 TLSv1
15:57:23.871 [DEBUG - main] (TestNegotiationTLSv13.java:110) supported TLS protocols: TLSv1.3 TLSv1.2 SSLv3 TLSv1.1 SSLv2Hello TLSv1
15:57:23.879 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskZ_lbqa/test-tmp
15:57:23.881 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
15:57:23.883 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskZ_lbqa/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
15:57:24.120 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 0
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423"
  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 {
  }
}

15:57:24.133 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:24.134 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

15:57:24.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.135893 13694 mini_oidc.cc:152] Starting JWKS server
15:57:24.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.138016 13694 webserver.cc:460] Webserver started at http://127.0.0.1:39095/ using document root <none> and password file <none>
15:57:24.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.138164 13694 mini_oidc.cc:189] Starting OIDC Discovery server
15:57:24.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.138399 13694 webserver.cc:460] Webserver started at http://127.0.0.1:40005/ using document root <none> and password file <none>
15:57:24.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
15:57:24.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z Disabled control of system clock
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.154934 13694 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/logs
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data/info.pb
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:24.156 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.95.190:39217
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.95.190
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.95.148:42947
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.95.190:39217
15:57:24.157 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39095/jwks.json
15:57:24.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
15:57:24.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
15:57:24.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.263294 13706 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:24.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.263561 13706 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:24.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.263602 13706 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268028 13706 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268105 13706 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268123 13706 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268138 13706 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268153 13706 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:24.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.268165 13706 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39095/jwks.json
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.273066 13706 master_runner.cc:386] Master server non-default flags:
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.95.148:42947
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:24.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.95.190:39217
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.95.190:39217
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39095/jwks.json
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
15:57:24.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data/info.pb
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.95.190
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13706
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/logs
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:24.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.274324 13706 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:24.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.275878 13706 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.284699 13712 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.284777 13706 server_base.cc:1034] running on GCE node
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.284701 13711 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:24.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.284722 13714 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:24.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.285976 13706 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
15:57:24.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:24.286069 13706 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
15:57:24.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.286103 13706 hybrid_clock.cc:648] HybridClock initialized: now 1783526244286099 us; error 0 us; skew 500 ppm
15:57:24.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.291302 13706 webserver.cc:460] Webserver started at http://127.13.95.190:42687/ using document root <none> and password file <none>
15:57:24.291 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.291855 13706 fs_manager.cc:359] Metadata directory not provided
15:57:24.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.291915 13706 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:24.292 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.292089 13706 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.294046 13706 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data/instance:
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "150bda1bbde0414e80586016bdbad364"
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-6b6n"
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.294605 13706 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal/instance:
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "150bda1bbde0414e80586016bdbad364"
15:57:24.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-6b6n"
15:57:24.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.298177 13706 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
15:57:24.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.300446 13719 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:24.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.301765 13706 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.301872 13706 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data,/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "150bda1bbde0414e80586016bdbad364"
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:24 on dist-test-slave-6b6n"
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.301949 13706 fs_report.cc:383] FS layout report
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/wal
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster3985560483273769423/master-0/data/data
15:57:24.302 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:24.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:24.319 [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
15:57:24.335 [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-taskZ_lbqa/build/debug/bin/kudu: process exited with non-zero status 1"
}

15:57:24.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:24Z chronyd exiting
15:57:24.375 [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-taskZ_lbqa/build/debug/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]
15:57:24.383 [INFO - main] (RandomUtils.java:49) Using random seed: 1783526244383
15:57:24.391 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
15:57:24.429 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
15:57:24.429 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskZ_lbqa/test-tmp
15:57:24.430 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
15:57:24.430 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskZ_lbqa/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
15:57:24.434 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526"
  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 {
  }
}

15:57:24.542 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:24.542 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

15:57:24.543 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.543488 13721 mini_oidc.cc:152] Starting JWKS server
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.545468 13721 webserver.cc:460] Webserver started at http://127.0.0.1:46665/ using document root <none> and password file <none>
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.545598 13721 mini_oidc.cc:189] Starting OIDC Discovery server
15:57:24.545 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:24.545819 13721 webserver.cc:460] Webserver started at http://127.0.0.1:36499/ using document root <none> and password file <none>
15:57:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
15:57:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/principal' for realm 'KRBTEST.COM',
15:57:24.582 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
15:57:24.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:24 dist-test-slave-6b6n krb5kdc[13731](info): setting up network...
15:57:24.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
15:57:24.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:24 dist-test-slave-6b6n krb5kdc[13731](info): set up 2 sockets
15:57:24.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:24 dist-test-slave-6b6n krb5kdc[13731](info): commencing operation
15:57:24.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
15:57:25.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.483071 13721 mini_kdc.cc:121] Time spent starting KDC: real 0.930s	user 0.001s	sys 0.004s
15:57:25.489 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
15:57:25.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:57:25.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
15:57:25.509 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
15:57:25.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:57:25.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
15:57:25.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
15:57:25.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:57:25.549 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
15:57:25.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
15:57:25.561 [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-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/test-user.keytab.
15:57:25.561 [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-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/test-user.keytab.
15:57:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:25 dist-test-slave-6b6n krb5kdc[13731](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526245, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:57:25.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
15:57:25.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:25Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
15:57:25.579 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:25Z Disabled control of system clock
15:57:25.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.13.102.126@KRBTEST.COM; defaulting to no policy
15:57:25.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:25.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.13.102.126@KRBTEST.COM" created.
15:57:25.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:25.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.126 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.126.keytab.
15:57:25.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.126 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.126.keytab.
15:57:25.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.603649 13721 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/logs
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data/info.pb
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.605 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.126:37565
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.126
15:57:25.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.126.keytab
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.126
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:25.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.102.126:37565
15:57:25.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:25.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46665/jwks.json
15:57:25.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
15:57:25.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
15:57:25.608 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:57:25.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.711300 13744 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:25.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.711553 13744 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:25.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.711596 13744 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715420 13744 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715463 13744 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715480 13744 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715497 13744 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715509 13744 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715523 13744 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
15:57:25.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.715535 13744 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:46665/jwks.json
15:57:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.720589 13744 master_runner.cc:386] Master server non-default flags:
15:57:25.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.13.102.126:37565
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.126.keytab
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.126
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
15:57:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.126:37565
15:57:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
15:57:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
15:57:25.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:46665/jwks.json
15:57:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
15:57:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:57:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:57:25.723 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data/info.pb
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.126
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13744
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.724 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/logs
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.721525 13744 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:25.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.722505 13744 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.731148 13750 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.731236 13744 server_base.cc:1034] running on GCE node
15:57:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.731138 13752 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:25.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.731138 13749 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:25.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.732211 13744 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:25.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.733222 13744 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:25.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.734385 13744 hybrid_clock.cc:648] HybridClock initialized: now 1783526245734362 us; error 43 us; skew 500 ppm
15:57:25.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:25 dist-test-slave-6b6n krb5kdc[13731](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526245, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.126@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:57:25.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.737011 13744 init.cc:377] Logged in from keytab as kudu/127.13.102.126@KRBTEST.COM (short username kudu)
15:57:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.737917 13744 webserver.cc:460] Webserver started at http://127.13.102.126:33845/ using document root <none> and password file <none>
15:57:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.738546 13744 fs_manager.cc:359] Metadata directory not provided
15:57:25.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.738618 13744 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:25.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.738862 13744 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.740787 13744 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data/instance:
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "52711c274dab47c38b3f65f532fb3016"
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-6b6n"
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.741382 13744 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal/instance:
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "52711c274dab47c38b3f65f532fb3016"
15:57:25.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-6b6n"
15:57:25.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.745122 13744 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.006s	sys 0.000s
15:57:25.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.747611 13759 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.748852 13744 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
15:57:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.748971 13744 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data,/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal
15:57:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "52711c274dab47c38b3f65f532fb3016"
15:57:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:25 on dist-test-slave-6b6n"
15:57:25.749 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.749079 13744 fs_report.cc:383] FS layout report
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data/data
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:25.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:25.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:25.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:25.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:25.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:25.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.781154 13744 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.784046 13744 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:25.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.784236 13744 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:25.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.791087 13744 rpc_server.cc:307] RPC server started. Bound to: 127.13.102.126:37565
15:57:25.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.791317 13811 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.102.126:37565 every 8 connection(s)
15:57:25.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.792225 13744 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/data/info.pb
15:57:25.795 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.795117 13812 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
15:57:25.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.799580 13721 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu as pid 13744
15:57:25.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.799748 13721 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/master-0/wal/instance
15:57:25.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.800017 13812 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: Bootstrap starting.
15:57:25.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.802356 13812 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: Neither blocks nor log segments found. Creating new log.
15:57:25.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.803140 13812 log.cc:824] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: Log is configured to *not* fsync() on all Append() calls
15:57:25.805 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.804941 13812 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: No bootstrap required, opened a new log
15:57:25.808 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.808548 13812 raft_consensus.cc:348] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } }
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.808756 13812 raft_consensus.cc:374] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.808802 13812 raft_consensus.cc:729] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 52711c274dab47c38b3f65f532fb3016, State: Initialized, Role: FOLLOWER
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.809271 13812 consensus_queue.cc:260] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [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: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } }
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.809448 13812 raft_consensus.cc:388] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.809510 13812 raft_consensus.cc:482] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
15:57:25.809 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.809598 13812 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 0 FOLLOWER]: Advancing to term 1
15:57:25.810 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.810617 13812 raft_consensus.cc:504] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } }
15:57:25.811 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.811195 13812 leader_election.cc:302] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [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: 52711c274dab47c38b3f65f532fb3016; no voters: 
15:57:25.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.811556 13812 leader_election.cc:288] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [CANDIDATE]: Term 1 election: Requested vote from peers 
15:57:25.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.812811 13812 sys_catalog.cc:564] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [sys.catalog]: configured and running, proceeding with master startup.
15:57:25.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.812865 13817 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 1 FOLLOWER]: Leader election won for term 1
15:57:25.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.813486 13817 raft_consensus.cc:686] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [term 1 LEADER]: Becoming Leader. State: Replica: 52711c274dab47c38b3f65f532fb3016, State: Running, Role: LEADER
15:57:25.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.814008 13817 consensus_queue.cc:237] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [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: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } }
15:57:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.816129 13818 sys_catalog.cc:455] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "52711c274dab47c38b3f65f532fb3016" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } } }
15:57:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.817416 13818 sys_catalog.cc:458] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [sys.catalog]: This master's current role is: LEADER
15:57:25.817 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:25 dist-test-slave-6b6n krb5kdc[13731](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526245, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.13.102.126@KRBTEST.COM
15:57:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.817441 13819 sys_catalog.cc:455] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 52711c274dab47c38b3f65f532fb3016. Latest consensus state: current_term: 1 leader_uuid: "52711c274dab47c38b3f65f532fb3016" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "52711c274dab47c38b3f65f532fb3016" member_type: VOTER last_known_addr { host: "127.13.102.126" port: 37565 } } }
15:57:25.818 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.818140 13819 sys_catalog.cc:458] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016 [sys.catalog]: This master's current role is: LEADER
15:57:25.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.819332 13831 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
15:57:25.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:25.819602 13831 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
15:57:25.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.819705 13833 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
15:57:25.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.820770 13833 catalog_manager.cc:1484] Initializing Kudu cluster ID...
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.823798 13816 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.803952 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:57782 (local address 127.13.102.126:37565)
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.804376 (+   424us) server_negotiation.cc:206] Beginning negotiation
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.804395 (+    19us) server_negotiation.cc:399] Waiting for connection header
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.804437 (+    42us) server_negotiation.cc:407] Connection header received
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.806218 (+  1781us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.806241 (+    23us) server_negotiation.cc:461] Received NEGOTIATE request from client
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.806664 (+   423us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.807012 (+   348us) server_negotiation.cc:226] Negotiated authn=SASL
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.808841 (+  1829us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.810751 (+  1910us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.812498 (+  1747us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.813226 (+   728us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.813375 (+   149us) 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
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.818510 (+  5135us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.818517 (+     7us) server_negotiation.cc:881] Received SASL_INITIATE request from client
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.818534 (+    17us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.818562 (+    28us) server_negotiation.cc:922] calling sasl_server_start()
15:57:25.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.820537 (+  1975us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821114 (+   577us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821120 (+     6us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821126 (+     6us) server_negotiation.cc:967] calling sasl_server_step()
15:57:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821232 (+   106us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:25.825 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821580 (+   348us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821583 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821585 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.821953 (+   368us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.822128 (+   175us) server_negotiation.cc:1035] Waiting for connection context
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.822692 (+   564us) server_negotiation.cc:299] Negotiation successful
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:25.822880 (+   188us) negotiation.cc:327] Negotiation complete: OK
15:57:25.826 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":285,"thread_start_us":89,"threads_started":1}
15:57:25.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.831861 13833 catalog_manager.cc:1347] Generated new cluster ID: a67db17c099248599f014dae46bfbb79
15:57:25.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.832274 13833 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
15:57:25.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.843410 13833 catalog_manager.cc:1370] Generated new certificate authority record
15:57:25.844 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.844412 13833 catalog_manager.cc:1504] Loading token signing keys...
15:57:25.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.854851 13833 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 52711c274dab47c38b3f65f532fb3016: Generated new TSK 0
15:57:25.855 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.855607 13833 catalog_manager.cc:1514] Initializing in-progress tserver states...
15:57:25.866 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.13.102.65@KRBTEST.COM; defaulting to no policy
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:25.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.13.102.65@KRBTEST.COM" created.
15:57:25.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:25.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.65 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.65.keytab.
15:57:25.880 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.65 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.65.keytab.
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:25.881059 13721 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/logs
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data/info.pb
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:25.881 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.65:0
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.65
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.65
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.65.keytab
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.65
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:25.882 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
15:57:25.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:57:26.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.015784 13838 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:26.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.016010 13838 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:26.016 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.016049 13838 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:26.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.019912 13838 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
15:57:26.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.019958 13838 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:26.020 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.020010 13838 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.102.65
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.024835 13838 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.65.keytab
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.65
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:26.025 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.65:0
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data/info.pb
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.65
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13838
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:26.026 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.65
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/logs
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.025875 13838 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:26.027 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.027098 13838 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.036003 13844 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.036021 13838 server_base.cc:1034] running on GCE node
15:57:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.036039 13843 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.036228 13846 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.036 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.036808 13838 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:26.037 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.037335 13838 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:26.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.038493 13838 hybrid_clock.cc:648] HybridClock initialized: now 1783526246038482 us; error 50 us; skew 500 ppm
15:57:26.040 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.65@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:57:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.040872 13838 init.cc:377] Logged in from keytab as kudu/127.13.102.65@KRBTEST.COM (short username kudu)
15:57:26.041 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.041656 13838 webserver.cc:460] Webserver started at http://127.13.102.65:40955/ using document root <none> and password file <none>
15:57:26.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.042119 13838 fs_manager.cc:359] Metadata directory not provided
15:57:26.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.042171 13838 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:26.042 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.042347 13838 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.044766 13838 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data/instance:
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ed97c1f9ecd94d71994beaa19b025706"
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.045392 13838 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal/instance:
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ed97c1f9ecd94d71994beaa19b025706"
15:57:26.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.049 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.049604 13838 fs_manager.cc:691] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
15:57:26.052 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.051847 13853 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.053068 13838 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.053172 13838 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data,/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "ed97c1f9ecd94d71994beaa19b025706"
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.053246 13838 fs_report.cc:383] FS layout report
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data/data
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:26.053 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:26.054 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:26.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.076011 13838 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:26.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.078790 13838 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:26.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.078943 13838 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:26.079 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.079471 13838 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:26.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.080273 13838 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:26.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.080318 13838 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:26.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.080356 13838 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:26.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.080370 13838 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:26.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.089349 13838 rpc_server.cc:307] RPC server started. Bound to: 127.13.102.65:38523
15:57:26.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.089371 13966 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.102.65:38523 every 8 connection(s)
15:57:26.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.090306 13838 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/data/info.pb
15:57:26.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.098841 13721 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu as pid 13838
15:57:26.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.098958 13721 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-0/wal/instance
15:57:26.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.65@KRBTEST.COM for kudu/127.13.102.126@KRBTEST.COM
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.105093 13816 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.092332 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.13.102.65:57897 (local address 127.13.102.126:37565)
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.092489 (+   157us) server_negotiation.cc:206] Beginning negotiation
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.092493 (+     4us) server_negotiation.cc:399] Waiting for connection header
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.093390 (+   897us) server_negotiation.cc:407] Connection header received
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.094865 (+  1475us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.094868 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.094928 (+    60us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.095002 (+    74us) server_negotiation.cc:226] Negotiated authn=SASL
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096228 (+  1226us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096763 (+   535us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.097893 (+  1130us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.098137 (+   244us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.098228 (+    91us) 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
15:57:26.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.101068 (+  2840us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.101072 (+     4us) server_negotiation.cc:881] Received SASL_INITIATE request from client
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.101075 (+     3us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.101103 (+    28us) server_negotiation.cc:922] calling sasl_server_start()
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.102784 (+  1681us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103462 (+   678us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103466 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103468 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103545 (+    77us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103920 (+   375us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103924 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103926 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104107 (+   181us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104259 (+   152us) server_negotiation.cc:1035] Waiting for connection context
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104825 (+   566us) server_negotiation.cc:299] Negotiation successful
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104926 (+   101us) negotiation.cc:327] Negotiation complete: OK
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":71}
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.106091 13969 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.092721 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.13.102.126:37565 (local address 127.13.102.65:57897)
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.093221 (+   500us) negotiation.cc:107] Waiting for socket to connect
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.093272 (+    51us) client_negotiation.cc:174] Beginning negotiation
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.094643 (+  1371us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.095209 (+   566us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.095217 (+     8us) client_negotiation.cc:394] Received NEGOTIATE response from server
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.095599 (+   382us) client_negotiation.cc:189] Negotiated authn=SASL
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096074 (+   475us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096091 (+    17us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096879 (+   788us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.106 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.096881 (+     2us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.097768 (+   887us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.097777 (+     9us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.098287 (+   510us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.098291 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.098490 (+   199us) 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
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.099180 (+   690us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
15:57:26.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.099233 (+    53us) client_negotiation.cc:656] calling sasl_client_start()
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.100819 (+  1586us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.102956 (+  2137us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.102963 (+     7us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.102981 (+    18us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103337 (+   356us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103653 (+   316us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103656 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103658 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.103803 (+   145us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104274 (+   471us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104281 (+     7us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104553 (+   272us) client_negotiation.cc:769] Sending connection context
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104771 (+   218us) client_negotiation.cc:240] Negotiation successful
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.104998 (+   227us) negotiation.cc:327] Negotiation complete: OK
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":271,"thread_start_us":126,"threads_started":1}
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.108134 13967 heartbeater.cc:347] Connected to a master server at 127.13.102.126:37565
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.108422 13967 heartbeater.cc:464] Registering TS with master...
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.13.102.66@KRBTEST.COM; defaulting to no policy
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.109066 13967 heartbeater.cc:511] Master 127.13.102.126:37565 requested a full tablet report, sending...
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.110991 13776 ts_manager.cc:194] Registered new tserver with Master: ed97c1f9ecd94d71994beaa19b025706 (127.13.102.65:38523)
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.13.102.66@KRBTEST.COM" created.
15:57:26.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.112447 13776 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.13.102.65@KRBTEST.COM'} at 127.13.102.65:57897
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.66 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.66.keytab.
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.66 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.66.keytab.
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.126593 13721 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:26.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/logs
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data/info.pb
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.66:0
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.66
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.66
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:26.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.66.keytab
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.66
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
15:57:26.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:57:26.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.235935 13972 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:26.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.236212 13972 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:26.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.236255 13972 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:26.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.240330 13972 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
15:57:26.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.240391 13972 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:26.240 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.240451 13972 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.102.66
15:57:26.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.245648 13972 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:26.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.66.keytab
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.66
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.66:0
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data/info.pb
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.66
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.13972
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.66
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/logs
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:26.246 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.246716 13972 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:26.247 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.247805 13972 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:26.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.257311 13977 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.257300 13978 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.257300 13980 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.257354 13972 server_base.cc:1034] running on GCE node
15:57:26.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.257845 13972 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:26.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.258484 13972 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:26.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.259652 13972 hybrid_clock.cc:648] HybridClock initialized: now 1783526246259616 us; error 47 us; skew 500 ppm
15:57:26.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.66@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:57:26.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.262320 13972 init.cc:377] Logged in from keytab as kudu/127.13.102.66@KRBTEST.COM (short username kudu)
15:57:26.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.263180 13972 webserver.cc:460] Webserver started at http://127.13.102.66:44809/ using document root <none> and password file <none>
15:57:26.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.263782 13972 fs_manager.cc:359] Metadata directory not provided
15:57:26.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.263844 13972 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:26.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.264007 13972 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.265796 13972 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data/instance:
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dedf401504574e1c925695344a25550f"
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.266289 13972 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal/instance:
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dedf401504574e1c925695344a25550f"
15:57:26.266 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.269776 13972 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.000s
15:57:26.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.271970 13987 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.273204 13972 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.273298 13972 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data,/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "dedf401504574e1c925695344a25550f"
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.273368 13972 fs_report.cc:383] FS layout report
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data/data
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:26.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:26.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.284248 13972 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:26.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.287452 13972 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:26.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.287606 13972 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:26.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.288130 13972 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:26.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.288920 13972 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:26.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.288964 13972 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:26.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.289003 13972 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:26.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.289017 13972 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:26.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.297289 13972 rpc_server.cc:307] RPC server started. Bound to: 127.13.102.66:41139
15:57:26.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.297315 14100 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.102.66:41139 every 8 connection(s)
15:57:26.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.298317 13972 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/data/info.pb
15:57:26.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.304080 13721 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu as pid 13972
15:57:26.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.304175 13721 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-1/wal/instance
15:57:26.309 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.66@KRBTEST.COM for kudu/127.13.102.126@KRBTEST.COM
15:57:26.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.13.102.67@KRBTEST.COM; defaulting to no policy
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.313386 13816 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.300300 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.13.102.66:47799 (local address 127.13.102.126:37565)
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.300429 (+   129us) server_negotiation.cc:206] Beginning negotiation
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.300432 (+     3us) server_negotiation.cc:399] Waiting for connection header
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.301550 (+  1118us) server_negotiation.cc:407] Connection header received
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303052 (+  1502us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303056 (+     4us) server_negotiation.cc:461] Received NEGOTIATE request from client
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303118 (+    62us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
15:57:26.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303211 (+    93us) server_negotiation.cc:226] Negotiated authn=SASL
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.304641 (+  1430us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.305197 (+   556us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306409 (+  1212us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306671 (+   262us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306757 (+    86us) 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
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.309653 (+  2896us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.309656 (+     3us) server_negotiation.cc:881] Received SASL_INITIATE request from client
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.309658 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
15:57:26.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.309681 (+    23us) server_negotiation.cc:922] calling sasl_server_start()
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.310990 (+  1309us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311601 (+   611us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311604 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311605 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311675 (+    70us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312131 (+   456us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312134 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312135 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312328 (+   193us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312423 (+    95us) server_negotiation.cc:1035] Waiting for connection context
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.313144 (+   721us) server_negotiation.cc:299] Negotiation successful
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.313238 (+    94us) negotiation.cc:327] Negotiation complete: OK
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":43}
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.314224 14103 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.300848 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.13.102.126:37565 (local address 127.13.102.66:47799)
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.301377 (+   529us) negotiation.cc:107] Waiting for socket to connect
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.301424 (+    47us) client_negotiation.cc:174] Beginning negotiation
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.302811 (+  1387us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303426 (+   615us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303434 (+     8us) client_negotiation.cc:394] Received NEGOTIATE response from server
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.303840 (+   406us) client_negotiation.cc:189] Negotiated authn=SASL
15:57:26.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.304425 (+   585us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.304447 (+    22us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.305351 (+   904us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.305354 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306282 (+   928us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306293 (+    11us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306809 (+   516us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.306814 (+     5us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.307017 (+   203us) 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
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.307723 (+   706us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.307743 (+    20us) client_negotiation.cc:656] calling sasl_client_start()
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.309426 (+  1683us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311133 (+  1707us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311138 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311157 (+    19us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311491 (+   334us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311785 (+   294us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311789 (+     4us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311791 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.311971 (+   180us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312466 (+   495us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312474 (+     8us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.312779 (+   305us) client_negotiation.cc:769] Sending connection context
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.313075 (+   296us) client_negotiation.cc:240] Negotiation successful
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.313311 (+   236us) negotiation.cc:327] Negotiation complete: OK
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":317,"thread_start_us":168,"threads_started":1}
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.13.102.67@KRBTEST.COM" created.
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.315609 14101 heartbeater.cc:347] Connected to a master server at 127.13.102.126:37565
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.315834 14101 heartbeater.cc:464] Registering TS with master...
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.316365 14101 heartbeater.cc:511] Master 127.13.102.126:37565 requested a full tablet report, sending...
15:57:26.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.317472 13776 ts_manager.cc:194] Registered new tserver with Master: dedf401504574e1c925695344a25550f (127.13.102.66:41139)
15:57:26.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.318216 13776 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.13.102.66@KRBTEST.COM'} at 127.13.102.66:47799
15:57:26.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
15:57:26.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.67 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.67.keytab.
15:57:26.328 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.13.102.67 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.67.keytab.
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.329305 13721 external_mini_cluster.cc:1326] Running /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/logs
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data/info.pb
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
15:57:26.329 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.67:0
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.67
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.67
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.67.keytab
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.67
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:26.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
15:57:26.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
15:57:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.434051 14106 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
15:57:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.434357 14106 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
15:57:26.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.434422 14106 flags.cc:425] Enabled unsafe flag: --never_fsync=true
15:57:26.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.438403 14106 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
15:57:26.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.438490 14106 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
15:57:26.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.438562 14106 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.13.102.67
15:57:26.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.443635 14106 tablet_server_runner.cc:78] Tablet server non-default flags:
15:57:26.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.13.102.84:45809
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/kudu_127.13.102.67.keytab
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.13.102.67
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.13.102.67:0
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data/info.pb
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.13.102.67
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.13.102.126:37565
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.14106
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
15:57:26.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.13.102.67
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/logs
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 15:02:02 UTC on ccycloud.quasar-faqpgf.root.comops.site
15:57:26.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4493841
15:57:26.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.444608 14106 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
15:57:26.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.445739 14106 file_cache.cc:493] Constructed file cache file cache with capacity 419430
15:57:26.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.456614 14111 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.456797 14106 server_base.cc:1034] running on GCE node
15:57:26.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.457006 14112 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.456645 14114 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
15:57:26.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.457557 14106 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
15:57:26.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.458246 14106 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
15:57:26.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.459416 14106 hybrid_clock.cc:648] HybridClock initialized: now 1783526246459396 us; error 65 us; skew 500 ppm
15:57:26.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.67@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
15:57:26.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.462162 14106 init.cc:377] Logged in from keytab as kudu/127.13.102.67@KRBTEST.COM (short username kudu)
15:57:26.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.463125 14106 webserver.cc:460] Webserver started at http://127.13.102.67:38979/ using document root <none> and password file <none>
15:57:26.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.463733 14106 fs_manager.cc:359] Metadata directory not provided
15:57:26.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.463822 14106 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
15:57:26.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.464059 14106 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.465969 14106 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data/instance:
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "666ec90723904c0e94a8b55d03c5a3fa"
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.466569 14106 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal/instance:
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "666ec90723904c0e94a8b55d03c5a3fa"
15:57:26.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.470072 14106 fs_manager.cc:691] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
15:57:26.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.472338 14121 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.473531 14106 fs_manager.cc:725] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.473639 14106 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data,/tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "666ec90723904c0e94a8b55d03c5a3fa"
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 15:57:26 on dist-test-slave-6b6n"
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.473739 14106 fs_report.cc:383] FS layout report
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal
15:57:26.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data/data
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
15:57:26.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
15:57:26.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.487668 14106 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
15:57:26.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.490947 14106 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
15:57:26.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.491134 14106 kserver.cc:163] Server-wide thread pool size limit: 3276
15:57:26.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.491847 14106 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
15:57:26.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.492734 14106 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
15:57:26.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.492781 14106 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
15:57:26.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.492834 14106 ts_tablet_manager.cc:610] Registered 0 tablets
15:57:26.493 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.492854 14106 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
15:57:26.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.501019 14106 rpc_server.cc:307] RPC server started. Bound to: 127.13.102.67:43477
15:57:26.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.501040 14234 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.13.102.67:43477 every 8 connection(s)
15:57:26.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.501995 14106 server_base.cc:1166] Dumped server information to /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/data/info.pb
15:57:26.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.504496 13721 external_mini_cluster.cc:1388] Started /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu as pid 14106
15:57:26.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.504608 13721 external_mini_cluster.cc:1402] Reading /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/ts-2/wal/instance
15:57:26.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 15:57:26 dist-test-slave-6b6n krb5kdc[13731](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783526246, etypes {rep=17 tkt=17 ses=17}, kudu/127.13.102.67@KRBTEST.COM for kudu/127.13.102.126@KRBTEST.COM
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.515516 13816 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.503757 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.13.102.67:48101 (local address 127.13.102.126:37565)
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.503916 (+   159us) server_negotiation.cc:206] Beginning negotiation
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.503921 (+     5us) server_negotiation.cc:399] Waiting for connection header
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.504837 (+   916us) server_negotiation.cc:407] Connection header received
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506416 (+  1579us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506419 (+     3us) server_negotiation.cc:461] Received NEGOTIATE request from client
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506491 (+    72us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506564 (+    73us) server_negotiation.cc:226] Negotiated authn=SASL
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.507840 (+  1276us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.508368 (+   528us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509471 (+  1103us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509690 (+   219us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509780 (+    90us) 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
15:57:26.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.512190 (+  2410us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.512193 (+     3us) server_negotiation.cc:881] Received SASL_INITIATE request from client
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.512195 (+     2us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.512228 (+    33us) server_negotiation.cc:922] calling sasl_server_start()
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513415 (+  1187us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513994 (+   579us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513998 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514000 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514071 (+    71us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514479 (+   408us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514482 (+     3us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514484 (+     2us) server_negotiation.cc:967] calling sasl_server_step()
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514654 (+   170us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514771 (+   117us) server_negotiation.cc:1035] Waiting for connection context
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.515269 (+   498us) server_negotiation.cc:299] Negotiation successful
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.515364 (+    95us) negotiation.cc:327] Negotiation complete: OK
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":59}
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.516191 14237 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.504164 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.13.102.126:37565 (local address 127.13.102.67:48101)
15:57:26.516 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.504657 (+   493us) negotiation.cc:107] Waiting for socket to connect
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.504725 (+    68us) client_negotiation.cc:174] Beginning negotiation
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506212 (+  1487us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506751 (+   539us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.506758 (+     7us) client_negotiation.cc:394] Received NEGOTIATE response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.507219 (+   461us) client_negotiation.cc:189] Negotiated authn=SASL
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.507700 (+   481us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.507713 (+    13us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.508482 (+   769us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.508486 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509353 (+   867us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509363 (+    10us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509823 (+   460us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509827 (+     4us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.509995 (+   168us) 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
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.510602 (+   607us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.510619 (+    17us) client_negotiation.cc:656] calling sasl_client_start()
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.511992 (+  1373us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513543 (+  1551us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513548 (+     5us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513563 (+    15us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.513878 (+   315us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514176 (+   298us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514179 (+     3us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514181 (+     2us) client_negotiation.cc:760] calling sasl_client_step()
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514324 (+   143us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514783 (+   459us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.514790 (+     7us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.515007 (+   217us) client_negotiation.cc:769] Sending connection context
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.515181 (+   174us) client_negotiation.cc:240] Negotiation successful
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 15:57:26.515385 (+   204us) negotiation.cc:327] Negotiation complete: OK
15:57:26.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":272,"thread_start_us":140,"threads_started":1}
15:57:26.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.517374 14235 heartbeater.cc:347] Connected to a master server at 127.13.102.126:37565
15:57:26.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.517604 14235 heartbeater.cc:464] Registering TS with master...
15:57:26.518 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.518141 14235 heartbeater.cc:511] Master 127.13.102.126:37565 requested a full tablet report, sending...
15:57:26.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.519155 13776 ts_manager.cc:194] Registered new tserver with Master: 666ec90723904c0e94a8b55d03c5a3fa (127.13.102.67:43477)
15:57:26.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.519711 13776 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.13.102.67@KRBTEST.COM'} at 127.13.102.67:48101
15:57:26.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.531607 13721 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
15:57:26.532 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
15:57:26.533 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

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

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

15:57:26.551 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.102.126"
      port: 37565
    }
    bound_http_address {
      host: "127.13.102.126"
      port: 33845
    }
  }
}

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

15:57:26.556 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.13.102.65"
      port: 38523
    }
    bound_http_address {
      host: "127.13.102.65"
      port: 40955
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.13.102.66"
      port: 41139
    }
    bound_http_address {
      host: "127.13.102.66"
      port: 44809
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.13.102.67"
      port: 43477
    }
    bound_http_address {
      host: "127.13.102.67"
      port: 38979
    }
  }
}

15:57:26.557 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
15:57:26.748 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-taskZ_lbqa/test-tmp/mini-kudu-cluster6359334372963762526/krb5kdc/krb5cc
15:57:26.757 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
15:57:26.769 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
15:57:26.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.771541 13721 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu with pid 13838
15:57:26.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.776520 13761 connection.cc:535] server connection from 127.13.102.65:57897 recv error: Network error: failed to read from TLS socket (remote: 127.13.102.65:57897): Connection reset by peer (error 104)
15:57:26.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.776571 13721 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu with pid 13972
15:57:26.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.780807 13762 connection.cc:535] server connection from 127.13.102.66:47799 recv error: Network error: failed to read from TLS socket (remote: 127.13.102.66:47799): Connection reset by peer (error 104)
15:57:26.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.780966 13721 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu with pid 14106
15:57:26.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.785408 13760 connection.cc:535] server connection from 127.13.102.67:48101 recv error: Network error: failed to read from TLS socket (remote: 127.13.102.67:48101): Connection reset by peer (error 104)
15:57:26.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 15:57:26.785601 13721 external_mini_cluster.cc:1595] Killing /tmp/dist-test-taskZ_lbqa/build/debug/bin/kudu with pid 13744
15:57:26.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 15:57:26.790192 13729 connection.cc:535] client connection to 127.13.102.126:37565 recv error: Network error: failed to read from TLS socket (remote: 127.13.102.126:37565): Connection reset by peer (error 104)
15:57:26.814 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T15:57:26Z chronyd exiting

Time: 3.296

OK (1 test)

