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

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

07:57:02.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.262609 22275 mini_oidc.cc:152] Starting JWKS server
07:57:02.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.263857 22275 webserver.cc:460] Webserver started at http://127.0.0.1:34945/ using document root <none> and password file <none>
07:57:02.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.264020 22275 mini_oidc.cc:189] Starting OIDC Discovery server
07:57:02.264 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.264240 22275 webserver.cc:460] Webserver started at http://127.0.0.1:44711/ using document root <none> and password file <none>
07:57:02.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:02Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
07:57:02.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:02Z Disabled control of system clock
07:57:02.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.278582 22275 external_mini_cluster.cc:1326] Running /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:02.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/logs
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data/info.pb
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:02.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:02.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:02.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:02.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:02.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:02.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.192.254:44179
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.192.254
07:57:02.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.192.212:37657
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:02.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.192.254:44179
07:57:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34945/jwks.json
07:57:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
07:57:02.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3 with env {}
07:57:02.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.367662 22287 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:02.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.367952 22287 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:02.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.367988 22287 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:02.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369561 22287 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
07:57:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369629 22287 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369652 22287 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
07:57:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369671 22287 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
07:57:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369690 22287 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
07:57:02.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.369709 22287 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:34945/jwks.json
07:57:02.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.371482 22287 master_runner.cc:386] Master server non-default flags:
07:57:02.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:02.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.192.212:37657
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=system_unsync
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.192.254:44179
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:02.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.192.254:44179
07:57:02.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:02.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:02.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:02.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34945/jwks.json
07:57:02.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_tls_min_protocol=TLSv1.3
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data/info.pb
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.192.254
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22287
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:02.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/logs
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:02.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:02.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.371798 22287 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:02.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.372186 22287 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:02.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.379487 22292 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.379554 22295 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.379704 22287 server_base.cc:1034] running on GCE node
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.379554 22293 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.380056 22287 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:02.380124 22287 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
07:57:02.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.380163 22287 hybrid_clock.cc:648] HybridClock initialized: now 1783497422380163 us; error 0 us; skew 500 ppm
07:57:02.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.385653 22287 webserver.cc:460] Webserver started at http://127.21.192.254:35093/ using document root <none> and password file <none>
07:57:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.385982 22287 fs_manager.cc:359] Metadata directory not provided
07:57:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.386044 22287 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:02.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.386188 22287 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.387686 22287 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data/instance:
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42e10c2b0434418b8a07c5a18e462901"
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:02 on dist-test-slave-6hjl"
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.388170 22287 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal/instance:
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42e10c2b0434418b8a07c5a18e462901"
07:57:02.388 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:02 on dist-test-slave-6hjl"
07:57:02.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.390156 22287 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.004s	sys 0.000s
07:57:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.391215 22300 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.391507 22287 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
07:57:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.391600 22287 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data,/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal
07:57:02.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "42e10c2b0434418b8a07c5a18e462901"
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:02 on dist-test-slave-6hjl"
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.391659 22287 fs_report.cc:383] FS layout report
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/wal
07:57:02.392 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster6922052994733150683/master-0/data/data
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:02.393 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:02.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:02.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:02.406 [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
07:57:02.418 [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-task4iPoWg/build/release/bin/kudu: process exited with non-zero status 1"
}

07:57:02.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:02Z chronyd exiting
07:57:02.458 [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-task4iPoWg/build/release/bin/kudu: process exited with non-zero status 1
	at org.apache.kudu.test.cluster.MiniKuduCluster.sendRequestToCluster(MiniKuduCluster.java:199) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.start(MiniKuduCluster.java:266) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster.access$300(MiniKuduCluster.java:85) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.test.cluster.MiniKuduCluster$MiniKuduClusterBuilder.build(MiniKuduCluster.java:883) ~[kudu-test-utils-1.18.0-SNAPSHOT-unshaded.jar:1.18.0-SNAPSHOT]
	at org.apache.kudu.client.TestNegotiationTLSv13.isTLSv13SupportedByServerSide(TestNegotiationTLSv13.java:133) [test/:?]
	at org.apache.kudu.client.TestNegotiationTLSv13.<init>(TestNegotiationTLSv13.java:157) [test/:?]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_362]
	at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) [?:1.8.0_362]
	at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [?:1.8.0_362]
	at java.lang.reflect.Constructor.newInstance(Constructor.java:423) [?:1.8.0_362]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:250) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.createTest(BlockJUnit4ClassRunner.java:260) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$2.runReflectiveCall(BlockJUnit4ClassRunner.java:309) [junit-4.13.2.jar:4.13.2]
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:12) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.methodBlock(BlockJUnit4ClassRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:128) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.Suite.runChild(Suite.java:27) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306) [junit-4.13.2.jar:4.13.2]
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77) [junit-4.13.2.jar:4.13.2]
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36) [junit-4.13.2.jar:4.13.2]
07:57:02.467 [INFO - main] (RandomUtils.java:49) Using random seed: 1783497422467
07:57:02.476 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
07:57:02.522 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
07:57:02.522 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task4iPoWg/test-tmp
07:57:02.523 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
07:57:02.523 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task4iPoWg/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
07:57:02.526 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 1
  num_tservers: 3
  enable_kerberos: true
  cluster_root: "/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179"
  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 {
  }
}

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

07:57:02.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.612223 22302 mini_oidc.cc:152] Starting JWKS server
07:57:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.613186 22302 webserver.cc:460] Webserver started at http://127.0.0.1:39831/ using document root <none> and password file <none>
07:57:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.613284 22302 mini_oidc.cc:189] Starting OIDC Discovery server
07:57:02.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:02.613507 22302 webserver.cc:460] Webserver started at http://127.0.0.1:42887/ using document root <none> and password file <none>
07:57:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Loading random data
07:57:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Initializing database '/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/principal' for realm 'KRBTEST.COM',
07:57:02.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master key name 'K/M@KRBTEST.COM'
07:57:02.673 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-6hjl krb5kdc[22312](info): setting up network...
07:57:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: setsockopt(10,IPV6_V6ONLY,1) worked
07:57:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-6hjl krb5kdc[22312](info): set up 2 sockets
07:57:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:02 dist-test-slave-6hjl krb5kdc[22312](info): commencing operation
07:57:02.674 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) krb5kdc: starting...
07:57:03.687 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.686646 22302 mini_kdc.cc:121] Time spent starting KDC: real 1.068s	user 0.002s	sys 0.004s
07:57:03.694 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-admin@KRBTEST.COM; defaulting to no policy
07:57:03.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-admin@KRBTEST.COM" created.
07:57:03.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for test-user@KRBTEST.COM; defaulting to no policy
07:57:03.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "test-user@KRBTEST.COM" created.
07:57:03.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for joe-interloper@KRBTEST.COM; defaulting to no policy
07:57:03.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "joe-interloper@KRBTEST.COM" created.
07:57:03.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal slave/admin@KRBTEST.COM with password.
07:57:03.770 [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-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/test-user.keytab.
07:57:03.770 [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-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/test-user.keytab.
07:57:03.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-6hjl krb5kdc[22312](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Password for test-admin@KRBTEST.COM: 
07:57:03.790 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:03Z chronyd version 3.5 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -SECHASH -IPV6 +DEBUG)
07:57:03.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:03Z Disabled control of system clock
07:57:03.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.199.190@KRBTEST.COM; defaulting to no policy
07:57:03.802 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.199.190@KRBTEST.COM" created.
07:57:03.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:03.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.190 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.190.keytab.
07:57:03.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.190 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.190.keytab.
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.820813 22302 external_mini_cluster.cc:1326] Running /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:03.821 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/logs
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data/info.pb
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.190:33235
07:57:03.822 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.190
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.190.keytab
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.190
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.199.190:33235
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39831/jwks.json
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
07:57:03.823 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
07:57:03.824 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.908095 22325 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:03.908 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.908406 22325 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:03.909 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.908448 22325 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910063 22325 flags.cc:425] Enabled experimental flag: --ipki_ca_key_size=768
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910143 22325 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910167 22325 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910187 22325 flags.cc:425] Enabled experimental flag: --tsk_num_rsa_bits=512
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910214 22325 flags.cc:425] Enabled experimental flag: --rpc_reuseport=true
07:57:03.910 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910233 22325 flags.cc:425] Enabled experimental flag: --enable_jwt_token_auth=true
07:57:03.911 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.910251 22325 flags.cc:425] Enabled experimental flag: --jwks_url=http://localhost:39831/jwks.json
07:57:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.912323 22325 master_runner.cc:386] Master server non-default flags:
07:57:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:03.912 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.21.199.190:33235
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.190.keytab
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.190
07:57:03.913 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.190:33235
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
07:57:03.914 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39831/jwks.json
07:57:03.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:03.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
07:57:03.915 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data/info.pb
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.190
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22325
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:03.916 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/logs
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.912649 22325 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:03.917 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.912932 22325 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:03.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.920661 22330 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:03.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.920667 22331 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:03.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.921614 22325 server_base.cc:1034] running on GCE node
07:57:03.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.920714 22333 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:03.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.922116 22325 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:03.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.922487 22325 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:03.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.923669 22325 hybrid_clock.cc:648] HybridClock initialized: now 1783497423923642 us; error 46 us; skew 500 ppm
07:57:03.926 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-6hjl krb5kdc[22312](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.190@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:03.927 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.927382 22325 init.cc:377] Logged in from keytab as kudu/127.21.199.190@KRBTEST.COM (short username kudu)
07:57:03.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.928036 22325 webserver.cc:460] Webserver started at http://127.21.199.190:38427/ using document root <none> and password file <none>
07:57:03.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.928369 22325 fs_manager.cc:359] Metadata directory not provided
07:57:03.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.928453 22325 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:03.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.928601 22325 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:03.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.930164 22325 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data/instance:
07:57:03.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "68e1b43dd52f411eafad7a7aaf37f8cc"
07:57:03.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-6hjl"
07:57:03.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.930632 22325 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal/instance:
07:57:03.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "68e1b43dd52f411eafad7a7aaf37f8cc"
07:57:03.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-6hjl"
07:57:03.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.932325 22325 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.001s
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.933246 22340 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.933511 22325 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.933609 22325 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data,/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal
07:57:03.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "68e1b43dd52f411eafad7a7aaf37f8cc"
07:57:03.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:03 on dist-test-slave-6hjl"
07:57:03.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.933701 22325 fs_report.cc:383] FS layout report
07:57:03.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:03.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal
07:57:03.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal
07:57:03.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data/data
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:03.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:03.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:03.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.948503 22325 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.954825 22325 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
07:57:03.955 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.955406 22325 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.968953 22325 rpc_server.cc:307] RPC server started. Bound to: 127.21.199.190:33235
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.969043 22392 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.199.190:33235 every 8 connection(s)
07:57:03.969 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.969516 22325 server_base.cc:1166] Dumped server information to /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/data/info.pb
07:57:03.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.970606 22393 data_dirs.cc:395] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
07:57:03.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.973148 22393 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: Bootstrap starting.
07:57:03.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.974335 22393 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: Neither blocks nor log segments found. Creating new log.
07:57:03.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.974602 22393 log.cc:824] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: Log is configured to *not* fsync() on all Append() calls
07:57:03.976 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.975503 22393 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: No bootstrap required, opened a new log
07:57:03.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978166 22393 raft_consensus.cc:348] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } }
07:57:03.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978356 22393 raft_consensus.cc:374] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
07:57:03.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978381 22393 raft_consensus.cc:729] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 68e1b43dd52f411eafad7a7aaf37f8cc, State: Initialized, Role: FOLLOWER
07:57:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978528 22393 consensus_queue.cc:260] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [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: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } }
07:57:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978595 22393 raft_consensus.cc:388] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
07:57:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978616 22393 raft_consensus.cc:482] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
07:57:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.978644 22393 raft_consensus.cc:3037] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 0 FOLLOWER]: Advancing to term 1
07:57:03.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979724 22302 external_mini_cluster.cc:1388] Started /tmp/dist-test-task4iPoWg/build/release/bin/kudu as pid 22325
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979875 22302 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/master-0/wal/instance
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979843 22393 raft_consensus.cc:504] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } }
07:57:03.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.979974 22393 leader_election.cc:302] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [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: 68e1b43dd52f411eafad7a7aaf37f8cc; no voters: 
07:57:03.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.980361 22393 leader_election.cc:288] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [CANDIDATE]: Term 1 election: Requested vote from peers 
07:57:03.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.980652 22393 sys_catalog.cc:564] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [sys.catalog]: configured and running, proceeding with master startup.
07:57:03.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.982654 22397 raft_consensus.cc:2781] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 1 FOLLOWER]: Leader election won for term 1
07:57:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.983069 22397 raft_consensus.cc:686] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [term 1 LEADER]: Becoming Leader. State: Replica: 68e1b43dd52f411eafad7a7aaf37f8cc, State: Running, Role: LEADER
07:57:03.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.983371 22397 consensus_queue.cc:237] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [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: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } }
07:57:03.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.984709 22396 sys_catalog.cc:455] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } } }
07:57:03.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.985112 22396 sys_catalog.cc:458] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [sys.catalog]: This master's current role is: LEADER
07:57:03.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.985152 22412 catalog_manager.cc:1558] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
07:57:03.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:03.985735 22412 catalog_manager.cc:873] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
07:57:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.984534 22397 sys_catalog.cc:455] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [sys.catalog]: SysCatalogTable state changed. Reason: New leader 68e1b43dd52f411eafad7a7aaf37f8cc. Latest consensus state: current_term: 1 leader_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "68e1b43dd52f411eafad7a7aaf37f8cc" member_type: VOTER last_known_addr { host: "127.21.199.190" port: 33235 } } }
07:57:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.986195 22397 sys_catalog.cc:458] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc [sys.catalog]: This master's current role is: LEADER
07:57:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.986219 22414 catalog_manager.cc:1475] Loading table and tablet metadata into memory...
07:57:03.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.986735 22414 catalog_manager.cc:1484] Initializing Kudu cluster ID...
07:57:03.991 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.991336 22414 catalog_manager.cc:1347] Generated new cluster ID: acf3dad2b2864bdd877967995f5bec16
07:57:03.992 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:03.991420 22414 catalog_manager.cc:1495] Initializing Kudu internal certificate authority...
07:57:03.999 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:03 dist-test-slave-6hjl krb5kdc[22312](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497423, etypes {rep=17 tkt=17 ses=17}, test-admin@KRBTEST.COM for kudu/127.21.199.190@KRBTEST.COM
07:57:04.001 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.000952 22414 catalog_manager.cc:1370] Generated new certificate authority record
07:57:04.002 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.002259 22414 catalog_manager.cc:1504] Loading token signing keys...
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.006057 22410 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.983348 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.0.0.1:47750 (local address 127.21.199.190:33235)
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.984883 (+  1535us) server_negotiation.cc:206] Beginning negotiation
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.984894 (+    11us) server_negotiation.cc:399] Waiting for connection header
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.984934 (+    40us) server_negotiation.cc:407] Connection header received
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.985079 (+   145us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.985087 (+     8us) server_negotiation.cc:461] Received NEGOTIATE request from client
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.985157 (+    70us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
07:57:04.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.987689 (+  2532us) server_negotiation.cc:226] Negotiated authn=SASL
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.988052 (+   363us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.991484 (+  3432us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.993077 (+  1593us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.994039 (+   962us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.994163 (+   124us) 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
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.999727 (+  5564us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
07:57:04.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.999732 (+     5us) server_negotiation.cc:881] Received SASL_INITIATE request from client
07:57:04.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.999733 (+     1us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
07:57:04.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:03.999748 (+    15us) server_negotiation.cc:922] calling sasl_server_start()
07:57:04.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.002596 (+  2848us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.003533 (+   937us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.003537 (+     4us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.003537 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.003663 (+   126us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.004240 (+   577us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.004241 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.004242 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.004580 (+   338us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.004731 (+   151us) server_negotiation.cc:1035] Waiting for connection context
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.005645 (+   914us) server_negotiation.cc:299] Negotiation successful
07:57:04.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.005764 (+   119us) negotiation.cc:327] Negotiation complete: OK
07:57:04.014 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":1473,"thread_start_us":80,"threads_started":1}
07:57:04.022 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.022277 22414 catalog_manager.cc:5868] T 00000000000000000000000000000000 P 68e1b43dd52f411eafad7a7aaf37f8cc: Generated new TSK 0
07:57:04.023 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.022570 22414 catalog_manager.cc:1514] Initializing in-progress tserver states...
07:57:04.038 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.199.129@KRBTEST.COM; defaulting to no policy
07:57:04.044 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.045 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.199.129@KRBTEST.COM" created.
07:57:04.072 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.129 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.129.keytab.
07:57:04.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.129 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.129.keytab.
07:57:04.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.073345 22302 external_mini_cluster.cc:1326] Running /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.073 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/logs
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data/info.pb
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:04.074 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:04.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.129:0
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.129
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.129
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.129.keytab
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.129
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
07:57:04.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
07:57:04.077 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:04.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.169201 22419 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:04.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.169420 22419 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:04.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.169471 22419 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:04.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.170593 22419 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
07:57:04.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.170634 22419 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:04.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.170660 22419 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.199.129
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.172132 22419 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data
07:57:04.172 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.129.keytab
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.129
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.129:0
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data/info.pb
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.129
07:57:04.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22419
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.129
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/logs
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:04.174 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:04.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:04.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.172399 22419 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:04.175 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.172673 22419 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.179646 22424 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.179666 22427 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.180039 22419 server_base.cc:1034] running on GCE node
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.179628 22425 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.180404 22419 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:04.180 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.180732 22419 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:04.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.181977 22419 hybrid_clock.cc:648] HybridClock initialized: now 1783497424181941 us; error 51 us; skew 500 ppm
07:57:04.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.129@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:04.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.185180 22419 init.cc:377] Logged in from keytab as kudu/127.21.199.129@KRBTEST.COM (short username kudu)
07:57:04.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.185787 22419 webserver.cc:460] Webserver started at http://127.21.199.129:43175/ using document root <none> and password file <none>
07:57:04.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.186077 22419 fs_manager.cc:359] Metadata directory not provided
07:57:04.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.186167 22419 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:04.186 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.186311 22419 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.187520 22419 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data/instance:
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b871404c3f6c4f98b333ab7bb49b69ba"
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.187973 22419 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal/instance:
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b871404c3f6c4f98b333ab7bb49b69ba"
07:57:04.188 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.189817 22419 fs_manager.cc:691] Time spent creating directory manager: real 0.002s	user 0.004s	sys 0.000s
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.190965 22434 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.191232 22419 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.191332 22419 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data,/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b871404c3f6c4f98b333ab7bb49b69ba"
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.191408 22419 fs_report.cc:383] FS layout report
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal
07:57:04.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data/data
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:04.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:04.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.232056 22419 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:04.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.234784 22419 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
07:57:04.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235069 22419 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:04.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235384 22419 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:04.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235811 22419 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:04.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235877 22419 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:04.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235914 22419 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:04.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.235944 22419 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:04.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.243363 22419 rpc_server.cc:307] RPC server started. Bound to: 127.21.199.129:41339
07:57:04.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.243399 22547 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.199.129:41339 every 8 connection(s)
07:57:04.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.243748 22419 server_base.cc:1166] Dumped server information to /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/data/info.pb
07:57:04.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.249704 22302 external_mini_cluster.cc:1388] Started /tmp/dist-test-task4iPoWg/build/release/bin/kudu as pid 22419
07:57:04.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.249831 22302 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-0/wal/instance
07:57:04.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.129@KRBTEST.COM for kudu/127.21.199.190@KRBTEST.COM
07:57:04.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.254685 22410 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244568 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.199.129:38751 (local address 127.21.199.190:33235)
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244640 (+    72us) server_negotiation.cc:206] Beginning negotiation
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244642 (+     2us) server_negotiation.cc:399] Waiting for connection header
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244877 (+   235us) server_negotiation.cc:407] Connection header received
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246057 (+  1180us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246059 (+     2us) server_negotiation.cc:461] Received NEGOTIATE request from client
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246072 (+    13us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246127 (+    55us) server_negotiation.cc:226] Negotiated authn=SASL
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246815 (+   688us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.247342 (+   527us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248376 (+  1034us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248585 (+   209us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248673 (+    88us) 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
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.251187 (+  2514us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.251189 (+     2us) server_negotiation.cc:881] Received SASL_INITIATE request from client
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.251189 (+     0us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
07:57:04.255 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.251198 (+     9us) server_negotiation.cc:922] calling sasl_server_start()
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.252710 (+  1512us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253334 (+   624us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253336 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253336 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253403 (+    67us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253822 (+   419us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253823 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253823 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253978 (+   155us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254043 (+    65us) server_negotiation.cc:1035] Waiting for connection context
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254510 (+   467us) server_negotiation.cc:299] Negotiation successful
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254590 (+    80us) negotiation.cc:327] Negotiation complete: OK
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":40}
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.254858 22550 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244566 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.199.190:33235 (local address 127.21.199.129:38751)
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244741 (+   175us) negotiation.cc:107] Waiting for socket to connect
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.244782 (+    41us) client_negotiation.cc:174] Beginning negotiation
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.245927 (+  1145us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246214 (+   287us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246219 (+     5us) client_negotiation.cc:394] Received NEGOTIATE response from server
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246494 (+   275us) client_negotiation.cc:189] Negotiated authn=SASL
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246710 (+   216us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.256 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.246714 (+     4us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.247444 (+   730us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.247445 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248277 (+   832us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248279 (+     2us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248683 (+   404us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248684 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.257 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.248818 (+   134us) 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
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.249489 (+   671us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.249505 (+    16us) client_negotiation.cc:656] calling sasl_client_start()
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.251050 (+  1545us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.252835 (+  1785us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.252845 (+    10us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.252848 (+     3us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253207 (+   359us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253536 (+   329us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253537 (+     1us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253538 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.253696 (+   158us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254122 (+   426us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254128 (+     6us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254313 (+   185us) client_negotiation.cc:769] Sending connection context
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254438 (+   125us) client_negotiation.cc:240] Negotiation successful
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.254551 (+   113us) negotiation.cc:327] Negotiation complete: OK
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":127,"thread_start_us":75,"threads_started":1}
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.256465 22548 heartbeater.cc:347] Connected to a master server at 127.21.199.190:33235
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.256583 22548 heartbeater.cc:464] Registering TS with master...
07:57:04.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.256810 22548 heartbeater.cc:511] Master 127.21.199.190:33235 requested a full tablet report, sending...
07:57:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.257552 22357 ts_manager.cc:194] Registered new tserver with Master: b871404c3f6c4f98b333ab7bb49b69ba (127.21.199.129:41339)
07:57:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.258446 22357 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.199.129@KRBTEST.COM'} at 127.21.199.129:38751
07:57:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.199.130@KRBTEST.COM; defaulting to no policy
07:57:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.199.130@KRBTEST.COM" created.
07:57:04.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.130 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.130.keytab.
07:57:04.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.130 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.130.keytab.
07:57:04.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.281713 22302 external_mini_cluster.cc:1326] Running /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/logs
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data/info.pb
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.130:0
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.130
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.130
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.130.keytab
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.130
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
07:57:04.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
07:57:04.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:04.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.369001 22553 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:04.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.369275 22553 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:04.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.369313 22553 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:04.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.370746 22553 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
07:57:04.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.370836 22553 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:04.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.370878 22553 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.199.130
07:57:04.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.372596 22553 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:04.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.130.keytab
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.130
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.130:0
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data/info.pb
07:57:04.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.130
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22553
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.130
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/logs
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:04.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:04.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.372893 22553 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:04.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.373193 22553 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:04.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.379554 22561 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.379519 22558 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.379571 22559 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.379588 22553 server_base.cc:1034] running on GCE node
07:57:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.380259 22553 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:04.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.380478 22553 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:04.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.381693 22553 hybrid_clock.cc:648] HybridClock initialized: now 1783497424381664 us; error 45 us; skew 500 ppm
07:57:04.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.130@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:04.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.384828 22553 init.cc:377] Logged in from keytab as kudu/127.21.199.130@KRBTEST.COM (short username kudu)
07:57:04.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.385370 22553 webserver.cc:460] Webserver started at http://127.21.199.130:46357/ using document root <none> and password file <none>
07:57:04.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.385673 22553 fs_manager.cc:359] Metadata directory not provided
07:57:04.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.385761 22553 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:04.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.385908 22553 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.386981 22553 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data/instance:
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5bbad246b7ac4896939fc7d703e7c483"
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.387454 22553 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal/instance:
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5bbad246b7ac4896939fc7d703e7c483"
07:57:04.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.389065 22553 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.390074 22568 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.390267 22553 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.390372 22553 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data,/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5bbad246b7ac4896939fc7d703e7c483"
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.390450 22553 fs_report.cc:383] FS layout report
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal
07:57:04.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data/data
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:04.391 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:04.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.402758 22553 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:04.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.405279 22553 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
07:57:04.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.405503 22553 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:04.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.405792 22553 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:04.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.406205 22553 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:04.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.406279 22553 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:04.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.406318 22553 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:04.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.406338 22553 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:04.413 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.413573 22553 rpc_server.cc:307] RPC server started. Bound to: 127.21.199.130:44379
07:57:04.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.413646 22681 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.199.130:44379 every 8 connection(s)
07:57:04.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.414049 22553 server_base.cc:1166] Dumped server information to /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/data/info.pb
07:57:04.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.417629 22302 external_mini_cluster.cc:1388] Started /tmp/dist-test-task4iPoWg/build/release/bin/kudu as pid 22553
07:57:04.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.417735 22302 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-1/wal/instance
07:57:04.421 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.130@KRBTEST.COM for kudu/127.21.199.190@KRBTEST.COM
07:57:04.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.425419 22410 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.414921 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.199.130:47537 (local address 127.21.199.190:33235)
07:57:04.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.414999 (+    78us) server_negotiation.cc:206] Beginning negotiation
07:57:04.425 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.415002 (+     3us) server_negotiation.cc:399] Waiting for connection header
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.415210 (+   208us) server_negotiation.cc:407] Connection header received
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416331 (+  1121us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416332 (+     1us) server_negotiation.cc:461] Received NEGOTIATE request from client
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416346 (+    14us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416401 (+    55us) server_negotiation.cc:226] Negotiated authn=SASL
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.417100 (+   699us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.417916 (+   816us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419228 (+  1312us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419430 (+   202us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419520 (+    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
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.422355 (+  2835us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.422357 (+     2us) server_negotiation.cc:881] Received SASL_INITIATE request from client
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.422357 (+     0us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.422366 (+     9us) server_negotiation.cc:922] calling sasl_server_start()
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.423855 (+  1489us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424330 (+   475us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424332 (+     2us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424332 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424409 (+    77us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424698 (+   289us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424699 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424699 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424819 (+   120us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424910 (+    91us) server_negotiation.cc:1035] Waiting for connection context
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.425231 (+   321us) server_negotiation.cc:299] Negotiation successful
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.425311 (+    80us) negotiation.cc:327] Negotiation complete: OK
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":45}
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.425640 22684 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.414891 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.199.190:33235 (local address 127.21.199.130:47537)
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.415086 (+   195us) negotiation.cc:107] Waiting for socket to connect
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.415131 (+    45us) client_negotiation.cc:174] Beginning negotiation
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416213 (+  1082us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416499 (+   286us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416508 (+     9us) client_negotiation.cc:394] Received NEGOTIATE response from server
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416787 (+   279us) client_negotiation.cc:189] Negotiated authn=SASL
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416994 (+   207us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.416999 (+     5us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.418051 (+  1052us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.418053 (+     2us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419118 (+  1065us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419121 (+     3us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419530 (+   409us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419530 (+     0us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.419669 (+   139us) 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
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.420314 (+   645us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.420326 (+    12us) client_negotiation.cc:656] calling sasl_client_start()
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.422185 (+  1859us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.423977 (+  1792us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.423985 (+     8us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.423988 (+     3us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424234 (+   246us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424493 (+   259us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424494 (+     1us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424495 (+     1us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424616 (+   121us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424911 (+   295us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.424919 (+     8us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.425074 (+   155us) client_negotiation.cc:769] Sending connection context
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.425207 (+   133us) client_negotiation.cc:240] Negotiation successful
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.425313 (+   106us) negotiation.cc:327] Negotiation complete: OK
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":153,"thread_start_us":117,"threads_started":1}
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) WARNING: no policy specified for kudu/127.21.199.131@KRBTEST.COM; defaulting to no policy
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.426257 22682 heartbeater.cc:347] Connected to a master server at 127.21.199.190:33235
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.426362 22682 heartbeater.cc:464] Registering TS with master...
07:57:04.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.426576 22682 heartbeater.cc:511] Master 127.21.199.190:33235 requested a full tablet report, sending...
07:57:04.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.429700 22357 ts_manager.cc:194] Registered new tserver with Master: 5bbad246b7ac4896939fc7d703e7c483 (127.21.199.130:44379)
07:57:04.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.430269 22357 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.199.130@KRBTEST.COM'} at 127.21.199.130:47537
07:57:04.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Principal "kudu/127.21.199.131@KRBTEST.COM" created.
07:57:04.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Authenticating as principal test-admin/admin@KRBTEST.COM with password.
07:57:04.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.131 with kvno 2, encryption type aes256-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.131.keytab.
07:57:04.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Entry for principal kudu/127.21.199.131 with kvno 2, encryption type aes128-cts-hmac-sha1-96 added to keytab WRFILE:/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.131.keytab.
07:57:04.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.454710 22302 external_mini_cluster.cc:1326] Running /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task4iPoWg/build/release/bin/kudu
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/logs
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data/info.pb
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.131:0
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.131
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.131
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.131.keytab
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.131
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=test-admin
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=test-user
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-encryption=required
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections
07:57:04.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc-trace-negotiation with env {KRB5CCNAME=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5cc,KRB5_CONFIG=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5.conf,KRB5_KDC_PROFILE=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kdc.conf,KUDU_ENABLE_KRB5_REALM_FIX=yes}
07:57:04.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.551033 22687 flags.cc:425] Enabled unsafe flag: --openssl_security_level_override=0
07:57:04.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.551265 22687 flags.cc:425] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
07:57:04.551 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.551290 22687 flags.cc:425] Enabled unsafe flag: --never_fsync=true
07:57:04.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.552479 22687 flags.cc:425] Enabled experimental flag: --rpc_trace_negotiation=true
07:57:04.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.552525 22687 flags.cc:425] Enabled experimental flag: --ipki_server_key_size=768
07:57:04.552 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.552553 22687 flags.cc:425] Enabled experimental flag: --local_ip_for_outbound_sockets=127.21.199.131
07:57:04.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.554533 22687 tablet_server_runner.cc:78] Tablet server non-default flags:
07:57:04.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.21.199.148:40551
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encrypt_loopback_connections=true
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_trace_negotiation=true
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --keytab_file=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/kudu_127.21.199.131.keytab
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --principal=kudu/127.21.199.131
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.21.199.131:0
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_authentication=required
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_encryption=required
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --superuser_acl=<redacted>
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --user_acl=<redacted>
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
07:57:04.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data/info.pb
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.21.199.131
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.21.199.190:33235
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.22687
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.21.199.131
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/logs
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
07:57:04.556 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.18.0-SNAPSHOT
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision c2d25d5f57d102d9ad9869eaf208d035a22e18aa
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by systest at 08 Jul 2026 06:42:21 UTC on ccycloud.quasar-lnvdon.root.comops.site
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 4492842
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.554778 22687 env_posix.cc:2256] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
07:57:04.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.554975 22687 file_cache.cc:493] Constructed file cache file cache with capacity 419430
07:57:04.560 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.560669 22695 instance_detector.cc:116] could not retrieve OpenStack instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.560647 22692 instance_detector.cc:116] could not retrieve AWS instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.560642 22693 instance_detector.cc:116] could not retrieve Azure instance metadata: Network error: curl error: HTTP response code said error: The requested URL returned error: 404
07:57:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.561332 22687 server_base.cc:1034] running on GCE node
07:57:04.561 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.561604 22687 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
07:57:04.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.561980 22687 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
07:57:04.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.563171 22687 hybrid_clock.cc:648] HybridClock initialized: now 1783497424563148 us; error 44 us; skew 500 ppm
07:57:04.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): AS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.131@KRBTEST.COM for krbtgt/KRBTEST.COM@KRBTEST.COM
07:57:04.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.566630 22687 init.cc:377] Logged in from keytab as kudu/127.21.199.131@KRBTEST.COM (short username kudu)
07:57:04.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.567091 22687 webserver.cc:460] Webserver started at http://127.21.199.131:40299/ using document root <none> and password file <none>
07:57:04.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.567281 22687 fs_manager.cc:359] Metadata directory not provided
07:57:04.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.567317 22687 fs_manager.cc:365] Using write-ahead log directory (fs_wal_dir) as metadata directory
07:57:04.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.567451 22687 server_base.cc:882] This appears to be a new deployment of Kudu; creating new FS layout
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.568985 22687 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data/instance:
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4dc2804eb0f41d89074b3d337127c27"
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.569410 22687 fs_manager.cc:1063] Generated new instance metadata in path /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal/instance:
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4dc2804eb0f41d89074b3d337127c27"
07:57:04.569 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.571 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.571125 22687 fs_manager.cc:691] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.571907 22702 log_block_manager.cc:3774] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.572178 22687 fs_manager.cc:725] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.572286 22687 fs_manager.cc:642] Opened local filesystem: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data,/tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f4dc2804eb0f41d89074b3d337127c27"
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 07:57:04 on dist-test-slave-6hjl"
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.572412 22687 fs_report.cc:383] FS layout report
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data/data
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
07:57:04.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
07:57:04.573 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
07:57:04.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.603449 22687 rpc_server.cc:225] running with OpenSSL 1.0.2k-fips  26 Jan 2017
07:57:04.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.605895 22687 env_posix.cc:2256] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
07:57:04.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606087 22687 kserver.cc:163] Server-wide thread pool size limit: 3276
07:57:04.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606359 22687 txn_system_client.cc:433] TxnSystemClient initialization is disabled...
07:57:04.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606750 22687 ts_tablet_manager.cc:579] Loaded tablet metadata (0 total tablets, 0 live tablets)
07:57:04.606 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606812 22687 ts_tablet_manager.cc:525] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
07:57:04.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606845 22687 ts_tablet_manager.cc:610] Registered 0 tablets
07:57:04.607 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.606863 22687 ts_tablet_manager.cc:589] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
07:57:04.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.613256 22687 rpc_server.cc:307] RPC server started. Bound to: 127.21.199.131:42341
07:57:04.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.613338 22815 acceptor_pool.cc:254] collecting diagnostics on the listening RPC socket 127.21.199.131:42341 every 8 connection(s)
07:57:04.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.613744 22687 server_base.cc:1166] Dumped server information to /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/data/info.pb
07:57:04.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Jul 08 07:57:04 dist-test-slave-6hjl krb5kdc[22312](info): TGS_REQ (2 etypes {17 16}) 127.0.0.1: ISSUE: authtime 1783497424, etypes {rep=17 tkt=17 ses=17}, kudu/127.21.199.131@KRBTEST.COM for kudu/127.21.199.190@KRBTEST.COM
07:57:04.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.621694 22302 external_mini_cluster.cc:1388] Started /tmp/dist-test-task4iPoWg/build/release/bin/kudu as pid 22687
07:57:04.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.621779 22302 external_mini_cluster.cc:1402] Reading /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/ts-2/wal/instance
07:57:04.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.625420 22410 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.614747 (+     0us) reactor.cc:625] Submitting negotiation task for server connection from 127.21.199.131:54549 (local address 127.21.199.190:33235)
07:57:04.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.614923 (+   176us) server_negotiation.cc:206] Beginning negotiation
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.614926 (+     3us) server_negotiation.cc:399] Waiting for connection header
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.615177 (+   251us) server_negotiation.cc:407] Connection header received
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616406 (+  1229us) server_negotiation.cc:365] Received NEGOTIATE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616408 (+     2us) server_negotiation.cc:461] Received NEGOTIATE request from client
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616422 (+    14us) server_negotiation.cc:377] Sending NEGOTIATE NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616488 (+    66us) server_negotiation.cc:226] Negotiated authn=SASL
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.617241 (+   753us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.617886 (+   645us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619106 (+  1220us) server_negotiation.cc:365] Received TLS_HANDSHAKE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619331 (+   225us) server_negotiation.cc:377] Sending TLS_HANDSHAKE NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619425 (+    94us) 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
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.622318 (+  2893us) server_negotiation.cc:365] Received SASL_INITIATE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.622320 (+     2us) server_negotiation.cc:881] Received SASL_INITIATE request from client
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.622320 (+     0us) server_negotiation.cc:892] Client requested to use mechanism: GSSAPI
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.622337 (+    17us) server_negotiation.cc:922] calling sasl_server_start()
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.623853 (+  1516us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624348 (+   495us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624354 (+     6us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624354 (+     0us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624409 (+    55us) server_negotiation.cc:377] Sending SASL_CHALLENGE NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624715 (+   306us) server_negotiation.cc:365] Received SASL_RESPONSE NegotiatePB request
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624716 (+     1us) server_negotiation.cc:956] Received SASL_RESPONSE request from client
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624717 (+     1us) server_negotiation.cc:967] calling sasl_server_step()
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624843 (+   126us) server_negotiation.cc:377] Sending SASL_SUCCESS NegotiatePB response
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624929 (+    86us) server_negotiation.cc:1035] Waiting for connection context
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.625246 (+   317us) server_negotiation.cc:299] Negotiation successful
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.625321 (+    75us) negotiation.cc:327] Negotiation complete: OK
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"server-negotiator.queue_time_us":50}
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.625613 22818 negotiation.cc:339] RPC negotiation tracing enabled. Trace:
07:57:04.626 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.614696 (+     0us) reactor.cc:625] Submitting negotiation task for client connection to 127.21.199.190:33235 (local address 127.21.199.131:54549)
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.615039 (+   343us) negotiation.cc:107] Waiting for socket to connect
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.615080 (+    41us) client_negotiation.cc:174] Beginning negotiation
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616266 (+  1186us) client_negotiation.cc:252] Sending NEGOTIATE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616583 (+   317us) client_negotiation.cc:271] Received NEGOTIATE NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616587 (+     4us) client_negotiation.cc:394] Received NEGOTIATE response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.616892 (+   305us) client_negotiation.cc:189] Negotiated authn=SASL
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.617130 (+   238us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.617135 (+     5us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.618028 (+   893us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.618031 (+     3us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619000 (+   969us) client_negotiation.cc:514] Sending TLS_HANDSHAKE message to server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619003 (+     3us) client_negotiation.cc:252] Sending TLS_HANDSHAKE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619439 (+   436us) client_negotiation.cc:271] Received TLS_HANDSHAKE NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619440 (+     1us) client_negotiation.cc:527] Received TLS_HANDSHAKE response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.619588 (+   148us) 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
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.620225 (+   637us) client_negotiation.cc:623] Initiating SASL GSSAPI handshake
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.620235 (+    10us) client_negotiation.cc:656] calling sasl_client_start()
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.622156 (+  1921us) client_negotiation.cc:252] Sending SASL_INITIATE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.623979 (+  1823us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.623987 (+     8us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.623990 (+     3us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624238 (+   248us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624505 (+   267us) client_negotiation.cc:271] Received SASL_CHALLENGE NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624506 (+     1us) client_negotiation.cc:694] Received SASL_CHALLENGE response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624506 (+     0us) client_negotiation.cc:760] calling sasl_client_step()
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624631 (+   125us) client_negotiation.cc:252] Sending SASL_RESPONSE NegotiatePB request
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624925 (+   294us) client_negotiation.cc:271] Received SASL_SUCCESS NegotiatePB response
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.624933 (+     8us) client_negotiation.cc:715] Received SASL_SUCCESS response from server
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.625095 (+   162us) client_negotiation.cc:769] Sending connection context
07:57:04.627 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.625221 (+   126us) client_negotiation.cc:240] Negotiation successful
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 0708 07:57:04.625324 (+   103us) negotiation.cc:327] Negotiation complete: OK
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Metrics: {"client-negotiator.queue_time_us":297,"thread_start_us":91,"threads_started":1}
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.626513 22816 heartbeater.cc:347] Connected to a master server at 127.21.199.190:33235
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.626614 22816 heartbeater.cc:464] Registering TS with master...
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.626776 22816 heartbeater.cc:511] Master 127.21.199.190:33235 requested a full tablet report, sending...
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.627269 22357 ts_manager.cc:194] Registered new tserver with Master: f4dc2804eb0f41d89074b3d337127c27 (127.21.199.131:42341)
07:57:04.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.627760 22357 master_service.cc:496] Signed X509 certificate for tserver {username='kudu', principal='kudu/127.21.199.131@KRBTEST.COM'} at 127.21.199.131:54549
07:57:04.635 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.635306 22302 external_mini_cluster.cc:930] 3 TS(s) registered with all masters
07:57:04.636 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
07:57:04.638 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_kdc_env_vars {
}

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

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

07:57:04.662 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.199.190"
      port: 33235
    }
    bound_http_address {
      host: "127.21.199.190"
      port: 38427
    }
  }
}

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

07:57:04.669 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.21.199.129"
      port: 41339
    }
    bound_http_address {
      host: "127.21.199.129"
      port: 43175
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.21.199.130"
      port: 44379
    }
    bound_http_address {
      host: "127.21.199.130"
      port: 46357
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.21.199.131"
      port: 42341
    }
    bound_http_address {
      host: "127.21.199.131"
      port: 40299
    }
  }
}

07:57:04.670 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
07:57:04.896 [DEBUG - main] (SecurityUtil.java:105) Using ticketCache: /tmp/dist-test-task4iPoWg/test-tmp/mini-kudu-cluster7134932728840110179/krb5kdc/krb5cc
07:57:04.907 [DEBUG - main] (SecurityUtil.java:119) Logged in as subject: test-admin@KRBTEST.COM
07:57:04.921 [DEBUG - main] (AsyncKuduClient.java:2704) Releasing all remaining resources
07:57:04.925 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.924865 22302 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task4iPoWg/build/release/bin/kudu with pid 22419
07:57:04.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.930546 22341 connection.cc:535] server connection from 127.21.199.129:38751 recv error: Network error: failed to read from TLS socket (remote: 127.21.199.129:38751): Connection reset by peer (error 104)
07:57:04.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.930675 22302 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task4iPoWg/build/release/bin/kudu with pid 22553
07:57:04.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.935669 22342 connection.cc:535] server connection from 127.21.199.130:47537 recv error: Network error: failed to read from TLS socket (remote: 127.21.199.130:47537): Connection reset by peer (error 104)
07:57:04.936 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.935922 22302 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task4iPoWg/build/release/bin/kudu with pid 22687
07:57:04.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.941031 22341 connection.cc:535] server connection from 127.21.199.131:54549 recv error: Network error: failed to read from TLS socket (remote: 127.21.199.131:54549): Connection reset by peer (error 104)
07:57:04.941 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 07:57:04.941282 22302 external_mini_cluster.cc:1595] Killing /tmp/dist-test-task4iPoWg/build/release/bin/kudu with pid 22325
07:57:04.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 07:57:04.946625 22310 connection.cc:535] client connection to 127.21.199.190:33235 recv error: Network error: failed to read from TLS socket (remote: 127.21.199.190:33235): Connection reset by peer (error 104)
07:57:04.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T07:57:04Z chronyd exiting

Time: 3.392

OK (1 test)

