JUnit version 4.13.2
.18:21:28.983 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1786472488972
18:21:29.016 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
18:21:29.058 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
18:21:29.069 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-task_Dmqc5/test-tmp
18:21:29.104 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/release/bin
18:21:29.108 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-task_Dmqc5/java/build/dist-test/../../../build/release/bin/kudu, test, mini_cluster, --serialization=pb]
18:21:29.335 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

18:21:29.354 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:21:29.356 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

18:21:29.357 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.357297 29738 mini_oidc.cc:150] Starting JWKS server
18:21:29.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.358100 29738 webserver.cc:533] Webserver started at http://127.0.0.1:34241/ using document root <none> and password file <none>
18:21:29.358 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.358201 29738 mini_oidc.cc:186] Starting OIDC Discovery server
18:21:29.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.358379 29738 webserver.cc:533] Webserver started at http://127.0.0.1:37181/ using document root <none> and password file <none>
18:21:29.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:21:29Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
18:21:29.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:21:29Z Disabled control of system clock
18:21:29.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.374715 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal
18:21:29.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data
18:21:29.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:29.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:29.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:29.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/logs
18:21:29.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data/info.pb
18:21:29.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:29.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:29.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:29.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:29.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:29.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:29.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.190:39897
18:21:29.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.190
18:21:29.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json with env {}
18:21:29.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.456369 29757 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:29.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.456566 29757 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:29.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.456595 29757 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:29.458 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458611 29757 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:29.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458670 29757 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:29.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458688 29757 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:29.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458704 29757 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:29.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458721 29757 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:29.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.458737 29757 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34241/jwks.json
18:21:29.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.461043 29757 master_runner.cc:387] Master server non-default flags:
18:21:29.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/logs
18:21:29.461 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:29.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.462 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data
18:21:29.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal
18:21:29.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.190:39897
18:21:29.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:29.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.465 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data/info.pb
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.190
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:29.466 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29757
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:29.467 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:29.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:29.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:29.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:29.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:29.468 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:29.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.461381 29757 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:29.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.461681 29757 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:29.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.464831 29757 server_base.cc:1061] running on GCE node
18:21:29.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.464849 29765 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
18:21:29.469 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.465167 29763 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
18:21:29.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.467612 29769 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
18:21:29.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.467949 29757 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:29.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.468312 29757 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:29.470 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.469468 29757 hybrid_clock.cc:648] HybridClock initialized: now 1786472489469442 us; error 156 us; skew 500 ppm
18:21:29.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.470988 29757 webserver.cc:533] Webserver started at http://127.29.10.190:42951/ using document root <none> and password file <none>
18:21:29.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.471175 29757 fs_manager.cc:362] Metadata directory not provided
18:21:29.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.471206 29757 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:29.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.471323 29757 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:29.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.472370 29757 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data/instance:
18:21:29.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c624188932b94255aceb89813bcf6942"
18:21:29.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.472640 29757 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal/instance:
18:21:29.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c624188932b94255aceb89813bcf6942"
18:21:29.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.473995 29757 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
18:21:29.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.474880 29782 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:29.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.475088 29757 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:21:29.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.475150 29757 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal
18:21:29.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "c624188932b94255aceb89813bcf6942"
18:21:29.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.475214 29757 fs_report.cc:389] FS layout report
18:21:29.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:29.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal
18:21:29.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal
18:21:29.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data/data
18:21:29.477 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:29.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:29.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:29.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:29.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:29.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:29.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:29.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:29.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:29.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:29.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:29.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.487285 29757 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:29.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.487628 29757 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:29.488 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.487725 29757 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:29.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.491497 29757 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.190:39897
18:21:29.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.491539 29898 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.190:39897 every 8 connection(s)
18:21:29.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.491918 29757 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/data/info.pb
18:21:29.492 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.492638 29901 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:29.494 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.494140 29901 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.500655 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 29757
18:21:29.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.500782 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-0/wal/instance
18:21:29.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.501751 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal
18:21:29.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data
18:21:29.502 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:29.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:29.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:29.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/logs
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data/info.pb
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:29.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.189:42713
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.189
18:21:29.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json with env {}
18:21:29.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.503150 29901 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.503659 29783 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.29.10.189:42713: connect: Connection refused (error 111)
18:21:29.507 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.504225 29901 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.189:42713: Network error: Client connection negotiation failed: client connection to 127.29.10.189:42713: connect: Connection refused (error 111)
18:21:29.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.553462 29901 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } attempt: 1
18:21:29.554 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.554422 29901 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.189:42713: Network error: Client connection negotiation failed: client connection to 127.29.10.189:42713: connect: Connection refused (error 111)
18:21:29.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.584344 29908 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:29.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.584545 29908 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:29.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.584565 29908 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:29.586 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586547 29908 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:29.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586606 29908 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:29.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586619 29908 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:29.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586634 29908 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:29.587 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586645 29908 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:29.588 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.586655 29908 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34241/jwks.json
18:21:29.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.589123 29908 master_runner.cc:387] Master server non-default flags:
18:21:29.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/logs
18:21:29.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.589 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:29.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.590 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.189:42713
18:21:29.592 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:29.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json
18:21:29.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data/info.pb
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.189
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.29908
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:29.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:29.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:29.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:29.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.589463 29908 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:29.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.589751 29908 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:29.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.592844 29922 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
18:21:29.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.592957 29926 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
18:21:29.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.592852 29921 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
18:21:29.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.593573 29908 server_base.cc:1061] running on GCE node
18:21:29.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.593791 29908 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:29.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.594017 29908 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:29.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.595178 29908 hybrid_clock.cc:648] HybridClock initialized: now 1786472489595157 us; error 31 us; skew 500 ppm
18:21:29.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.596412 29908 webserver.cc:533] Webserver started at http://127.29.10.189:43391/ using document root <none> and password file <none>
18:21:29.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.596633 29908 fs_manager.cc:362] Metadata directory not provided
18:21:29.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.596681 29908 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.596791 29908 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.597887 29908 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data/instance:
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06cdd190cd244dd884077783ae508c8e"
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.598261 29908 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal/instance:
18:21:29.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06cdd190cd244dd884077783ae508c8e"
18:21:29.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.599793 29908 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.003s
18:21:29.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.600533 29938 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:29.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.600696 29908 fs_manager.cc:730] Time spent opening block manager: real 0.000s	user 0.000s	sys 0.001s
18:21:29.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.600754 29908 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal
18:21:29.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "06cdd190cd244dd884077783ae508c8e"
18:21:29.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.600811 29908 fs_report.cc:389] FS layout report
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data/data
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:29.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:29.603 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:29.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:29.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:29.604 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:29.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.622591 29901 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } attempt: 2
18:21:29.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.623402 29901 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.189:42713: Network error: Client connection negotiation failed: client connection to 127.29.10.189:42713: connect: Connection refused (error 111)
18:21:29.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.625365 29908 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:29.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.625675 29908 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:29.625 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.625772 29908 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:29.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.629766 29908 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.189:42713
18:21:29.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.629832 30039 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.189:42713 every 8 connection(s)
18:21:29.630 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.630086 29908 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/data/info.pb
18:21:29.631 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.630805 30041 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:29.632 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.632218 30041 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.637135 30041 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.639125 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 29908
18:21:29.639 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.639212 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-1/wal/instance
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.639659 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:29.640 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/logs
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data/info.pb
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:29.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.188:34349
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.188
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.643 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json with env {}
18:21:29.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.642544 30041 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.648 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.648253 29939 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.29.10.188:34349: connect: Connection refused (error 111)
18:21:29.650 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.650063 30041 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.188:34349: Network error: Client connection negotiation failed: client connection to 127.29.10.188:34349: connect: Connection refused (error 111)
18:21:29.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.699337 30041 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } attempt: 1
18:21:29.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.700289 30041 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.188:34349: Network error: Client connection negotiation failed: client connection to 127.29.10.188:34349: connect: Connection refused (error 111)
18:21:29.715 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.714579 29901 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } attempt: 3
18:21:29.718 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.718132 29901 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.719630 29901 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.188:34349: Network error: Client connection negotiation failed: client connection to 127.29.10.188:34349: connect: Connection refused (error 111)
18:21:29.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.724730 30046 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:29.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.724918 30046 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:29.725 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.724941 30046 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:29.726 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726555 30046 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
18:21:29.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726609 30046 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:29.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726622 30046 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
18:21:29.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726634 30046 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
18:21:29.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726644 30046 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
18:21:29.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.726653 30046 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:34241/jwks.json
18:21:29.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.728356 30046 master_runner.cc:387] Master server non-default flags:
18:21:29.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/logs
18:21:29.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
18:21:29.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.188:34349
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
18:21:29.730 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:34241/jwks.json
18:21:29.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:29.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:29.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data/info.pb
18:21:29.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.188
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.30046
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:29.732 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:29.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.728601 30046 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.728807 30046 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.731380 30065 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
18:21:29.734 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.731380 30066 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
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.732335 30068 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
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.732376 30046 server_base.cc:1061] running on GCE node
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.732606 30046 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.732857 30046 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.734019 30046 hybrid_clock.cc:648] HybridClock initialized: now 1786472489734001 us; error 29 us; skew 500 ppm
18:21:29.735 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.735260 30046 webserver.cc:533] Webserver started at http://127.29.10.188:37407/ using document root <none> and password file <none>
18:21:29.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.735508 30046 fs_manager.cc:362] Metadata directory not provided
18:21:29.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.735558 30046 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:29.736 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.735675 30046 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:29.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.736809 30046 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data/instance:
18:21:29.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70ea3f3542134c21872a2a5241acd261"
18:21:29.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.737320 30046 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal/instance:
18:21:29.737 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70ea3f3542134c21872a2a5241acd261"
18:21:29.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.738855 30046 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
18:21:29.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.739737 30077 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.739948 30046 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.740003 30046 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "70ea3f3542134c21872a2a5241acd261"
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:29 on dist-test-slave-pww0"
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.740062 30046 fs_report.cc:389] FS layout report
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data/data
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:29.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:29.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:29.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.750427 30046 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:29.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.750747 30046 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:29.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.750839 30046 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:29.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.750841 29901 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } attempt: 1
18:21:29.751 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.751725 29901 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.29.10.188:34349: Network error: Client connection negotiation failed: client connection to 127.29.10.188:34349: connect: Connection refused (error 111)
18:21:29.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.754824 30046 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.188:34349
18:21:29.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.754858 30187 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.188:34349 every 8 connection(s)
18:21:29.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.755173 30046 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/data/info.pb
18:21:29.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.755587 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 30046
18:21:29.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.755664 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/master-2/wal/instance
18:21:29.756 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.755860 30190 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:29.758 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.757627 30190 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.764 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.764333 30190 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.768 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.768460 30041 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } attempt: 2
18:21:29.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.769843 30190 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } has no permanent_uuid. Determining permanent_uuid...
18:21:29.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.772838 30041 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: Bootstrap starting.
18:21:29.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.773640 30041 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: Neither blocks nor log segments found. Creating new log.
18:21:29.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.773880 30041 log.cc:826] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: Log is configured to *not* fsync() on all Append() calls
18:21:29.774 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.774186 30190 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: Bootstrap starting.
18:21:29.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.774873 30190 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: Neither blocks nor log segments found. Creating new log.
18:21:29.775 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.775156 30190 log.cc:826] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: Log is configured to *not* fsync() on all Append() calls
18:21:29.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.775908 30190 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: No bootstrap required, opened a new log
18:21:29.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.775974 30041 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: No bootstrap required, opened a new log
18:21:29.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777573 30041 raft_consensus.cc:359] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777561 30190 raft_consensus.cc:359] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777685 30041 raft_consensus.cc:385] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777685 30190 raft_consensus.cc:385] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777706 30041 raft_consensus.cc:740] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 06cdd190cd244dd884077783ae508c8e, State: Initialized, Role: FOLLOWER
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777714 30190 raft_consensus.cc:740] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 70ea3f3542134c21872a2a5241acd261, State: Initialized, Role: FOLLOWER
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777786 30041 consensus_queue.cc:260] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.778 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.777839 30190 consensus_queue.cc:260] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.778048 30215 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.778097 30041 sys_catalog.cc:565] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: configured and running, proceeding with master startup.
18:21:29.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.778113 30215 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.779 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.778162 30190 sys_catalog.cc:565] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: configured and running, proceeding with master startup.
18:21:29.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.779851 30216 sys_catalog.cc:455] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.779963 30216 sys_catalog.cc:458] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.781100 30243 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:29.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.781406 30243 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:29.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.780761 30046 master_runner.cc:187] Error getting master registration for 127.29.10.190:39897: OK, instance_id { permanent_uuid: "c624188932b94255aceb89813bcf6942" instance_seqno: 1786472489490503 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:21:29.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.782262 30046 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:21:29.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.781461 29908 master_runner.cc:187] Error getting master registration for 127.29.10.190:39897: OK, instance_id { permanent_uuid: "c624188932b94255aceb89813bcf6942" instance_seqno: 1786472489490503 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
18:21:29.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.783139 29908 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:21:29.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.784456 30251 catalog_manager.cc:1594] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:29.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.784786 30251 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:29.827 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.826910 29901 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } attempt: 2
18:21:29.832 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.832304 29901 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: Bootstrap starting.
18:21:29.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.833091 29901 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: Neither blocks nor log segments found. Creating new log.
18:21:29.833 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.833699 29901 log.cc:826] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: Log is configured to *not* fsync() on all Append() calls
18:21:29.834 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.834525 29901 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: No bootstrap required, opened a new log
18:21:29.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.836241 29901 raft_consensus.cc:359] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.836380 29901 raft_consensus.cc:385] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:29.836 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.836411 29901 raft_consensus.cc:740] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c624188932b94255aceb89813bcf6942, State: Initialized, Role: FOLLOWER
18:21:29.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.836547 29901 consensus_queue.cc:260] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.836869 29901 sys_catalog.cc:565] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: configured and running, proceeding with master startup.
18:21:29.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.837464 30260 sys_catalog.cc:455] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 0 committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.837805 30260 sys_catalog.cc:458] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.839094 30283 catalog_manager.cc:1594] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
18:21:29.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.839396 30283 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
18:21:29.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.841506 29757 master_runner.cc:264] No leader master found from master c624188932b94255aceb89813bcf6942
18:21:29.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.841559 29757 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
18:21:29.876 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:29.876385 29951 tablet.cc:2406] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:21:29.920 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.916564 30215 raft_consensus.cc:493] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.916719 30215 raft_consensus.cc:515] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.916970 30215 leader_election.cc:290] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers c624188932b94255aceb89813bcf6942 (127.29.10.190:39897), 70ea3f3542134c21872a2a5241acd261 (127.29.10.188:34349)
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917351 30138 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "06cdd190cd244dd884077783ae508c8e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "70ea3f3542134c21872a2a5241acd261" is_pre_election: true
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917501 30138 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 06cdd190cd244dd884077783ae508c8e in term 0.
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917716 29939 leader_election.cc:304] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 06cdd190cd244dd884077783ae508c8e, 70ea3f3542134c21872a2a5241acd261; no voters: 
18:21:29.921 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917848 30215 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Leader pre-election won for term 1
18:21:29.922 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917888 30215 raft_consensus.cc:493] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:21:29.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.917908 30215 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 0 FOLLOWER]: Advancing to term 1
18:21:29.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.919076 30215 raft_consensus.cc:515] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.919224 30215 leader_election.cc:290] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [CANDIDATE]: Term 1 election: Requested vote from peers c624188932b94255aceb89813bcf6942 (127.29.10.190:39897), 70ea3f3542134c21872a2a5241acd261 (127.29.10.188:34349)
18:21:29.928 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.919445 30138 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "06cdd190cd244dd884077783ae508c8e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "70ea3f3542134c21872a2a5241acd261"
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.919559 30138 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 0 FOLLOWER]: Advancing to term 1
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.920365 30138 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 06cdd190cd244dd884077783ae508c8e in term 1.
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.920542 29939 leader_election.cc:304] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 06cdd190cd244dd884077783ae508c8e, 70ea3f3542134c21872a2a5241acd261; no voters: 
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.922266 30260 raft_consensus.cc:493] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.922402 30260 raft_consensus.cc:515] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.922739 30260 leader_election.cc:290] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 06cdd190cd244dd884077783ae508c8e (127.29.10.189:42713), 70ea3f3542134c21872a2a5241acd261 (127.29.10.188:34349)
18:21:29.929 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.923219 29987 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "c624188932b94255aceb89813bcf6942" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "06cdd190cd244dd884077783ae508c8e" is_pre_election: true
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.923353 29987 raft_consensus.cc:2393] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 1 FOLLOWER]: Leader pre-election vote request: Denying vote to candidate c624188932b94255aceb89813bcf6942 in current term 1: Already voted for candidate 06cdd190cd244dd884077783ae508c8e in this term.
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.923870 29838 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "06cdd190cd244dd884077783ae508c8e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c624188932b94255aceb89813bcf6942" is_pre_election: true
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.923974 29838 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 06cdd190cd244dd884077783ae508c8e in term 0.
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.924088 29837 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "06cdd190cd244dd884077783ae508c8e" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "c624188932b94255aceb89813bcf6942"
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.924155 29837 raft_consensus.cc:3060] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 0 FOLLOWER]: Advancing to term 1
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.925362 29837 raft_consensus.cc:2468] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 06cdd190cd244dd884077783ae508c8e in term 1.
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.925676 30138 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "c624188932b94255aceb89813bcf6942" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "70ea3f3542134c21872a2a5241acd261" is_pre_election: true
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.925772 30138 raft_consensus.cc:2393] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 1 FOLLOWER]: Leader pre-election vote request: Denying vote to candidate c624188932b94255aceb89813bcf6942 in current term 1: Already voted for candidate 06cdd190cd244dd884077783ae508c8e in this term.
18:21:29.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.925968 29783 leader_election.cc:304] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate lost. Election summary: received 3 responses out of 3 voters: 1 yes votes; 2 no votes. yes voters: c624188932b94255aceb89813bcf6942; no voters: 06cdd190cd244dd884077783ae508c8e, 70ea3f3542134c21872a2a5241acd261
18:21:29.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.926139 30260 raft_consensus.cc:2749] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 1 FOLLOWER]: Leader pre-election lost for term 1. Reason: could not achieve majority
18:21:29.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.927050 30215 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 1 FOLLOWER]: Leader election won for term 1
18:21:29.931 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.927266 30215 raft_consensus.cc:697] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [term 1 LEADER]: Becoming Leader. State: Replica: 06cdd190cd244dd884077783ae508c8e, State: Running, Role: LEADER
18:21:29.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.927361 30215 consensus_queue.cc:237] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } }
18:21:29.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.927768 30215 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: SysCatalogTable state changed. Reason: New leader 06cdd190cd244dd884077783ae508c8e. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.927847 30215 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: This master's current role is: LEADER
18:21:29.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.932622 30289 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
18:21:29.933 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.933159 30289 catalog_manager.cc:1520] Initializing Kudu cluster ID...
18:21:29.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.935519 30138 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [term 1 FOLLOWER]: Refusing update from remote peer 06cdd190cd244dd884077783ae508c8e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:29.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.936208 30215 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [LEADER]: Connected to new peer: Peer: permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:29.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.937415 30216 sys_catalog.cc:455] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 06cdd190cd244dd884077783ae508c8e. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.937500 30216 sys_catalog.cc:458] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.938246 29837 raft_consensus.cc:1275] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [term 1 FOLLOWER]: Refusing update from remote peer 06cdd190cd244dd884077783ae508c8e: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.938494 30215 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [LEADER]: Connected to new peer: Peer: permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.939649 30260 sys_catalog.cc:455] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 06cdd190cd244dd884077783ae508c8e. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.939733 30260 sys_catalog.cc:458] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.940946 30287 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.941022 30287 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: This master's current role is: LEADER
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.941501 30260 sys_catalog.cc:455] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.941577 30260 sys_catalog.cc:458] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.941746 30290 mvcc.cc:204] Tried to move back new op lower bound from 7317391318773071872 to 7317391318743162880. Current Snapshot: MvccSnapshot[applied={T|T < 7317391318773071872}]
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.941897 30300 mvcc.cc:204] Tried to move back new op lower bound from 7317391318773071872 to 7317391318743162880. Current Snapshot: MvccSnapshot[applied={T|T < 7317391318773071872}]
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.942584 30215 sys_catalog.cc:455] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.942656 30215 sys_catalog.cc:458] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e [sys.catalog]: This master's current role is: LEADER
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.943022 30216 sys_catalog.cc:455] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "06cdd190cd244dd884077783ae508c8e" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "c624188932b94255aceb89813bcf6942" member_type: VOTER last_known_addr { host: "127.29.10.190" port: 39897 } } peers { permanent_uuid: "06cdd190cd244dd884077783ae508c8e" member_type: VOTER last_known_addr { host: "127.29.10.189" port: 42713 } } peers { permanent_uuid: "70ea3f3542134c21872a2a5241acd261" member_type: VOTER last_known_addr { host: "127.29.10.188" port: 34349 } } }
18:21:29.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.943099 30216 sys_catalog.cc:458] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261 [sys.catalog]: This master's current role is: FOLLOWER
18:21:29.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.947280 30291 mvcc.cc:204] Tried to move back new op lower bound from 7317391318773071872 to 7317391318743162880. Current Snapshot: MvccSnapshot[applied={T|T < 7317391318773071872}]
18:21:29.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.948799 30289 catalog_manager.cc:1383] Generated new cluster ID: 293b243eac554d90a1ed1ca639a4fa73
18:21:29.953 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.948873 30289 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
18:21:29.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.973424 30289 catalog_manager.cc:1406] Generated new certificate authority record
18:21:29.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.974247 30289 catalog_manager.cc:1540] Loading token signing keys...
18:21:29.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.986347 30289 catalog_manager.cc:6092] T 00000000000000000000000000000000 P 06cdd190cd244dd884077783ae508c8e: Generated new TSK 0
18:21:29.987 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:29.986588 30289 catalog_manager.cc:1550] Initializing in-progress tserver states...
18:21:30.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.004441 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/logs
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data/info.pb
18:21:30.005 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.129:0
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.129
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.129
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:30.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.088779 30314 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:30.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.088975 30314 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:30.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.088994 30314 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:30.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.090616 30314 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:30.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.090683 30314 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.29.10.129
18:21:30.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.092386 30314 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:30.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/logs
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.129:0
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data/info.pb
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.129
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.30314
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.129
18:21:30.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.092599 30314 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.092826 30314 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.095762 30337 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
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.096022 30328 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
18:21:30.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.096102 30331 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
18:21:30.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.096252 30314 server_base.cc:1061] running on GCE node
18:21:30.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.096419 30314 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:30.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.096673 30314 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:30.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.097856 30314 hybrid_clock.cc:648] HybridClock initialized: now 1786472490097822 us; error 45 us; skew 500 ppm
18:21:30.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.099270 30314 webserver.cc:533] Webserver started at http://127.29.10.129:40041/ using document root <none> and password file <none>
18:21:30.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.099526 30314 fs_manager.cc:362] Metadata directory not provided
18:21:30.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.099579 30314 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:30.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.099712 30314 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.100837 30314 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data/instance:
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "141885861f854391a2f14d1f7e417ccc"
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.101227 30314 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal/instance:
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "141885861f854391a2f14d1f7e417ccc"
18:21:30.101 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.102736 30314 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
18:21:30.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.103549 30343 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:30.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.103734 30314 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:30.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.103804 30314 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "141885861f854391a2f14d1f7e417ccc"
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.103863 30314 fs_report.cc:389] FS layout report
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data/data
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:30.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:30.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:30.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.115376 30314 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:30.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.115973 30314 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:30.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116128 30314 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:30.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116412 30314 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:30.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116827 30314 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:30.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116873 30314 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:30.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116904 30314 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:30.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.116919 30314 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:30.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.127504 30546 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.129:33759 every 8 connection(s)
18:21:30.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.127921 30314 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.129:33759
18:21:30.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.129135 30314 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/data/info.pb
18:21:30.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.132536 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 30314
18:21:30.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.132660 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-0/wal/instance
18:21:30.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.134831 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/logs
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data/info.pb
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.138 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.130:0
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.130
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.130
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:30.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.135342 30549 heartbeater.cc:344] Connected to a master server at 127.29.10.188:34349
18:21:30.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.135493 30549 heartbeater.cc:461] Registering TS with master...
18:21:30.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.135761 30549 heartbeater.cc:507] Master 127.29.10.188:34349 requested a full tablet report, sending...
18:21:30.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.136323 30113 ts_manager.cc:194] Registered new tserver with Master: 141885861f854391a2f14d1f7e417ccc (127.29.10.129:33759)
18:21:30.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141412 30550 heartbeater.cc:344] Connected to a master server at 127.29.10.190:39897
18:21:30.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141505 30550 heartbeater.cc:461] Registering TS with master...
18:21:30.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141618 30550 heartbeater.cc:507] Master 127.29.10.190:39897 requested a full tablet report, sending...
18:21:30.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141698 30551 heartbeater.cc:344] Connected to a master server at 127.29.10.189:42713
18:21:30.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141775 30551 heartbeater.cc:461] Registering TS with master...
18:21:30.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.141858 30551 heartbeater.cc:507] Master 127.29.10.189:42713 requested a full tablet report, sending...
18:21:30.142 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.142228 29968 ts_manager.cc:194] Registered new tserver with Master: 141885861f854391a2f14d1f7e417ccc (127.29.10.129:33759)
18:21:30.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.142974 29817 ts_manager.cc:194] Registered new tserver with Master: 141885861f854391a2f14d1f7e417ccc (127.29.10.129:33759)
18:21:30.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.143167 29968 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.29.10.129:54183
18:21:30.228 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.228278 30561 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:30.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.228479 30561 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:30.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.228508 30561 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:30.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.230391 30561 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:30.230 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.230480 30561 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.29.10.130
18:21:30.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.232394 30561 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:30.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/logs
18:21:30.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.130:0
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.233 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data/info.pb
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.130
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.30561
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.130
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:30.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:30.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:30.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:30.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:30.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.232710 30561 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:30.235 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.233013 30561 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.236040 30577 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
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.236101 30574 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
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.236056 30582 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
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.236291 30561 server_base.cc:1061] running on GCE node
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.236431 30561 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:30.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.236627 30561 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:30.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.237820 30561 hybrid_clock.cc:648] HybridClock initialized: now 1786472490237797 us; error 36 us; skew 500 ppm
18:21:30.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.239352 30561 webserver.cc:533] Webserver started at http://127.29.10.130:42529/ using document root <none> and password file <none>
18:21:30.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.239570 30561 fs_manager.cc:362] Metadata directory not provided
18:21:30.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.239614 30561 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:30.239 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.239704 30561 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.240764 30561 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data/instance:
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0cdf25346c454e70bf47678afe9caed4"
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.241050 30561 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal/instance:
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0cdf25346c454e70bf47678afe9caed4"
18:21:30.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.242 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.242522 30561 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.003s	sys 0.000s
18:21:30.243 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.243537 30597 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.243773 30561 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.243839 30561 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0cdf25346c454e70bf47678afe9caed4"
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.243891 30561 fs_report.cc:389] FS layout report
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data/data
18:21:30.244 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:30.245 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.272732 30561 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273061 30561 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273183 30561 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273383 30561 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273680 30561 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273702 30561 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273725 30561 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:30.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.273736 30561 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:30.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.279806 30561 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.130:45947
18:21:30.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.279886 30821 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.130:45947 every 8 connection(s)
18:21:30.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.280143 30561 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/data/info.pb
18:21:30.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.283397 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 30561
18:21:30.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.283515 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-1/wal/instance
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.285493 29738 external_mini_cluster.cc:1372] Running /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-task_Dmqc5/build/release/bin/kudu
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/logs
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data/info.pb
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.131:0
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.131
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.131
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
18:21:30.288 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.285564 30822 heartbeater.cc:344] Connected to a master server at 127.29.10.188:34349
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.285671 30822 heartbeater.cc:461] Registering TS with master...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.285826 30822 heartbeater.cc:507] Master 127.29.10.188:34349 requested a full tablet report, sending...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.286311 30113 ts_manager.cc:194] Registered new tserver with Master: 0cdf25346c454e70bf47678afe9caed4 (127.29.10.130:45947)
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287181 30827 heartbeater.cc:344] Connected to a master server at 127.29.10.190:39897
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287245 30827 heartbeater.cc:461] Registering TS with master...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287346 30827 heartbeater.cc:507] Master 127.29.10.190:39897 requested a full tablet report, sending...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287590 30830 heartbeater.cc:344] Connected to a master server at 127.29.10.189:42713
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287649 30830 heartbeater.cc:461] Registering TS with master...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287685 29817 ts_manager.cc:194] Registered new tserver with Master: 0cdf25346c454e70bf47678afe9caed4 (127.29.10.130:45947)
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.287741 30830 heartbeater.cc:507] Master 127.29.10.189:42713 requested a full tablet report, sending...
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.288136 29968 ts_manager.cc:194] Registered new tserver with Master: 0cdf25346c454e70bf47678afe9caed4 (127.29.10.130:45947)
18:21:30.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.288472 29968 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.29.10.130:59001
18:21:30.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.371366 30838 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
18:21:30.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.371625 30838 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
18:21:30.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.371649 30838 flags.cc:432] Enabled unsafe flag: --never_fsync=true
18:21:30.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.373239 30838 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
18:21:30.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.373307 30838 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.29.10.131
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.374913 30838 tablet_server_runner.cc:78] Tablet server non-default flags:
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/logs
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.29.10.148:45417
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.29.10.131:0
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
18:21:30.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data/info.pb
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.29.10.131
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.29.10.190:39897,127.29.10.189:42713,127.29.10.188:34349
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.30838
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.29.10.131
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
18:21:30.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision cfdbd367ce7fd9747cb6f1860fc64263d9f9f79a
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type RELEASE
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 11 Aug 2026 17:57:35 UTC on e7f111948823
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 17630
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.375145 30838 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
18:21:30.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.375353 30838 file_cache.cc:504] Constructed file cache file cache with capacity 419430
18:21:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.378154 30845 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
18:21:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.378183 30846 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
18:21:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:30.378166 30849 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
18:21:30.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.378669 30838 server_base.cc:1061] running on GCE node
18:21:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.378883 30838 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
18:21:30.379 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.379163 30838 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
18:21:30.380 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.380358 30838 hybrid_clock.cc:648] HybridClock initialized: now 1786472490380339 us; error 26 us; skew 500 ppm
18:21:30.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.381644 30838 webserver.cc:533] Webserver started at http://127.29.10.131:44117/ using document root <none> and password file <none>
18:21:30.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.381865 30838 fs_manager.cc:362] Metadata directory not provided
18:21:30.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.381918 30838 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
18:21:30.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.382046 30838 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.383018 30838 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data/instance:
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b3e113c781554427bfaa96d0a45ca079"
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.383383 30838 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal/instance:
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b3e113c781554427bfaa96d0a45ca079"
18:21:30.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.384 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.384807 30838 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.001s
18:21:30.385 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.385684 30856 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.385883 30838 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.385955 30838 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data,/tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "b3e113c781554427bfaa96d0a45ca079"
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-08-11 18:21:30 on dist-test-slave-pww0"
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.386018 30838 fs_report.cc:389] FS layout report
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data/data
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
18:21:30.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
18:21:30.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
18:21:30.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.404614 30838 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
18:21:30.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.404971 30838 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
18:21:30.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405112 30838 kserver.cc:163] Server-wide thread pool size limit: 3276
18:21:30.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405397 30838 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
18:21:30.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405786 30838 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
18:21:30.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405821 30838 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
18:21:30.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405851 30838 ts_tablet_manager.cc:616] Registered 0 tablets
18:21:30.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.405869 30838 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
18:21:30.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.412086 30838 rpc_server.cc:307] RPC server started. Bound to: 127.29.10.131:39689
18:21:30.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.412142 31082 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.29.10.131:39689 every 8 connection(s)
18:21:30.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.412516 30838 server_base.cc:1193] Dumped server information to /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/data/info.pb
18:21:30.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.412652 29738 external_mini_cluster.cc:1434] Started /tmp/dist-test-task_Dmqc5/build/release/bin/kudu as pid 30838
18:21:30.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.412736 29738 external_mini_cluster.cc:1448] Reading /tmp/dist-test-task_Dmqc5/test-tmp/mini-kudu-cluster6218852258189559840/ts-2/wal/instance
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418151 31088 heartbeater.cc:344] Connected to a master server at 127.29.10.190:39897
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418273 31088 heartbeater.cc:461] Registering TS with master...
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418345 31089 heartbeater.cc:344] Connected to a master server at 127.29.10.189:42713
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418408 31089 heartbeater.cc:461] Registering TS with master...
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418474 31088 heartbeater.cc:507] Master 127.29.10.190:39897 requested a full tablet report, sending...
18:21:30.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418483 31089 heartbeater.cc:507] Master 127.29.10.189:42713 requested a full tablet report, sending...
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418669 31083 heartbeater.cc:344] Connected to a master server at 127.29.10.188:34349
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418712 31083 heartbeater.cc:461] Registering TS with master...
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418792 31083 heartbeater.cc:507] Master 127.29.10.188:34349 requested a full tablet report, sending...
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418926 29817 ts_manager.cc:194] Registered new tserver with Master: b3e113c781554427bfaa96d0a45ca079 (127.29.10.131:39689)
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.418916 29968 ts_manager.cc:194] Registered new tserver with Master: b3e113c781554427bfaa96d0a45ca079 (127.29.10.131:39689)
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.419083 30113 ts_manager.cc:194] Registered new tserver with Master: b3e113c781554427bfaa96d0a45ca079 (127.29.10.131:39689)
18:21:30.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.419401 29968 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.29.10.131:39247
18:21:30.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.428831 29738 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
18:21:30.429 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
18:21:30.431 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

18:21:30.440 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.29.10.190"
      port: 39897
    }
    bound_http_address {
      host: "127.29.10.190"
      port: 42951
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.29.10.189"
      port: 42713
    }
    bound_http_address {
      host: "127.29.10.189"
      port: 43391
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.29.10.188"
      port: 34349
    }
    bound_http_address {
      host: "127.29.10.188"
      port: 37407
    }
  }
}

18:21:30.444 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_tservers {
}

18:21:30.447 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.29.10.129"
      port: 33759
    }
    bound_http_address {
      host: "127.29.10.129"
      port: 40041
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.29.10.130"
      port: 45947
    }
    bound_http_address {
      host: "127.29.10.130"
      port: 42529
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.29.10.131"
      port: 39689
    }
    bound_http_address {
      host: "127.29.10.131"
      port: 44117
    }
  }
}

18:21:30.447 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
18:21:30.668 [DEBUG - main] (CompositeStrategy.java:59) Unable to load modern Subject methods, relying only on legacy methods
java.lang.NoSuchMethodException: javax.security.auth.Subject.current()
	at java.base/java.lang.Class.getDeclaredMethod(Class.java:2677)
	at org.apache.kudu.client.internals.ModernStrategy.<init>(ModernStrategy.java:51)
	at org.apache.kudu.client.internals.CompositeStrategy.<init>(CompositeStrategy.java:52)
	at org.apache.kudu.client.internals.CompositeStrategy.<clinit>(CompositeStrategy.java:41)
	at org.apache.kudu.client.internals.SecurityManagerCompatibility.get(SecurityManagerCompatibility.java:43)
	at org.apache.kudu.client.SecurityContext.setupSubject(SecurityContext.java:155)
	at org.apache.kudu.client.SecurityContext.<init>(SecurityContext.java:138)
	at org.apache.kudu.client.AsyncKuduClient.<init>(AsyncKuduClient.java:431)
	at org.apache.kudu.client.AsyncKuduClient$AsyncKuduClientBuilder.build(AsyncKuduClient.java:3109)
	at org.apache.kudu.test.KuduTestHarness.before(KuduTestHarness.java:161)
	at org.junit.rules.ExternalResource$1.evaluate(ExternalResource.java:50)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.doOneAttempt(RetryRule.java:225)
	at org.apache.kudu.test.junit.RetryRule$RetryStatement.evaluate(RetryRule.java:246)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.BlockJUnit4ClassRunner$1.evaluate(BlockJUnit4ClassRunner.java:100)
	at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:366)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:103)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:63)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runners.Suite.runChild(Suite.java:128)
	at org.junit.runners.Suite.runChild(Suite.java:27)
	at org.junit.runners.ParentRunner$4.run(ParentRunner.java:331)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:79)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:329)
	at org.junit.runners.ParentRunner.access$100(ParentRunner.java:66)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:293)
	at org.junit.runners.ParentRunner$3.evaluate(ParentRunner.java:306)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:413)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:137)
	at org.junit.runner.JUnitCore.run(JUnitCore.java:115)
	at org.junit.runner.JUnitCore.runMain(JUnitCore.java:77)
	at org.junit.runner.JUnitCore.main(JUnitCore.java:36)
18:21:30.723 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
18:21:30.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.782069 30243 catalog_manager.cc:1295] Loaded cluster ID: 293b243eac554d90a1ed1ca639a4fa73
18:21:30.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.782166 30243 catalog_manager.cc:1588] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: loading cluster ID for follower catalog manager: success
18:21:30.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.783537 30243 catalog_manager.cc:1610] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: acquiring CA information for follower catalog manager: success
18:21:30.784 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.783921 30243 catalog_manager.cc:1638] T 00000000000000000000000000000000 P 70ea3f3542134c21872a2a5241acd261: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:21:30.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.840124 30283 catalog_manager.cc:1295] Loaded cluster ID: 293b243eac554d90a1ed1ca639a4fa73
18:21:30.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.840224 30283 catalog_manager.cc:1588] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: loading cluster ID for follower catalog manager: success
18:21:30.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.841558 30283 catalog_manager.cc:1610] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: acquiring CA information for follower catalog manager: success
18:21:30.842 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:30.841897 30283 catalog_manager.cc:1638] T 00000000000000000000000000000000 P c624188932b94255aceb89813bcf6942: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
18:21:30.884 [DEBUG - main] (Connection.java:748) [peer master-127.29.10.190:39897(127.29.10.190:39897)] connecting to peer
18:21:30.936 [DEBUG - main] (Connection.java:748) [peer master-127.29.10.189:42713(127.29.10.189:42713)] connecting to peer
18:21:30.938 [DEBUG - main] (Connection.java:748) [peer master-127.29.10.188:34349(127.29.10.188:34349)] connecting to peer
18:21:30.956 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.29.10.190:39897(127.29.10.190:39897)] Successfully connected to peer
18:21:30.956 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.29.10.188:34349(127.29.10.188:34349)] Successfully connected to peer
18:21:30.956 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.29.10.189:42713(127.29.10.189:42713)] Successfully connected to peer
18:21:31.047 [DEBUG - kudu-nio-1] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.29.10.189
18:21:31.047 [DEBUG - kudu-nio-0] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.29.10.190
18:21:31.048 [DEBUG - kudu-nio-2] (Negotiator.java:528) SASL mechanism PLAIN chosen for peer 127.29.10.188
18:21:31.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.145807 30551 heartbeater.cc:499] Master 127.29.10.189:42713 was elected leader, sending a full tablet report...
18:21:31.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.289252 30830 heartbeater.cc:499] Master 127.29.10.189:42713 was elected leader, sending a full tablet report...
18:21:31.292 [DEBUG - kudu-nio-1] (Negotiator.java:918) Authenticated connection [id: 0xdc749e54, L:/127.0.0.1:60452 - R:/127.29.10.189:42713] using SASL/PLAIN
18:21:31.292 [DEBUG - kudu-nio-2] (Negotiator.java:918) Authenticated connection [id: 0xa1aed7b1, L:/127.0.0.1:43474 - R:/127.29.10.188:34349] using SASL/PLAIN
18:21:31.292 [DEBUG - kudu-nio-0] (Negotiator.java:918) Authenticated connection [id: 0x24686e03, L:/127.0.0.1:37090 - R:/127.29.10.190:39897] using SASL/PLAIN
18:21:31.330 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
18:21:31.331 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=484), Traces: [0ms] refreshing cache from master, [22ms] Sub RPC ConnectToMaster: sending RPC to server master-127.29.10.190:39897, [85ms] Sub RPC ConnectToMaster: sending RPC to server master-127.29.10.189:42713, [86ms] Sub RPC ConnectToMaster: sending RPC to server master-127.29.10.188:34349, [455ms] Sub RPC ConnectToMaster: received response from server master-127.29.10.188:34349: OK, [455ms] Sub RPC ConnectToMaster: received response from server master-127.29.10.190:39897: OK, [455ms] Sub RPC ConnectToMaster: received response from server master-127.29.10.189:42713: OK, deferred=null) after lookup
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.388181 29968 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:60452:
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1786472488862"
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
18:21:31.389 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
18:21:31.390 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:31.388546 29968 catalog_manager.cc:7099] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table org.apache.kudu.client.TestHybridTime-1786472488862 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
18:21:31.399 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.399550 30687 tablet_service.cc:1511] Processing CreateTablet for tablet d76b7adb89d843df90689a004096d40b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786472488862 [id=83d8027d0e154f9cb89276025a158116]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:31.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.399881 30687 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d76b7adb89d843df90689a004096d40b. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:31.402 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.402355 31156 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Bootstrap starting.
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.402777 30954 tablet_service.cc:1511] Processing CreateTablet for tablet d76b7adb89d843df90689a004096d40b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786472488862 [id=83d8027d0e154f9cb89276025a158116]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.402860 30423 tablet_service.cc:1511] Processing CreateTablet for tablet d76b7adb89d843df90689a004096d40b (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1786472488862 [id=83d8027d0e154f9cb89276025a158116]), partition=RANGE (key) PARTITION UNBOUNDED
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.403086 30954 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d76b7adb89d843df90689a004096d40b. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.403118 30423 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d76b7adb89d843df90689a004096d40b. 1 dirs total, 0 dirs full, 0 dirs failed
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.403271 31156 tablet_bootstrap.cc:654] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Neither blocks nor log segments found. Creating new log.
18:21:31.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.403610 31156 log.cc:826] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Log is configured to *not* fsync() on all Append() calls
18:21:31.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.404539 31156 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: No bootstrap required, opened a new log
18:21:31.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.404626 31156 ts_tablet_manager.cc:1403] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
18:21:31.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.405524 31168 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: Bootstrap starting.
18:21:31.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.405915 31169 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: Bootstrap starting.
18:21:31.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.406263 31156 raft_consensus.cc:359] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.406407 31168 tablet_bootstrap.cc:654] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: Neither blocks nor log segments found. Creating new log.
18:21:31.406 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.406702 31168 log.cc:826] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: Log is configured to *not* fsync() on all Append() calls
18:21:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.406765 31169 tablet_bootstrap.cc:654] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: Neither blocks nor log segments found. Creating new log.
18:21:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.407040 31169 log.cc:826] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: Log is configured to *not* fsync() on all Append() calls
18:21:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.407536 31156 raft_consensus.cc:385] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:31.407 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.407605 31156 raft_consensus.cc:740] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0cdf25346c454e70bf47678afe9caed4, State: Initialized, Role: FOLLOWER
18:21:31.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.407742 31156 consensus_queue.cc:260] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.408905 31156 ts_tablet_manager.cc:1434] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Time spent starting tablet: real 0.004s	user 0.003s	sys 0.000s
18:21:31.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.412147 31169 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: No bootstrap required, opened a new log
18:21:31.412 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.412575 31169 ts_tablet_manager.cc:1403] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: Time spent bootstrapping tablet: real 0.007s	user 0.002s	sys 0.000s
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.414405 31168 tablet_bootstrap.cc:492] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: No bootstrap required, opened a new log
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.414494 31168 ts_tablet_manager.cc:1403] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: Time spent bootstrapping tablet: real 0.009s	user 0.001s	sys 0.001s
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.416177 31168 raft_consensus.cc:359] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.416354 31168 raft_consensus.cc:385] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.416383 31168 raft_consensus.cc:740] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 141885861f854391a2f14d1f7e417ccc, State: Initialized, Role: FOLLOWER
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.416504 31168 consensus_queue.cc:260] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.417 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.416805 31168 ts_tablet_manager.cc:1434] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc: Time spent starting tablet: real 0.002s	user 0.001s	sys 0.001s
18:21:31.418 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.418658 31169 raft_consensus.cc:359] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.419071 31169 raft_consensus.cc:385] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
18:21:31.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.419153 31169 raft_consensus.cc:740] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: b3e113c781554427bfaa96d0a45ca079, State: Initialized, Role: FOLLOWER
18:21:31.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.419275 31169 consensus_queue.cc:260] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.419595 31169 ts_tablet_manager.cc:1434] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079: Time spent starting tablet: real 0.007s	user 0.002s	sys 0.000s
18:21:31.420 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.419953 31089 heartbeater.cc:499] Master 127.29.10.189:42713 was elected leader, sending a full tablet report...
18:21:31.424 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 83d8027d0e154f9cb89276025a158116
18:21:31.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.445991 31174 raft_consensus.cc:493] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
18:21:31.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.446134 31174 raft_consensus.cc:515] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.446506 31174 leader_election.cc:290] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 141885861f854391a2f14d1f7e417ccc (127.29.10.129:33759), b3e113c781554427bfaa96d0a45ca079 (127.29.10.131:39689)
18:21:31.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.450328 30457 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d76b7adb89d843df90689a004096d40b" candidate_uuid: "0cdf25346c454e70bf47678afe9caed4" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "141885861f854391a2f14d1f7e417ccc" is_pre_election: true
18:21:31.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.450555 30457 raft_consensus.cc:2468] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 0cdf25346c454e70bf47678afe9caed4 in term 0.
18:21:31.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.450992 30602 leader_election.cc:304] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [CANDIDATE]: Term 1 pre-election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 0cdf25346c454e70bf47678afe9caed4, 141885861f854391a2f14d1f7e417ccc; no voters: 
18:21:31.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.451161 31174 raft_consensus.cc:2804] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Leader pre-election won for term 1
18:21:31.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.451212 31174 raft_consensus.cc:493] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
18:21:31.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.451233 31174 raft_consensus.cc:3060] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 0 FOLLOWER]: Advancing to term 1
18:21:31.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.451483 30997 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d76b7adb89d843df90689a004096d40b" candidate_uuid: "0cdf25346c454e70bf47678afe9caed4" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b3e113c781554427bfaa96d0a45ca079" is_pre_election: true
18:21:31.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.451643 30997 raft_consensus.cc:2468] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 0cdf25346c454e70bf47678afe9caed4 in term 0.
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.452172 31174 raft_consensus.cc:515] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.452320 31174 leader_election.cc:290] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [CANDIDATE]: Term 1 election: Requested vote from peers 141885861f854391a2f14d1f7e417ccc (127.29.10.129:33759), b3e113c781554427bfaa96d0a45ca079 (127.29.10.131:39689)
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.452689 30997 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d76b7adb89d843df90689a004096d40b" candidate_uuid: "0cdf25346c454e70bf47678afe9caed4" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "b3e113c781554427bfaa96d0a45ca079"
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.452792 30997 raft_consensus.cc:3060] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 0 FOLLOWER]: Advancing to term 1
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.453084 30457 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d76b7adb89d843df90689a004096d40b" candidate_uuid: "0cdf25346c454e70bf47678afe9caed4" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "141885861f854391a2f14d1f7e417ccc"
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.453215 30457 raft_consensus.cc:3060] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 0 FOLLOWER]: Advancing to term 1
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.453941 30997 raft_consensus.cc:2468] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 0cdf25346c454e70bf47678afe9caed4 in term 1.
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.454262 30598 leader_election.cc:304] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 2 responses out of 3 voters: 2 yes votes; 0 no votes. yes voters: 0cdf25346c454e70bf47678afe9caed4, b3e113c781554427bfaa96d0a45ca079; no voters: 
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.454381 31174 raft_consensus.cc:2804] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 1 FOLLOWER]: Leader election won for term 1
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.454633 31174 raft_consensus.cc:697] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [term 1 LEADER]: Becoming Leader. State: Replica: 0cdf25346c454e70bf47678afe9caed4, State: Running, Role: LEADER
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.454733 30457 raft_consensus.cc:2468] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 0cdf25346c454e70bf47678afe9caed4 in term 1.
18:21:31.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.454756 31174 consensus_queue.cc:237] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 2, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } }
18:21:31.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.455965 29968 catalog_manager.cc:5719] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 reported cstate change: term changed from 0 to 1, leader changed from <none> to 0cdf25346c454e70bf47678afe9caed4 (127.29.10.130). New cstate: current_term: 1 leader_uuid: "0cdf25346c454e70bf47678afe9caed4" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "0cdf25346c454e70bf47678afe9caed4" member_type: VOTER last_known_addr { host: "127.29.10.130" port: 45947 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 } health_report { overall_health: UNKNOWN } } }
18:21:31.499 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet d76b7adb89d843df90689a004096d40b for table 'org.apache.kudu.client.TestHybridTime-1786472488862' with partition [<start>, <end>)
18:21:31.505 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=d76b7adb89d843df90689a004096d40b@[0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)[L],141885861f854391a2f14d1f7e417ccc(127.29.10.129:33759),b3e113c781554427bfaa96d0a45ca079(127.29.10.131:39689)]}]
18:21:31.507 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=16), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.29.10.189:42713, [7ms] Sub RPC GetTableLocations: received response from server master-127.29.10.189:42713: OK, deferred=null) after lookup
18:21:31.517 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)] connecting to peer
18:21:31.520 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)] Successfully connected to peer
18:21:31.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:31.531358 30833 tablet.cc:2406] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4: Can't schedule compaction. Clean time has not been advanced past its initial value.
18:21:31.619 [DEBUG - kudu-nio-3] (Negotiator.java:918) Authenticated connection [id: 0x03095937, L:/127.0.0.1:39024 - R:/127.29.10.130:45947] using TOKEN/null
18:21:31.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.623203 30997 raft_consensus.cc:1275] T d76b7adb89d843df90689a004096d40b P b3e113c781554427bfaa96d0a45ca079 [term 1 FOLLOWER]: Refusing update from remote peer 0cdf25346c454e70bf47678afe9caed4: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:31.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.623203 30457 raft_consensus.cc:1275] T d76b7adb89d843df90689a004096d40b P 141885861f854391a2f14d1f7e417ccc [term 1 FOLLOWER]: Refusing update from remote peer 0cdf25346c454e70bf47678afe9caed4: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
18:21:31.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.623600 31174 consensus_queue.cc:1048] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [LEADER]: Connected to new peer: Peer: permanent_uuid: "141885861f854391a2f14d1f7e417ccc" member_type: VOTER last_known_addr { host: "127.29.10.129" port: 33759 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:31.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.624486 31174 consensus_queue.cc:1048] T d76b7adb89d843df90689a004096d40b P 0cdf25346c454e70bf47678afe9caed4 [LEADER]: Connected to new peer: Peer: permanent_uuid: "b3e113c781554427bfaa96d0a45ca079" member_type: VOTER last_known_addr { host: "127.29.10.131" port: 39689 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
18:21:31.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.627907 31196 mvcc.cc:204] Tried to move back new op lower bound from 7317391325685227520 to 7317391324999405568. Current Snapshot: MvccSnapshot[applied={T|T < 7317391325685227520}]
18:21:31.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.628464 31198 mvcc.cc:204] Tried to move back new op lower bound from 7317391325685227520 to 7317391324999405568. Current Snapshot: MvccSnapshot[applied={T|T < 7317391325685227520}]
18:21:31.664 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.676 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.680 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.684 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@410793571(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:31.693 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.693 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@915265743(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:31.698 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.699 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1814406365(state=PENDING, result=null, callback=<none>, errback=<none>)}
18:21:31.704 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
18:21:31.751 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.760 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7317391346165227521) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.764 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7317391346165227525) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.769 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7317391346165227529) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.775 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7317391346165227533) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.779 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7317391346165227537) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.783 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7317391346165227541) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.787 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7317391346165227542) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1786472488862, tablet=d76b7adb89d843df90689a004096d40b, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
18:21:31.790 [DEBUG - main] (Connection.java:575) [peer 0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)] disconnecting while in state READY
18:21:31.797 [DEBUG - main] (Connection.java:575) [peer master-127.29.10.188:34349(127.29.10.188:34349)] disconnecting while in state READY
18:21:31.797 [DEBUG - main] (Connection.java:575) [peer master-127.29.10.190:39897(127.29.10.190:39897)] disconnecting while in state READY
18:21:31.804 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.29.10.190:39897(127.29.10.190:39897)] handling channelInactive
18:21:31.805 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.29.10.188:34349(127.29.10.188:34349)] handling channelInactive
18:21:31.805 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.29.10.188:34349(127.29.10.188:34349)] cleaning up while in state READY due to: connection closed
18:21:31.806 [DEBUG - main] (Connection.java:575) [peer master-127.29.10.189:42713(127.29.10.189:42713)] disconnecting while in state READY
18:21:31.807 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.29.10.190:39897(127.29.10.190:39897)] cleaning up while in state READY due to: connection closed
18:21:31.808 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.29.10.189:42713(127.29.10.189:42713)] handling channelInactive
18:21:31.808 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.29.10.189:42713(127.29.10.189:42713)] cleaning up while in state READY due to: connection closed
18:21:31.810 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
18:21:31.848 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)] handling channelInactive
18:21:31.848 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 0cdf25346c454e70bf47678afe9caed4(127.29.10.130:45947)] cleaning up while in state READY due to: connection closed
18:21:31.851 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.851258 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 30314
18:21:31.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.870007 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 30561
18:21:31.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.885267 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 30838
18:21:31.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.900029 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 29757
18:21:31.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260811 18:21:31.923396 29945 connection.cc:573] client connection to 127.29.10.190:39897 recv error: Network error: recv error from unknown peer: Transport endpoint is not connected (error 107)
18:21:31.923 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.923733 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 29908
18:21:31.935 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260811 18:21:31.935708 29738 external_mini_cluster.cc:1664] Killing /tmp/dist-test-task_Dmqc5/build/release/bin/kudu with pid 30046
18:21:31.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-08-11T18:21:31Z chronyd exiting

Time: 3.033

OK (1 test)

