JUnit version 4.13.2
.21:00:17.079 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783544417069
21:00:17.106 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
21:00:17.152 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
21:00:17.164 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskyULM3n/test-tmp
21:00:17.200 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/asan/bin
21:00:17.204 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskyULM3n/java/build/dist-test/../../../build/asan/bin/kudu, test, mini_cluster, --serialization=pb]
21:00:17.450 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

21:00:17.652 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
21:00:17.653 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

21:00:17.658 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:17.658049 10873 mini_oidc.cc:150] Starting JWKS server
21:00:17.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:17.661676 10873 webserver.cc:534] Webserver started at http://127.0.0.1:39985/ using document root <none> and password file <none>
21:00:17.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:17.662055 10873 mini_oidc.cc:186] Starting OIDC Discovery server
21:00:17.663 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:17.663527 10873 webserver.cc:534] Webserver started at http://127.0.0.1:35711/ using document root <none> and password file <none>
21:00:17.685 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:00:17Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
21:00:17.686 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:00:17Z Disabled control of system clock
21:00:17.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:17.696784 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:17.697 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:17.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal
21:00:17.698 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data
21:00:17.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:17.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:17.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:17.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:17.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:17.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:17.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/logs
21:00:17.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data/info.pb
21:00:17.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:17.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:17.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:17.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:17.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.126:42155
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.126
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:17.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:17.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:17.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:17.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:17.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json with env {}
21:00:18.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.065857 10884 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:18.066 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.066239 10884 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:18.067 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.066332 10884 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:18.075 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075059 10884 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:00:18.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075196 10884 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:18.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075280 10884 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:00:18.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075326 10884 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:00:18.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075378 10884 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:00:18.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.075417 10884 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39985/jwks.json
21:00:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.086524 10884 master_runner.cc:387] Master server non-default flags:
21:00:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:18.087 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:18.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.126:42155
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:18.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data/info.pb
21:00:18.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.126
21:00:18.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:18.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:18.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/logs
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:18.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:18.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:18.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.088650 10884 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:18.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.091213 10884 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:18.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.101652 10890 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
21:00:18.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.101605 10889 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
21:00:18.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.102030 10892 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
21:00:18.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.103601 10884 server_base.cc:1061] running on GCE node
21:00:18.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.104633 10884 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:18.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.106576 10884 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.107897 10884 hybrid_clock.cc:648] HybridClock initialized: now 1783544418107829 us; error 53 us; skew 500 ppm
21:00:18.108 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.108522 10884 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:18.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.112268 10884 webserver.cc:534] Webserver started at http://127.10.158.126:42381/ using document root <none> and password file <none>
21:00:18.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.113458 10884 fs_manager.cc:362] Metadata directory not provided
21:00:18.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.113628 10884 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:18.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.114194 10884 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:18.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.117247 10884 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data/instance:
21:00:18.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b400a59bcea43f4b91321d6c7c547ee"
21:00:18.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.118369 10884 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal/instance:
21:00:18.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b400a59bcea43f4b91321d6c7c547ee"
21:00:18.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.125460 10884 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.000s
21:00:18.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.129915 10898 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:18.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.131572 10884 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.005s	sys 0.000s
21:00:18.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.131778 10884 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal
21:00:18.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "5b400a59bcea43f4b91321d6c7c547ee"
21:00:18.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.131987 10884 fs_report.cc:389] FS layout report
21:00:18.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:18.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal
21:00:18.133 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal
21:00:18.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data/data
21:00:18.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:18.134 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:18.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:18.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:18.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:18.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:18.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:18.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:18.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:18.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:18.136 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:18.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.153684 10884 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:18.154 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.154668 10884 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:18.155 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.154922 10884 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:18.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.175678 10884 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.126:42155
21:00:18.176 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.175698 10949 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.126:42155 every 8 connection(s)
21:00:18.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.177477 10884 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/data/info.pb
21:00:18.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.182547 10950 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:18.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.188522 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 10884
21:00:18.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.189038 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-0/wal/instance
21:00:18.191 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.189970 10950 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.192 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.192538 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:18.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:18.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal
21:00:18.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data
21:00:18.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:18.194 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:18.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:18.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:18.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:18.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:18.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/logs
21:00:18.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data/info.pb
21:00:18.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:18.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:18.197 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:18.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:00:18.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:18.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:18.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:18.198 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.125:39521
21:00:18.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.125
21:00:18.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:18.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:18.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:18.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:18.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:18.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:18.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:18.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:18.200 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json with env {}
21:00:18.218 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.218343 10950 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.220 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.219696 10900 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.222 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.221645 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.125:39521: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.271057 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } attempt: 1
21:00:18.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.273270 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.125:39521: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.341617 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } attempt: 2
21:00:18.344 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.344046 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.125:39521: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.436 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.435379 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } attempt: 3
21:00:18.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.437997 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.125:39521: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.565815 10954 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:18.566 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.566184 10954 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:18.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.566278 10954 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:18.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575218 10954 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:00:18.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575344 10954 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:18.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575398 10954 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:00:18.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575438 10954 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:00:18.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575498 10954 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:00:18.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.575531 10954 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39985/jwks.json
21:00:18.581 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.581342 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } attempt: 4
21:00:18.584 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.583969 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.125:39521: Network error: Client connection negotiation failed: client connection to 127.10.158.125:39521: connect: Connection refused (error 111)
21:00:18.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.593032 10954 master_runner.cc:387] Master server non-default flags:
21:00:18.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:18.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:18.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:18.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:18.594 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.125:39521
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:18.595 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data/info.pb
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.125
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:18.596 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:18.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:18.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:18.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:18.597 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/logs
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:18.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:18.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:18.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:18.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:18.599 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.595765 10954 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:18.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.599175 10954 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:18.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.611130 10960 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
21:00:18.612 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.611163 10961 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
21:00:18.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.613747 10963 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
21:00:18.614 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.613747 10954 server_base.cc:1061] running on GCE node
21:00:18.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.615267 10954 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:18.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.617712 10954 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:18.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.618985 10954 hybrid_clock.cc:648] HybridClock initialized: now 1783544418618910 us; error 65 us; skew 500 ppm
21:00:18.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.619587 10954 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:18.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.622494 10954 webserver.cc:534] Webserver started at http://127.10.158.125:42775/ using document root <none> and password file <none>
21:00:18.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.623621 10954 fs_manager.cc:362] Metadata directory not provided
21:00:18.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.623771 10954 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:18.624 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.624333 10954 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:18.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.627584 10954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data/instance:
21:00:18.628 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "887a44c0c6894bde86ffdbd9fd39acba"
21:00:18.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.628770 10954 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal/instance:
21:00:18.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "887a44c0c6894bde86ffdbd9fd39acba"
21:00:18.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.636548 10954 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.007s	sys 0.001s
21:00:18.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.641486 10969 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:18.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.643733 10954 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.004s	sys 0.000s
21:00:18.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.644001 10954 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal
21:00:18.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "887a44c0c6894bde86ffdbd9fd39acba"
21:00:18.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:18 on dist-test-slave-4mx2"
21:00:18.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.644364 10954 fs_report.cc:389] FS layout report
21:00:18.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:18.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal
21:00:18.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data/data
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:18.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:18.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:18.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:18.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:18.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:18.664 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.664206 10954 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:18.665 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.665390 10954 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:18.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.665714 10954 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:18.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.687563 10954 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.125:39521
21:00:18.688 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.687577 11020 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.125:39521 every 8 connection(s)
21:00:18.689 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.689563 10954 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/data/info.pb
21:00:18.696 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.695691 11021 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:18.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.698691 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 10954
21:00:18.699 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.698897 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-1/wal/instance
21:00:18.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.700287 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:18.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:18.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/logs
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data/info.pb
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:18.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:18.703 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.124:33135
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.124
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:18.704 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:18.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:18.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:18.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:18.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:18.705 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json with env {}
21:00:18.708 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.705618 11021 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.727103 11021 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.741010 11021 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.743659 10973 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.748 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.746263 11021 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.795795 11021 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 1
21:00:18.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.799108 11021 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.868 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.867429 11021 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 2
21:00:18.870 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.870221 11021 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.883 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.883313 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } attempt: 5
21:00:18.890 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.890369 10950 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } has no permanent_uuid. Determining permanent_uuid...
21:00:18.893 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.893476 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.945 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.944746 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 1
21:00:18.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.946969 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:18.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:18.961552 11021 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 3
21:00:18.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:18.963697 11021 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:19.015 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.015224 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 2
21:00:19.018 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.017748 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:19.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.103461 11023 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:19.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.103816 11023 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:19.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.103900 11023 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:19.107 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.106953 11021 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 4
21:00:19.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.109021 11021 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:19.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113106 11023 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:00:19.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113209 11023 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:19.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113261 11023 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:00:19.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113302 11023 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:00:19.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113358 11023 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:00:19.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.113390 11023 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:39985/jwks.json
21:00:19.124 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.124037 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 3
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.124598 11023 master_runner.cc:387] Master server non-default flags:
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal
21:00:19.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.124:33135
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:00:19.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:39985/jwks.json
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data/info.pb
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.124
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:19.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/logs
21:00:19.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:19.129 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:19.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:19.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.126628 10950 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.10.158.124:33135: Network error: Client connection negotiation failed: client connection to 127.10.158.124:33135: connect: Connection refused (error 111)
21:00:19.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.126700 11023 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:19.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.128846 11023 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:19.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.139209 11032 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
21:00:19.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.139375 11031 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
21:00:19.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.139580 11034 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
21:00:19.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.140525 11023 server_base.cc:1061] running on GCE node
21:00:19.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.141472 11023 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:19.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.143253 11023 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:19.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.144513 11023 hybrid_clock.cc:648] HybridClock initialized: now 1783544419144454 us; error 58 us; skew 500 ppm
21:00:19.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.144912 11023 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:19.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.148203 11023 webserver.cc:534] Webserver started at http://127.10.158.124:45873/ using document root <none> and password file <none>
21:00:19.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.149127 11023 fs_manager.cc:362] Metadata directory not provided
21:00:19.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.149240 11023 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:19.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.149616 11023 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.152493 11023 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data/instance:
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9bdf7bf2857044febf77f5b78ccf8a40"
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:19 on dist-test-slave-4mx2"
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.153441 11023 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal/instance:
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9bdf7bf2857044febf77f5b78ccf8a40"
21:00:19.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:19 on dist-test-slave-4mx2"
21:00:19.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.162283 11023 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.005s	sys 0.004s
21:00:19.166 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.166548 11040 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:19.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.168406 11023 fs_manager.cc:730] Time spent opening block manager: real 0.004s	user 0.001s	sys 0.001s
21:00:19.168 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.168610 11023 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "9bdf7bf2857044febf77f5b78ccf8a40"
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:19 on dist-test-slave-4mx2"
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.168805 11023 fs_report.cc:389] FS layout report
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data/data
21:00:19.169 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:19.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:19.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:19.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:19.202 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.201710 11023 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:19.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.202759 11023 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:19.203 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.203037 11023 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:19.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.225201 11091 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.124:33135 every 8 connection(s)
21:00:19.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.225261 11023 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.124:33135
21:00:19.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.227108 11023 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/data/info.pb
21:00:19.232 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.232256 11092 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:19.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.234215 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 11023
21:00:19.234 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.234391 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/master-2/wal/instance
21:00:19.241 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.240324 11092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } has no permanent_uuid. Determining permanent_uuid...
21:00:19.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.258718 11092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } has no permanent_uuid. Determining permanent_uuid...
21:00:19.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.266731 11092 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } has no permanent_uuid. Determining permanent_uuid...
21:00:19.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.279508 11092 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: Bootstrap starting.
21:00:19.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.283840 11092 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: Neither blocks nor log segments found. Creating new log.
21:00:19.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.285212 11092 log.cc:826] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: Log is configured to *not* fsync() on all Append() calls
21:00:19.289 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.288602 11092 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: No bootstrap required, opened a new log
21:00:19.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.294757 11092 raft_consensus.cc:359] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.295117 11092 raft_consensus.cc:385] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:19.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.295204 11092 raft_consensus.cc:740] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9bdf7bf2857044febf77f5b78ccf8a40, State: Initialized, Role: FOLLOWER
21:00:19.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.296151 11092 consensus_queue.cc:260] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.297533 11102 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.298 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.297803 11102 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.298947 11092 sys_catalog.cc:565] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: configured and running, proceeding with master startup.
21:00:19.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.303867 10950 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 4
21:00:19.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.306792 11023 master_runner.cc:187] Error getting master registration for 127.10.158.126:42155: OK, instance_id { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" instance_seqno: 1783544418169895 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
21:00:19.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.313898 11023 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
21:00:19.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.315109 11113 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
21:00:19.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.315272 11113 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
21:00:19.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.317663 10950 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: Bootstrap starting.
21:00:19.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.321449 10950 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: Neither blocks nor log segments found. Creating new log.
21:00:19.322 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.322641 10950 log.cc:826] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: Log is configured to *not* fsync() on all Append() calls
21:00:19.325 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.325510 10950 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: No bootstrap required, opened a new log
21:00:19.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.333851 10950 raft_consensus.cc:359] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.334211 10950 raft_consensus.cc:385] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:19.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.334298 10950 raft_consensus.cc:740] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 5b400a59bcea43f4b91321d6c7c547ee, State: Initialized, Role: FOLLOWER
21:00:19.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.334959 10950 consensus_queue.cc:260] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.335908 11116 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.336220 11116 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.337349 10950 sys_catalog.cc:565] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: configured and running, proceeding with master startup.
21:00:19.359 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.350457 10884 master_runner.cc:187] Error getting master registration for 127.10.158.125:39521: OK, instance_id { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" instance_seqno: 1783544418681651 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
21:00:19.360 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.360519 10884 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
21:00:19.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.361645 11127 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
21:00:19.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.362040 11127 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
21:00:19.408 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.408236 10904 tablet.cc:2406] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:00:19.409 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.408253 11021 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } attempt: 5
21:00:19.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.418449 11102 raft_consensus.cc:493] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
21:00:19.428 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.418807 11102 raft_consensus.cc:515] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.420432 11021 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: Bootstrap starting.
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.421021 11102 leader_election.cc:290] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 5b400a59bcea43f4b91321d6c7c547ee (127.10.158.126:42155), 887a44c0c6894bde86ffdbd9fd39acba (127.10.158.125:39521)
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.423312 10925 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5b400a59bcea43f4b91321d6c7c547ee" is_pre_election: true
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.424008 10925 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 9bdf7bf2857044febf77f5b78ccf8a40 in term 0.
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.425081 11042 leader_election.cc:304] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [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: 5b400a59bcea43f4b91321d6c7c547ee, 9bdf7bf2857044febf77f5b78ccf8a40; no voters: 
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.425455 11021 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: Neither blocks nor log segments found. Creating new log.
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.425679 11102 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Leader pre-election won for term 1
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.425856 11102 raft_consensus.cc:493] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
21:00:19.429 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.425987 11102 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 0 FOLLOWER]: Advancing to term 1
21:00:19.430 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.427137 11021 log.cc:826] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: Log is configured to *not* fsync() on all Append() calls
21:00:19.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.432750 11102 raft_consensus.cc:515] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.444 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.437081 11102 leader_election.cc:290] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [CANDIDATE]: Term 1 election: Requested vote from peers 5b400a59bcea43f4b91321d6c7c547ee (127.10.158.126:42155), 887a44c0c6894bde86ffdbd9fd39acba (127.10.158.125:39521)
21:00:19.447 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.438374 10925 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "5b400a59bcea43f4b91321d6c7c547ee"
21:00:19.450 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.438699 10925 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 0 FOLLOWER]: Advancing to term 1
21:00:19.451 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.446682 10925 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 9bdf7bf2857044febf77f5b78ccf8a40 in term 1.
21:00:19.459 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.449045 11042 leader_election.cc:304] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [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: 5b400a59bcea43f4b91321d6c7c547ee, 9bdf7bf2857044febf77f5b78ccf8a40; no voters: 
21:00:19.460 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:19.455641 11046 tablet.cc:2406] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:00:19.463 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.460482 11102 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 1 FOLLOWER]: Leader election won for term 1
21:00:19.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.460749 11102 raft_consensus.cc:697] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [term 1 LEADER]: Becoming Leader. State: Replica: 9bdf7bf2857044febf77f5b78ccf8a40, State: Running, Role: LEADER
21:00:19.464 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.461474 11102 consensus_queue.cc:237] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.471828 11130 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 9bdf7bf2857044febf77f5b78ccf8a40. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.473 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.472369 11130 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: This master's current role is: LEADER
21:00:19.484 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.482956 11021 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: No bootstrap required, opened a new log
21:00:19.486 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.486317 11132 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
21:00:19.490 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.490209 11132 catalog_manager.cc:1519] Initializing Kudu cluster ID...
21:00:19.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.515733 11021 raft_consensus.cc:359] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.524984 11021 raft_consensus.cc:385] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:19.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.526165 11021 raft_consensus.cc:740] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 887a44c0c6894bde86ffdbd9fd39acba, State: Initialized, Role: FOLLOWER
21:00:19.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.532353 11021 consensus_queue.cc:260] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } }
21:00:19.536 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.535923 11134 sys_catalog.cc:455] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [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: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.537 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.536636 10925 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [term 1 FOLLOWER]: Refusing update from remote peer 9bdf7bf2857044febf77f5b78ccf8a40: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:00:19.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.539501 11130 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [LEADER]: Connected to new peer: Peer: permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:00:19.541 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.541492 11134 sys_catalog.cc:458] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.547775 11021 sys_catalog.cc:565] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: configured and running, proceeding with master startup.
21:00:19.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.548345 10994 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 0 FOLLOWER]: Advancing to term 1
21:00:19.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.555473 10994 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 1 FOLLOWER]: Refusing update from remote peer 9bdf7bf2857044febf77f5b78ccf8a40: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:00:19.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.547782 10996 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "887a44c0c6894bde86ffdbd9fd39acba" is_pre_election: true
21:00:19.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.556433 10996 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 1 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 9bdf7bf2857044febf77f5b78ccf8a40 in term 1.
21:00:19.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.548820 10995 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "887a44c0c6894bde86ffdbd9fd39acba"
21:00:19.565 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.560665 10995 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 9bdf7bf2857044febf77f5b78ccf8a40 in term 1.
21:00:19.567 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.566111 11130 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [LEADER]: Connected to new peer: Peer: permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:00:19.574 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.572446 11116 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: SysCatalogTable state changed. Reason: New leader 9bdf7bf2857044febf77f5b78ccf8a40. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.575 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.572822 11116 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.580 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.579775 11133 mvcc.cc:204] Tried to move back new op lower bound from 7305397942397050880 to 7305397942140198912. Current Snapshot: MvccSnapshot[applied={T|T < 7305397942397050880}]
21:00:19.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.592934 11116 sys_catalog.cc:455] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.593279 11116 sys_catalog.cc:458] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.598017 11134 sys_catalog.cc:455] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: SysCatalogTable state changed. Reason: New leader 9bdf7bf2857044febf77f5b78ccf8a40. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.598 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.598351 11134 sys_catalog.cc:458] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.600 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.600131 11102 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.600821 11102 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: This master's current role is: LEADER
21:00:19.601 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.601351 11102 sys_catalog.cc:455] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.601881 11102 sys_catalog.cc:458] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40 [sys.catalog]: This master's current role is: LEADER
21:00:19.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.604943 11132 catalog_manager.cc:1382] Generated new cluster ID: ca1386517a9f4c30a89dcd3a78de08ae
21:00:19.610 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.605085 11132 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
21:00:19.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.618319 11134 sys_catalog.cc:455] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "5b400a59bcea43f4b91321d6c7c547ee" member_type: VOTER last_known_addr { host: "127.10.158.126" port: 42155 } } peers { permanent_uuid: "887a44c0c6894bde86ffdbd9fd39acba" member_type: VOTER last_known_addr { host: "127.10.158.125" port: 39521 } } peers { permanent_uuid: "9bdf7bf2857044febf77f5b78ccf8a40" member_type: VOTER last_known_addr { host: "127.10.158.124" port: 33135 } } }
21:00:19.619 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.618618 11134 sys_catalog.cc:458] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba [sys.catalog]: This master's current role is: FOLLOWER
21:00:19.655 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.655501 11153 catalog_manager.cc:805] Waiting for catalog manager background task thread to start: Service unavailable: Catalog manager is not initialized. State: Starting
21:00:19.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.670068 11132 catalog_manager.cc:1405] Generated new certificate authority record
21:00:19.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.672525 11132 catalog_manager.cc:1539] Loading token signing keys...
21:00:19.700 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.700052 11132 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 9bdf7bf2857044febf77f5b78ccf8a40: Generated new TSK 0
21:00:19.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.701795 11132 catalog_manager.cc:1549] Initializing in-progress tserver states...
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:19.715215 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:19.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/logs
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data/info.pb
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.65:0
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.65
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.65
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:19.721 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:19.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:19.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:19.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:19.722 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:00:20.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.140240 11154 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:20.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.140590 11154 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:20.141 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.140679 11154 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:20.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.150105 11154 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:20.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.150341 11154 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.10.158.65
21:00:20.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.162267 11154 tablet_server_runner.cc:78] Tablet server non-default flags:
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.65:0
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:20.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data/info.pb
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.65
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.65
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/logs
21:00:20.164 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:20.165 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.164317 11154 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:20.167 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.167234 11154 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:20.181 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.180644 11159 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
21:00:20.182 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.181769 11160 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
21:00:20.189 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.189230 11162 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
21:00:20.190 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.190204 11154 server_base.cc:1061] running on GCE node
21:00:20.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.191243 11154 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:20.193 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.193547 11154 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:20.195 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.195094 11154 hybrid_clock.cc:648] HybridClock initialized: now 1783544420194970 us; error 116 us; skew 500 ppm
21:00:20.196 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.195933 11154 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:20.199 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.199517 11154 webserver.cc:534] Webserver started at http://127.10.158.65:39087/ using document root <none> and password file <none>
21:00:20.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.200881 11154 fs_manager.cc:362] Metadata directory not provided
21:00:20.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.201056 11154 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:20.201 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.201503 11154 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:20.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.205466 11154 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data/instance:
21:00:20.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a820bd19e0314f24a78f2a9a91de87a0"
21:00:20.206 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.206712 11154 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal/instance:
21:00:20.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a820bd19e0314f24a78f2a9a91de87a0"
21:00:20.207 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.215 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.215433 11154 fs_manager.cc:696] Time spent creating directory manager: real 0.008s	user 0.006s	sys 0.004s
21:00:20.221 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.220811 11168 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:20.225 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.223443 11154 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.004s	sys 0.000s
21:00:20.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.223651 11154 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal
21:00:20.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "a820bd19e0314f24a78f2a9a91de87a0"
21:00:20.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.223881 11154 fs_report.cc:389] FS layout report
21:00:20.226 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data/data
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:20.227 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:20.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.269677 11154 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:20.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.270658 11154 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:20.271 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.270925 11154 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:20.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.271992 11154 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:00:20.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.274047 11154 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:00:20.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.274154 11154 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:00:20.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.274236 11154 ts_tablet_manager.cc:616] Registered 0 tablets
21:00:20.274 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.274284 11154 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:00:20.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.312846 11154 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.65:40331
21:00:20.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.312917 11280 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.65:40331 every 8 connection(s)
21:00:20.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.314568 11154 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/data/info.pb
21:00:20.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.321276 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 11154
21:00:20.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.321532 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-0/wal/instance
21:00:20.330 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.330590 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/logs
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data/info.pb
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:20.331 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.66:0
21:00:20.332 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.66
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.66
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:20.333 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:00:20.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.364655 11282 heartbeater.cc:344] Connected to a master server at 127.10.158.126:42155
21:00:20.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.365005 11127 catalog_manager.cc:1294] Loaded cluster ID: ca1386517a9f4c30a89dcd3a78de08ae
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.365095 11127 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: loading cluster ID for follower catalog manager: success
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.365114 11282 heartbeater.cc:461] Registering TS with master...
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.366400 11281 heartbeater.cc:344] Connected to a master server at 127.10.158.124:33135
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.366448 11282 heartbeater.cc:507] Master 127.10.158.126:42155 requested a full tablet report, sending...
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.366631 11281 heartbeater.cc:461] Registering TS with master...
21:00:20.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.367179 11281 heartbeater.cc:507] Master 127.10.158.124:33135 requested a full tablet report, sending...
21:00:20.369 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.368957 11127 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: acquiring CA information for follower catalog manager: success
21:00:20.372 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.369493 11057 ts_manager.cc:194] Registered new tserver with Master: a820bd19e0314f24a78f2a9a91de87a0 (127.10.158.65:40331)
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.369685 11283 heartbeater.cc:344] Connected to a master server at 127.10.158.125:39521
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.369850 11283 heartbeater.cc:461] Registering TS with master...
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.370162 10915 ts_manager.cc:194] Registered new tserver with Master: a820bd19e0314f24a78f2a9a91de87a0 (127.10.158.65:40331)
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.370451 11283 heartbeater.cc:507] Master 127.10.158.125:39521 requested a full tablet report, sending...
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.371850 11057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.10.158.65:38005
21:00:20.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.372594 10986 ts_manager.cc:194] Registered new tserver with Master: a820bd19e0314f24a78f2a9a91de87a0 (127.10.158.65:40331)
21:00:20.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.376170 11127 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 5b400a59bcea43f4b91321d6c7c547ee: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
21:00:20.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.662094 11153 catalog_manager.cc:1294] Loaded cluster ID: ca1386517a9f4c30a89dcd3a78de08ae
21:00:20.662 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.662254 11153 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: loading cluster ID for follower catalog manager: success
21:00:20.667 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.666750 11153 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: acquiring CA information for follower catalog manager: success
21:00:20.670 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.670042 11153 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 887a44c0c6894bde86ffdbd9fd39acba: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
21:00:20.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.728621 11290 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:20.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.729031 11290 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:20.729 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.729161 11290 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:20.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.738943 11290 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:20.739 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.739195 11290 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.10.158.66
21:00:20.752 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.752530 11290 tablet_server_runner.cc:78] Tablet server non-default flags:
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.66:0
21:00:20.753 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data/info.pb
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.66
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.66
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/logs
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:20.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:20.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.755223 11290 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:20.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.757539 11290 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:20.770 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.769256 11297 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
21:00:20.771 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.771106 11298 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
21:00:20.773 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:20.773010 11300 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
21:00:20.776 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.776441 11290 server_base.cc:1061] running on GCE node
21:00:20.777 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.777690 11290 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:20.780 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.780468 11290 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:20.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.782214 11290 hybrid_clock.cc:648] HybridClock initialized: now 1783544420782085 us; error 130 us; skew 500 ppm
21:00:20.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.782730 11290 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:20.785 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.785699 11290 webserver.cc:534] Webserver started at http://127.10.158.66:35831/ using document root <none> and password file <none>
21:00:20.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.786765 11290 fs_manager.cc:362] Metadata directory not provided
21:00:20.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.786921 11290 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:20.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.787458 11290 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.790454 11290 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data/instance:
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e9ba7cc616374b5abcb3919d75691fa2"
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.791571 11290 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal/instance:
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e9ba7cc616374b5abcb3919d75691fa2"
21:00:20.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.798691 11290 fs_manager.cc:696] Time spent creating directory manager: real 0.007s	user 0.005s	sys 0.000s
21:00:20.803 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.803498 11306 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.805966 11290 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.003s	sys 0.000s
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.806252 11290 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "e9ba7cc616374b5abcb3919d75691fa2"
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:20 on dist-test-slave-4mx2"
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.806556 11290 fs_report.cc:389] FS layout report
21:00:20.806 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data/data
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:20.807 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:20.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.837803 11290 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:20.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.839267 11290 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:20.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.839644 11290 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:20.841 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.840991 11290 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:00:20.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.843144 11290 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:00:20.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.843271 11290 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:00:20.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.843379 11290 ts_tablet_manager.cc:616] Registered 0 tablets
21:00:20.843 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.843447 11290 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:00:20.885 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.885440 11290 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.66:39777
21:00:20.886 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.885452 11418 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.66:39777 every 8 connection(s)
21:00:20.887 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.887192 11290 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/data/info.pb
21:00:20.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.888752 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 11290
21:00:20.891 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.889005 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-1/wal/instance
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.896312 10873 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskyULM3n/build/asan/bin/kudu
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:20.900 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/logs
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data/info.pb
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.67:0
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.67
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.67
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:20.901 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:20.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:20.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:20.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:20.902 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:00:20.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.928918 11419 heartbeater.cc:344] Connected to a master server at 127.10.158.124:33135
21:00:20.930 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.929368 11419 heartbeater.cc:461] Registering TS with master...
21:00:20.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.931540 11421 heartbeater.cc:344] Connected to a master server at 127.10.158.125:39521
21:00:20.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.931726 11421 heartbeater.cc:461] Registering TS with master...
21:00:20.932 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.931968 11419 heartbeater.cc:507] Master 127.10.158.124:33135 requested a full tablet report, sending...
21:00:20.934 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.933036 11421 heartbeater.cc:507] Master 127.10.158.125:39521 requested a full tablet report, sending...
21:00:20.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.934757 11057 ts_manager.cc:194] Registered new tserver with Master: e9ba7cc616374b5abcb3919d75691fa2 (127.10.158.66:39777)
21:00:20.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.935205 10986 ts_manager.cc:194] Registered new tserver with Master: e9ba7cc616374b5abcb3919d75691fa2 (127.10.158.66:39777)
21:00:20.937 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.935907 11057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.10.158.66:57525
21:00:20.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.938055 11420 heartbeater.cc:344] Connected to a master server at 127.10.158.126:42155
21:00:20.938 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.938241 11420 heartbeater.cc:461] Registering TS with master...
21:00:20.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.939121 11420 heartbeater.cc:507] Master 127.10.158.126:42155 requested a full tablet report, sending...
21:00:20.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:20.940635 10915 ts_manager.cc:194] Registered new tserver with Master: e9ba7cc616374b5abcb3919d75691fa2 (127.10.158.66:39777)
21:00:21.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.295020 11429 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:00:21.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.295425 11429 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:00:21.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.295557 11429 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:00:21.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.305065 11429 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:00:21.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.305307 11429 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.10.158.67
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.319774 11429 tablet_server_runner.cc:78] Tablet server non-default flags:
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.10.158.84:43817
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.10.158.67:0
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data/info.pb
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.10.158.67
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.10.158.126:42155,127.10.158.125:39521,127.10.158.124:33135
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:00:21.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.10.158.67
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/logs
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type FASTDEBUG
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:55 UTC on bdcb31816ec0
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16877
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) ASAN enabled
21:00:21.321 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.321694 11429 env_posix.cc:2267] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
21:00:21.323 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.323652 11429 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:00:21.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.335650 11434 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
21:00:21.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.336016 11435 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
21:00:21.336 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:21.336828 11437 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
21:00:21.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.337049 11429 server_base.cc:1061] running on GCE node
21:00:21.338 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.338294 11429 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:00:21.340 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.340596 11429 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:00:21.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.341933 11429 hybrid_clock.cc:648] HybridClock initialized: now 1783544421341772 us; error 120 us; skew 500 ppm
21:00:21.342 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.342479 11429 server_base.cc:861] Flag tcmalloc_max_total_thread_cache_bytes is not working since tcmalloc is not enabled.
21:00:21.345 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.345254 11429 webserver.cc:534] Webserver started at http://127.10.158.67:34349/ using document root <none> and password file <none>
21:00:21.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.346240 11429 fs_manager.cc:362] Metadata directory not provided
21:00:21.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.346381 11429 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:00:21.346 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.346853 11429 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:00:21.350 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.349958 11429 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data/instance:
21:00:21.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "138062cd495f4a52af59799a14fb2941"
21:00:21.351 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:21 on dist-test-slave-4mx2"
21:00:21.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.351984 11429 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal/instance:
21:00:21.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "138062cd495f4a52af59799a14fb2941"
21:00:21.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:21 on dist-test-slave-4mx2"
21:00:21.362 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.361956 11429 fs_manager.cc:696] Time spent creating directory manager: real 0.009s	user 0.008s	sys 0.000s
21:00:21.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.367251 11443 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:00:21.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.369868 11429 fs_manager.cc:730] Time spent opening block manager: real 0.005s	user 0.002s	sys 0.000s
21:00:21.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.370379 11429 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data,/tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal
21:00:21.370 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "138062cd495f4a52af59799a14fb2941"
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:00:21 on dist-test-slave-4mx2"
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.370790 11429 fs_report.cc:389] FS layout report
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data/data
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:00:21.371 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:00:21.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.375066 11281 heartbeater.cc:499] Master 127.10.158.124:33135 was elected leader, sending a full tablet report...
21:00:21.400 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.400424 11429 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:00:21.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.401398 11429 env_posix.cc:2267] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
21:00:21.401 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.401712 11429 kserver.cc:163] Server-wide thread pool size limit: 3276
21:00:21.403 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.402837 11429 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:00:21.404 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.404702 11429 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:00:21.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.404798 11429 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:00:21.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.404893 11429 ts_tablet_manager.cc:616] Registered 0 tablets
21:00:21.405 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.404939 11429 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:00:21.438 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.438627 11429 rpc_server.cc:307] RPC server started. Bound to: 127.10.158.67:44837
21:00:21.439 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.438687 11555 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.10.158.67:44837 every 8 connection(s)
21:00:21.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.440203 11429 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/data/info.pb
21:00:21.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.442826 10873 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskyULM3n/build/asan/bin/kudu as pid 11429
21:00:21.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.443068 10873 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskyULM3n/test-tmp/mini-kudu-cluster1860963571367362003/ts-2/wal/instance
21:00:21.474 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474431 11556 heartbeater.cc:344] Connected to a master server at 127.10.158.124:33135
21:00:21.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474488 11558 heartbeater.cc:344] Connected to a master server at 127.10.158.125:39521
21:00:21.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474458 11557 heartbeater.cc:344] Connected to a master server at 127.10.158.126:42155
21:00:21.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474922 11558 heartbeater.cc:461] Registering TS with master...
21:00:21.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474916 11556 heartbeater.cc:461] Registering TS with master...
21:00:21.475 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.474918 11557 heartbeater.cc:461] Registering TS with master...
21:00:21.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.476303 11557 heartbeater.cc:507] Master 127.10.158.126:42155 requested a full tablet report, sending...
21:00:21.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.476353 11556 heartbeater.cc:507] Master 127.10.158.124:33135 requested a full tablet report, sending...
21:00:21.476 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.476387 11558 heartbeater.cc:507] Master 127.10.158.125:39521 requested a full tablet report, sending...
21:00:21.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.478323 11057 ts_manager.cc:194] Registered new tserver with Master: 138062cd495f4a52af59799a14fb2941 (127.10.158.67:44837)
21:00:21.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.478528 10986 ts_manager.cc:194] Registered new tserver with Master: 138062cd495f4a52af59799a14fb2941 (127.10.158.67:44837)
21:00:21.478 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.478714 10915 ts_manager.cc:194] Registered new tserver with Master: 138062cd495f4a52af59799a14fb2941 (127.10.158.67:44837)
21:00:21.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.479508 11057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.10.158.67:56803
21:00:21.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.487133 10873 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
21:00:21.489 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
21:00:21.490 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

21:00:21.500 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.10.158.126"
      port: 42155
    }
    bound_http_address {
      host: "127.10.158.126"
      port: 42381
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.10.158.125"
      port: 39521
    }
    bound_http_address {
      host: "127.10.158.125"
      port: 42775
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.10.158.124"
      port: 33135
    }
    bound_http_address {
      host: "127.10.158.124"
      port: 45873
    }
  }
}

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

21:00:21.508 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.10.158.65"
      port: 40331
    }
    bound_http_address {
      host: "127.10.158.65"
      port: 39087
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.10.158.66"
      port: 39777
    }
    bound_http_address {
      host: "127.10.158.66"
      port: 35831
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.10.158.67"
      port: 44837
    }
    bound_http_address {
      host: "127.10.158.67"
      port: 34349
    }
  }
}

21:00:21.508 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
21:00:21.750 [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)
21:00:21.813 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
21:00:21.940 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:21.939893 11419 heartbeater.cc:499] Master 127.10.158.124:33135 was elected leader, sending a full tablet report...
21:00:21.968 [DEBUG - main] (Connection.java:748) [peer master-127.10.158.124:33135(127.10.158.124:33135)] connecting to peer
21:00:22.027 [DEBUG - main] (Connection.java:748) [peer master-127.10.158.125:39521(127.10.158.125:39521)] connecting to peer
21:00:22.028 [DEBUG - main] (Connection.java:748) [peer master-127.10.158.126:42155(127.10.158.126:42155)] connecting to peer
21:00:22.046 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.10.158.125:39521(127.10.158.125:39521)] Successfully connected to peer
21:00:22.047 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.10.158.124:33135(127.10.158.124:33135)] Successfully connected to peer
21:00:22.048 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.10.158.126:42155(127.10.158.126:42155)] Successfully connected to peer
21:00:22.145 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.10.158.124
21:00:22.145 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.10.158.125
21:00:22.145 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.10.158.126
21:00:22.403 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0xfcd630b1, L:/127.0.0.1:46030 - R:/127.10.158.124:33135] using SASL/PLAIN
21:00:22.404 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x2b0535d4, L:/127.0.0.1:59232 - R:/127.10.158.125:39521] using SASL/PLAIN
21:00:22.406 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x68699522, L:/127.0.0.1:41536 - R:/127.10.158.126:42155] using SASL/PLAIN
21:00:22.441 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
21:00:22.443 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=520), Traces: [0ms] refreshing cache from master, [31ms] Sub RPC ConnectToMaster: sending RPC to server master-127.10.158.124:33135, [100ms] Sub RPC ConnectToMaster: sending RPC to server master-127.10.158.125:39521, [102ms] Sub RPC ConnectToMaster: sending RPC to server master-127.10.158.126:42155, [491ms] Sub RPC ConnectToMaster: received response from server master-127.10.158.126:42155: OK, [491ms] Sub RPC ConnectToMaster: received response from server master-127.10.158.125:39521: OK, [492ms] Sub RPC ConnectToMaster: received response from server master-127.10.158.124:33135: OK, deferred=null) after lookup
21:00:22.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.481911 11556 heartbeater.cc:499] Master 127.10.158.124:33135 was elected leader, sending a full tablet report...
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.497642 11057 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:46030:
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783544416968"
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
21:00:22.498 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
21:00:22.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
21:00:22.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
21:00:22.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:22.499503 11057 catalog_manager.cc:7076] 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-1783544416968 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
21:00:22.543 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:894) Opened table 678f66781b5d40ac83119ad28deee1c2
21:00:22.576 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.575297 11491 tablet_service.cc:1511] Processing CreateTablet for tablet d2089906dd02495b9ae87f08c79929dc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544416968 [id=678f66781b5d40ac83119ad28deee1c2]), partition=RANGE (key) PARTITION UNBOUNDED
21:00:22.578 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.577826 11491 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d2089906dd02495b9ae87f08c79929dc. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:22.583 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.582872 11216 tablet_service.cc:1511] Processing CreateTablet for tablet d2089906dd02495b9ae87f08c79929dc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544416968 [id=678f66781b5d40ac83119ad28deee1c2]), partition=RANGE (key) PARTITION UNBOUNDED
21:00:22.585 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.585225 11216 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d2089906dd02495b9ae87f08c79929dc. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:22.591 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.589951 11354 tablet_service.cc:1511] Processing CreateTablet for tablet d2089906dd02495b9ae87f08c79929dc (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544416968 [id=678f66781b5d40ac83119ad28deee1c2]), partition=RANGE (key) PARTITION UNBOUNDED
21:00:22.593 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.593647 11354 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet d2089906dd02495b9ae87f08c79929dc. 1 dirs total, 0 dirs full, 0 dirs failed
21:00:22.613 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.613278 11591 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Bootstrap starting.
21:00:22.615 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.615429 11592 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Bootstrap starting.
21:00:22.618 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.618434 11593 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Bootstrap starting.
21:00:22.620 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.620116 11592 tablet_bootstrap.cc:654] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Neither blocks nor log segments found. Creating new log.
21:00:22.621 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.621626 11591 tablet_bootstrap.cc:654] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Neither blocks nor log segments found. Creating new log.
21:00:22.622 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.622088 11592 log.cc:826] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Log is configured to *not* fsync() on all Append() calls
21:00:22.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.623050 11593 tablet_bootstrap.cc:654] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Neither blocks nor log segments found. Creating new log.
21:00:22.623 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.623453 11591 log.cc:826] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Log is configured to *not* fsync() on all Append() calls
21:00:22.629 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.629395 11593 log.cc:826] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Log is configured to *not* fsync() on all Append() calls
21:00:22.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.632692 11592 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: No bootstrap required, opened a new log
21:00:22.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.633625 11592 ts_tablet_manager.cc:1403] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Time spent bootstrapping tablet: real 0.019s	user 0.008s	sys 0.008s
21:00:22.641 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.641561 11591 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: No bootstrap required, opened a new log
21:00:22.642 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.641950 11591 ts_tablet_manager.cc:1403] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Time spent bootstrapping tablet: real 0.029s	user 0.016s	sys 0.005s
21:00:22.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.643427 11592 raft_consensus.cc:359] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.644 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.644788 11592 raft_consensus.cc:385] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:22.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.645120 11592 raft_consensus.cc:740] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a820bd19e0314f24a78f2a9a91de87a0, State: Initialized, Role: FOLLOWER
21:00:22.645 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.645253 11593 tablet_bootstrap.cc:492] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: No bootstrap required, opened a new log
21:00:22.646 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.645722 11593 ts_tablet_manager.cc:1403] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Time spent bootstrapping tablet: real 0.028s	user 0.012s	sys 0.007s
21:00:22.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.646442 11592 consensus_queue.cc:260] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [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: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.651445 11591 raft_consensus.cc:359] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.652 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.652724 11591 raft_consensus.cc:385] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:22.653 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.653115 11591 raft_consensus.cc:740] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 138062cd495f4a52af59799a14fb2941, State: Initialized, Role: FOLLOWER
21:00:22.654 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.654469 11591 consensus_queue.cc:260] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [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: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.656 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.656059 11592 ts_tablet_manager.cc:1434] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Time spent starting tablet: real 0.022s	user 0.010s	sys 0.008s
21:00:22.657 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.656908 11593 raft_consensus.cc:359] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.659 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.659693 11593 raft_consensus.cc:385] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:00:22.660 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.660224 11593 raft_consensus.cc:740] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: e9ba7cc616374b5abcb3919d75691fa2, State: Initialized, Role: FOLLOWER
21:00:22.661 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.661305 11593 consensus_queue.cc:260] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [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: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.666 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.666113 11591 ts_tablet_manager.cc:1434] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Time spent starting tablet: real 0.024s	user 0.006s	sys 0.018s
21:00:22.672 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.672125 11593 ts_tablet_manager.cc:1434] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Time spent starting tablet: real 0.026s	user 0.011s	sys 0.009s
21:00:22.695 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:22.695309 11559 tablet.cc:2406] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:00:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.769121 11598 raft_consensus.cc:493] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
21:00:22.769 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.769464 11598 raft_consensus.cc:515] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.772 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.772238 11598 leader_election.cc:290] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers a820bd19e0314f24a78f2a9a91de87a0 (127.10.158.65:40331), e9ba7cc616374b5abcb3919d75691fa2 (127.10.158.66:39777)
21:00:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.780723 11236 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d2089906dd02495b9ae87f08c79929dc" candidate_uuid: "138062cd495f4a52af59799a14fb2941" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a820bd19e0314f24a78f2a9a91de87a0" is_pre_election: true
21:00:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.780723 11374 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d2089906dd02495b9ae87f08c79929dc" candidate_uuid: "138062cd495f4a52af59799a14fb2941" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e9ba7cc616374b5abcb3919d75691fa2" is_pre_election: true
21:00:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.781384 11236 raft_consensus.cc:2468] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 138062cd495f4a52af59799a14fb2941 in term 0.
21:00:22.781 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.781384 11374 raft_consensus.cc:2468] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 138062cd495f4a52af59799a14fb2941 in term 0.
21:00:22.782 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.782414 11445 leader_election.cc:304] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [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: 138062cd495f4a52af59799a14fb2941, e9ba7cc616374b5abcb3919d75691fa2; no voters: 
21:00:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.782981 11598 raft_consensus.cc:2804] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Leader pre-election won for term 1
21:00:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.783141 11598 raft_consensus.cc:493] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
21:00:22.783 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.783246 11598 raft_consensus.cc:3060] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 0 FOLLOWER]: Advancing to term 1
21:00:22.786 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.786180 11598 raft_consensus.cc:515] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.787 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.787145 11598 leader_election.cc:290] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [CANDIDATE]: Term 1 election: Requested vote from peers a820bd19e0314f24a78f2a9a91de87a0 (127.10.158.65:40331), e9ba7cc616374b5abcb3919d75691fa2 (127.10.158.66:39777)
21:00:22.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.787781 11236 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d2089906dd02495b9ae87f08c79929dc" candidate_uuid: "138062cd495f4a52af59799a14fb2941" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "a820bd19e0314f24a78f2a9a91de87a0"
21:00:22.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.788098 11236 raft_consensus.cc:3060] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 0 FOLLOWER]: Advancing to term 1
21:00:22.788 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.788681 11374 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "d2089906dd02495b9ae87f08c79929dc" candidate_uuid: "138062cd495f4a52af59799a14fb2941" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "e9ba7cc616374b5abcb3919d75691fa2"
21:00:22.789 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.788931 11374 raft_consensus.cc:3060] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 0 FOLLOWER]: Advancing to term 1
21:00:22.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.791028 11236 raft_consensus.cc:2468] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 138062cd495f4a52af59799a14fb2941 in term 1.
21:00:22.791 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.791446 11374 raft_consensus.cc:2468] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 138062cd495f4a52af59799a14fb2941 in term 1.
21:00:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.791780 11447 leader_election.cc:304] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [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: 138062cd495f4a52af59799a14fb2941, a820bd19e0314f24a78f2a9a91de87a0; no voters: 
21:00:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.792244 11598 raft_consensus.cc:2804] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 1 FOLLOWER]: Leader election won for term 1
21:00:22.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.792765 11598 raft_consensus.cc:697] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [term 1 LEADER]: Becoming Leader. State: Replica: 138062cd495f4a52af59799a14fb2941, State: Running, Role: LEADER
21:00:22.793 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.793577 11598 consensus_queue.cc:237] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [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: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } }
21:00:22.801 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:22.800340 11057 catalog_manager.cc:5696] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 reported cstate change: term changed from 0 to 1, leader changed from <none> to 138062cd495f4a52af59799a14fb2941 (127.10.158.67). New cstate: current_term: 1 leader_uuid: "138062cd495f4a52af59799a14fb2941" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "138062cd495f4a52af59799a14fb2941" member_type: VOTER last_known_addr { host: "127.10.158.67" port: 44837 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 } health_report { overall_health: UNKNOWN } } }
21:00:22.820 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:22.820252 11284 tablet.cc:2406] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:00:22.905 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:00:22.905560 11422 tablet.cc:2406] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:00:23.020 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:2538) Learned about tablet d2089906dd02495b9ae87f08c79929dc for table 'org.apache.kudu.client.TestHybridTime-1783544416968' with partition [<start>, <end>)
21:00:23.025 [DEBUG - kudu-nio-0] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=d2089906dd02495b9ae87f08c79929dc@[138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)[L],a820bd19e0314f24a78f2a9a91de87a0(127.10.158.65:40331),e9ba7cc616374b5abcb3919d75691fa2(127.10.158.66:39777)]}]
21:00:23.027 [DEBUG - kudu-nio-0] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=17), Traces: [0ms] refreshing cache from master, [1ms] Sub RPC GetTableLocations: sending RPC to server master-127.10.158.124:33135, [9ms] Sub RPC GetTableLocations: received response from server master-127.10.158.124:33135: OK, deferred=null) after lookup
21:00:23.037 [DEBUG - kudu-nio-0] (Connection.java:748) [peer 138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)] connecting to peer
21:00:23.040 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)] Successfully connected to peer
21:00:23.104 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xcad989ec, L:/127.0.0.1:53450 - R:/127.10.158.67:44837] using TOKEN/null
21:00:23.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.117895 11236 raft_consensus.cc:1275] T d2089906dd02495b9ae87f08c79929dc P a820bd19e0314f24a78f2a9a91de87a0 [term 1 FOLLOWER]: Refusing update from remote peer 138062cd495f4a52af59799a14fb2941: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:00:23.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.117987 11374 raft_consensus.cc:1275] T d2089906dd02495b9ae87f08c79929dc P e9ba7cc616374b5abcb3919d75691fa2 [term 1 FOLLOWER]: Refusing update from remote peer 138062cd495f4a52af59799a14fb2941: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:00:23.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.119361 11602 consensus_queue.cc:1048] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [LEADER]: Connected to new peer: Peer: permanent_uuid: "a820bd19e0314f24a78f2a9a91de87a0" member_type: VOTER last_known_addr { host: "127.10.158.65" port: 40331 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:00:23.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.119756 11598 consensus_queue.cc:1048] T d2089906dd02495b9ae87f08c79929dc P 138062cd495f4a52af59799a14fb2941 [LEADER]: Connected to new peer: Peer: permanent_uuid: "e9ba7cc616374b5abcb3919d75691fa2" member_type: VOTER last_known_addr { host: "127.10.158.66" port: 39777 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:00:23.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.137247 11607 mvcc.cc:204] Tried to move back new op lower bound from 7305397957077524480 to 7305397955768766464. Current Snapshot: MvccSnapshot[applied={T|T < 7305397957077524480}]
21:00:23.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.138770 11609 mvcc.cc:204] Tried to move back new op lower bound from 7305397957077524480 to 7305397955768766464. Current Snapshot: MvccSnapshot[applied={T|T < 7305397957077524480}]
21:00:23.153 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.153296 11608 mvcc.cc:204] Tried to move back new op lower bound from 7305397957077524480 to 7305397955768766464. Current Snapshot: MvccSnapshot[applied={T|T < 7305397957077524480 or (T in {7305397957077524480})}]
21:00:23.193 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.207 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.218 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.222 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1533335597(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:00:23.240 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.240 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1938880610(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:00:23.254 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.255 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1492949940(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:00:23.266 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:00:23.326 [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-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.337 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305397977557524481) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.345 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305397977557524487) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.352 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305397977557524491) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.361 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305397977557524495) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.368 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305397977557524499) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.375 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305397977557524503) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.382 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305397977557524504) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544416968, tablet=d2089906dd02495b9ae87f08c79929dc, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:00:23.385 [DEBUG - main] (Connection.java:575) [peer master-127.10.158.124:33135(127.10.158.124:33135)] disconnecting while in state READY
21:00:23.392 [DEBUG - main] (Connection.java:575) [peer master-127.10.158.126:42155(127.10.158.126:42155)] disconnecting while in state READY
21:00:23.396 [DEBUG - main] (Connection.java:575) [peer 138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)] disconnecting while in state READY
21:00:23.396 [DEBUG - main] (Connection.java:575) [peer master-127.10.158.125:39521(127.10.158.125:39521)] disconnecting while in state READY
21:00:23.399 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.10.158.124:33135(127.10.158.124:33135)] handling channelInactive
21:00:23.401 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.10.158.125:39521(127.10.158.125:39521)] handling channelInactive
21:00:23.402 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.10.158.126:42155(127.10.158.126:42155)] handling channelInactive
21:00:23.404 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.10.158.125:39521(127.10.158.125:39521)] cleaning up while in state READY due to: connection closed
21:00:23.404 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.10.158.126:42155(127.10.158.126:42155)] cleaning up while in state READY due to: connection closed
21:00:23.405 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.10.158.124:33135(127.10.158.124:33135)] cleaning up while in state READY due to: connection closed
21:00:23.409 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
21:00:23.417 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)] handling channelInactive
21:00:23.418 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 138062cd495f4a52af59799a14fb2941(127.10.158.67:44837)] cleaning up while in state READY due to: connection closed
21:00:23.419 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.419149 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 11154
21:00:23.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.456050 11276 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:23.602 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.602061 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 11154
21:00:23.637 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.636745 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 11290
21:00:23.647 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.647403 11414 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:23.792 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.791647 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 11290
21:00:23.819 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.819377 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 11429
21:00:23.828 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.828203 11551 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:23.944 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.943713 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 11429
21:00:23.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.963259 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 10884
21:00:23.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:23.964723 10945 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:24.076 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.076287 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 10884
21:00:24.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.096864 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 10954
21:00:24.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.098335 11016 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:24.210 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.209805 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 10954
21:00:24.229 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.229353 10873 external_mini_cluster.cc:1705] Attempting to check leaks for /tmp/dist-test-taskyULM3n/build/asan/bin/kudu pid 11023
21:00:24.231 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.230808 11087 generic_service.cc:196] Checking for leaks (request via RPC)
21:00:24.347 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:00:24.346489 10873 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskyULM3n/build/asan/bin/kudu with pid 11023
21:00:24.394 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:00:24Z chronyd exiting

Time: 7.437

OK (1 test)

