JUnit version 4.13.2
.21:04:10.662 [DEBUG - main] (RandomUtils.java:49) Using random seed: 1783544650653
21:04:10.685 [INFO - main] (RetryRule.java:138) Creating RetryStatement with result reporter and retry count of 0 (no retries)
21:04:10.724 [INFO - main] (KuduTestHarness.java:155) Creating a new MiniKuduCluster...
21:04:10.734 [INFO - main] (TempDirUtils.java:71) Using the temp directory defined by TEST_TMPDIR: /tmp/dist-test-taskZMNQOV/test-tmp
21:04:10.762 [INFO - main] (KuduBinaryLocator.java:83) Using Kudu binary directory specified by system property 'kuduBinDir': ../../../build/debug/bin
21:04:10.766 [INFO - main] (MiniKuduCluster.java:217) Starting process: [/tmp/dist-test-taskZMNQOV/java/build/dist-test/../../../build/debug/bin/kudu, test, mini_cluster, --serialization=pb]
21:04:10.940 [DEBUG - main] (MiniKuduCluster.java:185) Request: create_cluster {
  num_masters: 3
  num_tservers: 3
  enable_kerberos: false
  cluster_root: "/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050"
  hms_mode: NONE
  mini_kdc_options {
  }
  principal: "kudu"
  mini_oidc_options {
  }
}

21:04:10.958 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
21:04:10.959 [DEBUG - main] (MiniKuduCluster.java:185) Request: start_cluster {
}

21:04:10.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:10.960857 25606 mini_oidc.cc:150] Starting JWKS server
21:04:10.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:10.962723 25606 webserver.cc:534] Webserver started at http://127.0.0.1:33639/ using document root <none> and password file <none>
21:04:10.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:10.962916 25606 mini_oidc.cc:186] Starting OIDC Discovery server
21:04:10.963 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:10.963227 25606 webserver.cc:534] Webserver started at http://127.0.0.1:37275/ using document root <none> and password file <none>
21:04:10.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:04:10Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
21:04:10.974 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:04:10Z Disabled control of system clock
21:04:10.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:10.978057 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:10.978 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:10.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal
21:04:10.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data
21:04:10.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:10.979 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:10.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:10.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:10.980 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:10.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:10.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/logs
21:04:10.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data/info.pb
21:04:10.981 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:10.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:10.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:10.982 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:10.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:10.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:10.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:10.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:10.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.190:38053
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.190
21:04:10.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:10.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:10.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:10.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json with env {}
21:04:11.080 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.080415 25617 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:11.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.080627 25617 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:11.081 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.080672 25617 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:11.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084367 25617 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:04:11.084 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084427 25617 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:11.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084447 25617 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:04:11.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084465 25617 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:04:11.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084483 25617 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:04:11.085 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.084497 25617 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33639/jwks.json
21:04:11.088 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.088515 25617 master_runner.cc:387] Master server non-default flags:
21:04:11.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.089 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.190:38053
21:04:11.090 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:11.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:11.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:11.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json
21:04:11.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.091 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data/info.pb
21:04:11.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.190
21:04:11.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:11.092 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.25617
21:04:11.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:11.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:11.093 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/logs
21:04:11.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:11.094 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:11.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:04:11.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:11.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:11.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:11.095 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:11.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:11.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.089679 25617 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:04:11.096 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.090780 25617 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:11.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.097007 25622 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:04:11.097 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.097054 25617 server_base.cc:1061] running on GCE node
21:04:11.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.097412 25625 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:04:11.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.097007 25623 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:04:11.098 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.098006 25617 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:11.099 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.098944 25617 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:11.100 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.100117 25617 hybrid_clock.cc:648] HybridClock initialized: now 1783544651100106 us; error 37 us; skew 500 ppm
21:04:11.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.101868 25617 webserver.cc:534] Webserver started at http://127.25.1.190:43659/ using document root <none> and password file <none>
21:04:11.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.102479 25617 fs_manager.cc:362] Metadata directory not provided
21:04:11.102 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.102536 25617 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:11.103 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.102689 25617 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:11.104 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.104385 25617 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data/instance:
21:04:11.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "687ff8ff42044004a9a2b4de32e50c1d"
21:04:11.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.104828 25617 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal/instance:
21:04:11.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "687ff8ff42044004a9a2b4de32e50c1d"
21:04:11.105 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.108719 25617 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
21:04:11.111 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.111063 25631 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:11.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.112139 25617 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
21:04:11.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.112233 25617 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal
21:04:11.112 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "687ff8ff42044004a9a2b4de32e50c1d"
21:04:11.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.112337 25617 fs_report.cc:389] FS layout report
21:04:11.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:11.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal
21:04:11.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal
21:04:11.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data/data
21:04:11.114 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:11.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:11.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:11.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:11.115 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:11.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:11.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:11.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:11.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:11.116 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:11.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:11.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.130792 25617 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:11.131 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.131544 25617 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:04:11.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.131700 25617 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:11.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.138996 25683 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.190:38053 every 8 connection(s)
21:04:11.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.139017 25617 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.190:38053
21:04:11.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.139981 25617 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/data/info.pb
21:04:11.143 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.142810 25684 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:04:11.144 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.144680 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 25617
21:04:11.145 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.144841 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-0/wal/instance
21:04:11.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.145543 25684 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.146319 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.146 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal
21:04:11.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data
21:04:11.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:11.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:11.147 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:11.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/logs
21:04:11.148 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data/info.pb
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:11.149 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:11.150 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.189:42939
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.189
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.151 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:11.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:11.152 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json with env {}
21:04:11.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.161660 25684 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.162 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.162519 25633 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.25.1.189:42939: connect: Connection refused (error 111)
21:04:11.163 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.163488 25684 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.189:42939: Network error: Client connection negotiation failed: client connection to 127.25.1.189:42939: connect: Connection refused (error 111)
21:04:11.213 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.212718 25684 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } attempt: 1
21:04:11.214 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.214355 25684 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.189:42939: Network error: Client connection negotiation failed: client connection to 127.25.1.189:42939: connect: Connection refused (error 111)
21:04:11.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.249019 25686 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:11.249 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.249233 25686 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:11.250 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.249276 25686 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:11.252 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252660 25686 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:04:11.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252715 25686 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:11.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252736 25686 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:04:11.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252753 25686 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:04:11.253 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252782 25686 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:04:11.254 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.252797 25686 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33639/jwks.json
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.258062 25686 master_runner.cc:387] Master server non-default flags:
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.258 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.259 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.189:42939
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data/info.pb
21:04:11.260 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.189
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.25686
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:11.261 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/logs
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:11.262 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:11.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:11.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:11.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:11.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.259435 25686 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:04:11.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.260799 25686 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:11.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.267133 25694 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:04:11.267 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.267135 25695 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:04:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.267135 25697 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:04:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.267549 25686 server_base.cc:1061] running on GCE node
21:04:11.268 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.268077 25686 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:11.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.269148 25686 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:11.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.270345 25686 hybrid_clock.cc:648] HybridClock initialized: now 1783544651270289 us; error 73 us; skew 500 ppm
21:04:11.272 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.272228 25686 webserver.cc:534] Webserver started at http://127.25.1.189:42139/ using document root <none> and password file <none>
21:04:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.272853 25686 fs_manager.cc:362] Metadata directory not provided
21:04:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.272936 25686 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:11.273 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.273154 25686 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.274763 25686 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data/instance:
21:04:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4c43bc378a6941b7b7137fca8cf0594c"
21:04:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.275347 25686 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal/instance:
21:04:11.275 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4c43bc378a6941b7b7137fca8cf0594c"
21:04:11.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.279 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.278793 25686 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.000s
21:04:11.281 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.281087 25703 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:11.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.282147 25686 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
21:04:11.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.282276 25686 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal
21:04:11.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4c43bc378a6941b7b7137fca8cf0594c"
21:04:11.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.282375 25686 fs_report.cc:389] FS layout report
21:04:11.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:11.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal
21:04:11.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data/data
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:11.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:11.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.284343 25684 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } attempt: 2
21:04:11.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.285876 25684 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.189:42939: Network error: Client connection negotiation failed: client connection to 127.25.1.189:42939: connect: Connection refused (error 111)
21:04:11.299 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.299329 25686 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.300052 25686 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:04:11.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.300246 25686 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:11.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.307458 25755 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.189:42939 every 8 connection(s)
21:04:11.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.307463 25686 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.189:42939
21:04:11.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.308624 25686 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/data/info.pb
21:04:11.311 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.311466 25756 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:04:11.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.312254 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 25686
21:04:11.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.312353 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-1/wal/instance
21:04:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.313093 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal
21:04:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data
21:04:11.313 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/logs
21:04:11.314 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data/info.pb
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) master
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.188:41351
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.188
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.316 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:11.317 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json with env {}
21:04:11.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.315008 25756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.327 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.327448 25756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.334 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.333992 25756 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.335 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.334861 25707 proxy.cc:239] Call had error, refreshing address and retrying: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.337 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.337127 25756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.188:41351: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.377063 25684 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } attempt: 3
21:04:11.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.381881 25684 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.383 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.383369 25684 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.188:41351: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.386 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.386341 25756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } attempt: 1
21:04:11.387 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.387692 25756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.188:41351: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.414 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.414566 25684 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } attempt: 1
21:04:11.416 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.416239 25684 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.188:41351: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.423205 25758 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:11.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.423432 25758 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:11.423 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.423480 25758 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427102 25758 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427170 25758 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427191 25758 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427208 25758 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427227 25758 flags.cc:432] Enabled experimental flag: --enable_jwt_token_auth=true
21:04:11.427 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.427241 25758 flags.cc:432] Enabled experimental flag: --jwks_url=http://localhost:33639/jwks.json
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.431313 25758 master_runner.cc:387] Master server non-default flags:
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data
21:04:11.431 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_ca_key_size=768
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --master_addresses=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tsk_num_rsa_bits=512
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.188:41351
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_reuseport=true
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:11.432 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_jwt_token_auth=true
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --jwks_url=http://localhost:33639/jwks.json
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data/info.pb
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.188
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.25758
21:04:11.433 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/logs
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Master server version:
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:11.434 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:11.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:11.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.432426 25758 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:04:11.435 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.433478 25758 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.439893 25766 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:04:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.439942 25767 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:04:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.440040 25758 server_base.cc:1061] running on GCE node
21:04:11.440 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.439913 25769 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:04:11.441 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.440876 25758 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:11.442 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.441994 25758 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:11.443 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.443171 25758 hybrid_clock.cc:648] HybridClock initialized: now 1783544651443015 us; error 173 us; skew 500 ppm
21:04:11.445 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.445266 25758 webserver.cc:534] Webserver started at http://127.25.1.188:45057/ using document root <none> and password file <none>
21:04:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.445914 25758 fs_manager.cc:362] Metadata directory not provided
21:04:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.445998 25758 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:11.446 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.446200 25758 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.448172 25758 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data/instance:
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f27a2990752d4a11a76d5585dcaa0f03"
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.448719 25758 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal/instance:
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f27a2990752d4a11a76d5585dcaa0f03"
21:04:11.448 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.452 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.452423 25758 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
21:04:11.454 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.454358 25775 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:11.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.455360 25758 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
21:04:11.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.455495 25758 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal
21:04:11.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "f27a2990752d4a11a76d5585dcaa0f03"
21:04:11.455 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.455588 25758 fs_report.cc:389] FS layout report
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data/data
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:11.456 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.455874 25756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } attempt: 2
21:04:11.457 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.457165 25756 consensus_peers.cc:760] Error getting permanent uuid from config peer 127.25.1.188:41351: Network error: Client connection negotiation failed: client connection to 127.25.1.188:41351: connect: Connection refused (error 111)
21:04:11.471 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.471240 25758 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:11.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.471957 25758 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:04:11.472 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.472155 25758 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:11.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.479467 25758 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.188:41351
21:04:11.479 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.479476 25827 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.188:41351 every 8 connection(s)
21:04:11.480 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.480581 25758 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/data/info.pb
21:04:11.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.482080 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 25758
21:04:11.482 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.482191 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/master-2/wal/instance
21:04:11.483 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.483659 25828 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:04:11.487 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.487534 25828 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.491 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.491407 25684 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } attempt: 2
21:04:11.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.498857 25828 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.501 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.501173 25684 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: Bootstrap starting.
21:04:11.503 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.503674 25684 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: Neither blocks nor log segments found. Creating new log.
21:04:11.504 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.504508 25684 log.cc:826] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: Log is configured to *not* fsync() on all Append() calls
21:04:11.505 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.504838 25828 sys_catalog.cc:422] member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } has no permanent_uuid. Determining permanent_uuid...
21:04:11.506 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.506204 25684 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: No bootstrap required, opened a new log
21:04:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.509742 25684 raft_consensus.cc:359] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.509989 25684 raft_consensus.cc:385] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.510048 25684 raft_consensus.cc:740] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 687ff8ff42044004a9a2b4de32e50c1d, State: Initialized, Role: FOLLOWER
21:04:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.510341 25828 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: Bootstrap starting.
21:04:11.510 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.510509 25684 consensus_queue.cc:260] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.511134 25836 sys_catalog.cc:455] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.511515 25836 sys_catalog.cc:458] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.511829 25684 sys_catalog.cc:565] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: configured and running, proceeding with master startup.
21:04:11.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.512805 25828 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: Neither blocks nor log segments found. Creating new log.
21:04:11.513 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.513597 25828 log.cc:826] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: Log is configured to *not* fsync() on all Append() calls
21:04:11.515 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.515389 25828 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: No bootstrap required, opened a new log
21:04:11.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.517076 25848 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
21:04:11.517 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.517469 25848 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
21:04:11.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.516688 25617 master_runner.cc:187] Error getting master registration for 127.25.1.189:42939: OK, instance_id { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" instance_seqno: 1783544651305528 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
21:04:11.519 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.518885 25617 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
21:04:11.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.519240 25828 raft_consensus.cc:359] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.519423 25828 raft_consensus.cc:385] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:11.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.519479 25828 raft_consensus.cc:740] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f27a2990752d4a11a76d5585dcaa0f03, State: Initialized, Role: FOLLOWER
21:04:11.520 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.519932 25828 consensus_queue.cc:260] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.521 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.521124 25828 sys_catalog.cc:565] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: configured and running, proceeding with master startup.
21:04:11.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.524199 25850 sys_catalog.cc:455] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.524 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.524675 25850 sys_catalog.cc:458] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.525967 25861 catalog_manager.cc:1593] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
21:04:11.526 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.526254 25861 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
21:04:11.528 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.527061 25758 master_runner.cc:187] Error getting master registration for 127.25.1.189:42939: OK, instance_id { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" instance_seqno: 1783544651305528 } error { code: CATALOG_MANAGER_NOT_INITIALIZED status { code: SERVICE_UNAVAILABLE message: "Catalog manager is not initialized. State: Starting" } }
21:04:11.529 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.528887 25758 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
21:04:11.548 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.548332 25756 consensus_peers.cc:770] Retrying to get permanent uuid for remote peer: member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } attempt: 3
21:04:11.555 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.554857 25756 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: Bootstrap starting.
21:04:11.557 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.557101 25756 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: Neither blocks nor log segments found. Creating new log.
21:04:11.558 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.557862 25756 log.cc:826] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: Log is configured to *not* fsync() on all Append() calls
21:04:11.559 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.559495 25756 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: No bootstrap required, opened a new log
21:04:11.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.562453 25756 raft_consensus.cc:359] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.562 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.562618 25756 raft_consensus.cc:385] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:11.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.562669 25756 raft_consensus.cc:740] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4c43bc378a6941b7b7137fca8cf0594c, State: Initialized, Role: FOLLOWER
21:04:11.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.563211 25756 consensus_queue.cc:260] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.563 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.563738 25864 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.564050 25864 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.564 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.564484 25756 sys_catalog.cc:565] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: configured and running, proceeding with master startup.
21:04:11.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.570190 25875 catalog_manager.cc:1593] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
21:04:11.570 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.570601 25875 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
21:04:11.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.572384 25686 master_runner.cc:264] No leader master found from master 4c43bc378a6941b7b7137fca8cf0594c
21:04:11.572 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.572443 25686 master_runner.cc:419] Couldn't verify the masters in the cluster. Trying again...
21:04:11.633 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.633100 25637 tablet.cc:2406] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:04:11.701 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.698817 25864 raft_consensus.cc:493] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
21:04:11.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.699014 25864 raft_consensus.cc:515] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.700043 25864 leader_election.cc:290] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 687ff8ff42044004a9a2b4de32e50c1d (127.25.1.190:38053), f27a2990752d4a11a76d5585dcaa0f03 (127.25.1.188:41351)
21:04:11.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.700722 25802 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "4c43bc378a6941b7b7137fca8cf0594c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f27a2990752d4a11a76d5585dcaa0f03" is_pre_election: true
21:04:11.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.700976 25802 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 4c43bc378a6941b7b7137fca8cf0594c in term 0.
21:04:11.702 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.701412 25707 leader_election.cc:304] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [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: 4c43bc378a6941b7b7137fca8cf0594c, f27a2990752d4a11a76d5585dcaa0f03; no voters: 
21:04:11.706 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.702792 25864 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Leader pre-election won for term 1
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.702865 25864 raft_consensus.cc:493] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.702906 25864 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 0 FOLLOWER]: Advancing to term 1
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.704085 25864 raft_consensus.cc:515] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.704470 25864 leader_election.cc:290] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [CANDIDATE]: Term 1 election: Requested vote from peers 687ff8ff42044004a9a2b4de32e50c1d (127.25.1.190:38053), f27a2990752d4a11a76d5585dcaa0f03 (127.25.1.188:41351)
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.704972 25802 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "4c43bc378a6941b7b7137fca8cf0594c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "f27a2990752d4a11a76d5585dcaa0f03"
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.705089 25802 raft_consensus.cc:3060] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 0 FOLLOWER]: Advancing to term 1
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.706195 25802 raft_consensus.cc:2468] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4c43bc378a6941b7b7137fca8cf0594c in term 1.
21:04:11.707 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.706552 25707 leader_election.cc:304] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [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: 4c43bc378a6941b7b7137fca8cf0594c, f27a2990752d4a11a76d5585dcaa0f03; no voters: 
21:04:11.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.708747 25657 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "4c43bc378a6941b7b7137fca8cf0594c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "687ff8ff42044004a9a2b4de32e50c1d"
21:04:11.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.708992 25657 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 0 FOLLOWER]: Advancing to term 1
21:04:11.711 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.710206 25657 raft_consensus.cc:2468] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4c43bc378a6941b7b7137fca8cf0594c in term 1.
21:04:11.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.710538 25658 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "00000000000000000000000000000000" candidate_uuid: "4c43bc378a6941b7b7137fca8cf0594c" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "687ff8ff42044004a9a2b4de32e50c1d" is_pre_election: true
21:04:11.712 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.710656 25658 raft_consensus.cc:2376] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 1 FOLLOWER]: Leader pre-election vote request: Already granted yes vote for candidate 4c43bc378a6941b7b7137fca8cf0594c in term 1. Re-sending same reply.
21:04:11.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.712333 25864 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 1 FOLLOWER]: Leader election won for term 1
21:04:11.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.712585 25864 raft_consensus.cc:697] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [term 1 LEADER]: Becoming Leader. State: Replica: 4c43bc378a6941b7b7137fca8cf0594c, State: Running, Role: LEADER
21:04:11.713 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.712921 25864 consensus_queue.cc:237] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [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: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } }
21:04:11.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.715745 25864 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: SysCatalogTable state changed. Reason: New leader 4c43bc378a6941b7b7137fca8cf0594c. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.716 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.715868 25864 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: This master's current role is: LEADER
21:04:11.719 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.719331 25879 catalog_manager.cc:1510] Loading table and tablet metadata into memory...
21:04:11.720 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.720753 25879 catalog_manager.cc:1519] Initializing Kudu cluster ID...
21:04:11.727 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.727092 25781 tablet.cc:2406] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:04:11.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.727875 25802 raft_consensus.cc:1275] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [term 1 FOLLOWER]: Refusing update from remote peer 4c43bc378a6941b7b7137fca8cf0594c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:04:11.731 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.728668 25877 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [LEADER]: Connected to new peer: Peer: permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:04:11.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.732734 25850 sys_catalog.cc:455] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: SysCatalogTable state changed. Reason: New leader 4c43bc378a6941b7b7137fca8cf0594c. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.733 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.732846 25850 sys_catalog.cc:458] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.740 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.734150 25658 raft_consensus.cc:1275] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [term 1 FOLLOWER]: Refusing update from remote peer 4c43bc378a6941b7b7137fca8cf0594c: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:04:11.741 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.734700 25877 consensus_queue.cc:1048] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [LEADER]: Connected to new peer: Peer: permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:04:11.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.738265 25836 sys_catalog.cc:455] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 4c43bc378a6941b7b7137fca8cf0594c. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.743 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.738387 25836 sys_catalog.cc:458] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.744722 25877 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.745 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.744861 25877 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: This master's current role is: LEADER
21:04:11.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.746495 25836 sys_catalog.cc:455] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.746606 25836 sys_catalog.cc:458] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.747 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.747696 25880 mvcc.cc:204] Tried to move back new op lower bound from 7305398893469528064 to 7305398893423153152. Current Snapshot: MvccSnapshot[applied={T|T < 7305398893469528064}]
21:04:11.754 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.754630 25864 sys_catalog.cc:455] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: SysCatalogTable state changed. Reason: Peer health change. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.755 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.754751 25864 sys_catalog.cc:458] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c [sys.catalog]: This master's current role is: LEADER
21:04:11.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.756376 25850 sys_catalog.cc:455] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: SysCatalogTable state changed. Reason: Replicated consensus-only round. Latest consensus state: current_term: 1 leader_uuid: "4c43bc378a6941b7b7137fca8cf0594c" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "687ff8ff42044004a9a2b4de32e50c1d" member_type: VOTER last_known_addr { host: "127.25.1.190" port: 38053 } } peers { permanent_uuid: "4c43bc378a6941b7b7137fca8cf0594c" member_type: VOTER last_known_addr { host: "127.25.1.189" port: 42939 } } peers { permanent_uuid: "f27a2990752d4a11a76d5585dcaa0f03" member_type: VOTER last_known_addr { host: "127.25.1.188" port: 41351 } } }
21:04:11.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.756527 25850 sys_catalog.cc:458] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03 [sys.catalog]: This master's current role is: FOLLOWER
21:04:11.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.757418 25881 mvcc.cc:204] Tried to move back new op lower bound from 7305398893469528064 to 7305398893423153152. Current Snapshot: MvccSnapshot[applied={T|T < 7305398893469528064}]
21:04:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.758175 25879 catalog_manager.cc:1382] Generated new cluster ID: 761820ef7c6c4516bd13a7d420577a78
21:04:11.763 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.758230 25879 catalog_manager.cc:1530] Initializing Kudu internal certificate authority...
21:04:11.799 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.799391 25879 catalog_manager.cc:1405] Generated new certificate authority record
21:04:11.800 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.800767 25879 catalog_manager.cc:1539] Loading token signing keys...
21:04:11.812 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.812536 25879 catalog_manager.cc:6069] T 00000000000000000000000000000000 P 4c43bc378a6941b7b7137fca8cf0594c: Generated new TSK 0
21:04:11.813 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.813563 25879 catalog_manager.cc:1549] Initializing in-progress tserver states...
21:04:11.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.837364 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:11.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal
21:04:11.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data
21:04:11.837 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/logs
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data/info.pb
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.838 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.129:0
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.129
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.129
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.839 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:04:11.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.939284 25889 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:11.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.939491 25889 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:11.939 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.939534 25889 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:11.942 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.942691 25889 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:11.943 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.942785 25889 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.25.1.129
21:04:11.946 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.946571 25889 tablet_server_runner.cc:78] Tablet server non-default flags:
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.129:0
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:11.947 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data/info.pb
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.129
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.25889
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.129
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/logs
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:11.948 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.947793 25889 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:04:11.949 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.949061 25889 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:11.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.956964 25895 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:04:11.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.957041 25894 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:04:11.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.957139 25889 server_base.cc:1061] running on GCE node
21:04:11.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:11.957383 25897 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:04:11.957 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.957756 25889 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:11.958 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.958278 25889 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:11.959 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.959455 25889 hybrid_clock.cc:648] HybridClock initialized: now 1783544651959437 us; error 35 us; skew 500 ppm
21:04:11.961 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.961308 25889 webserver.cc:534] Webserver started at http://127.25.1.129:41803/ using document root <none> and password file <none>
21:04:11.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.961894 25889 fs_manager.cc:362] Metadata directory not provided
21:04:11.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.961979 25889 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:11.962 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.962218 25889 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.963874 25889 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data/instance:
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0dc85df147164d5e871f9897afcd19a6"
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.964403 25889 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal/instance:
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0dc85df147164d5e871f9897afcd19a6"
21:04:11.964 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.968 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.968061 25889 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.004s	sys 0.000s
21:04:11.970 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.970253 25903 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.971315 25889 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
21:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.971451 25889 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal
21:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "0dc85df147164d5e871f9897afcd19a6"
21:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:11 on dist-test-slave-nrj2"
21:04:11.971 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.971552 25889 fs_report.cc:389] FS layout report
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data/data
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:11.972 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:11.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:11.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:11.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:11.973 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:11.983 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.983358 25889 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:11.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.984131 25889 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:04:11.984 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.984346 25889 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:11.985 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.984995 25889 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:04:11.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.986064 25889 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:04:11.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.986140 25889 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:04:11.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.986196 25889 ts_tablet_manager.cc:616] Registered 0 tablets
21:04:11.986 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.986219 25889 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:04:11.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.995584 25889 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.129:33151
21:04:11.995 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.995636 26016 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.129:33151 every 8 connection(s)
21:04:11.996 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:11.996604 25889 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/data/info.pb
21:04:12.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.003185 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 25889
21:04:12.004 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.003278 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-0/wal/instance
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.005908 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/logs
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data/info.pb
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:12.006 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.130:0
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.130
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.130
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:12.007 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.006435 26018 heartbeater.cc:344] Connected to a master server at 127.25.1.190:38053
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.006661 26018 heartbeater.cc:461] Registering TS with master...
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.007290 26018 heartbeater.cc:507] Master 127.25.1.190:38053 requested a full tablet report, sending...
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.007556 26019 heartbeater.cc:344] Connected to a master server at 127.25.1.189:42939
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.007620 26019 heartbeater.cc:461] Registering TS with master...
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.007777 26019 heartbeater.cc:507] Master 127.25.1.189:42939 requested a full tablet report, sending...
21:04:12.008 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.008826 25648 ts_manager.cc:194] Registered new tserver with Master: 0dc85df147164d5e871f9897afcd19a6 (127.25.1.129:33151)
21:04:12.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.009042 25720 ts_manager.cc:194] Registered new tserver with Master: 0dc85df147164d5e871f9897afcd19a6 (127.25.1.129:33151)
21:04:12.009 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.009893 26017 heartbeater.cc:344] Connected to a master server at 127.25.1.188:41351
21:04:12.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.009969 26017 heartbeater.cc:461] Registering TS with master...
21:04:12.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.010164 26017 heartbeater.cc:507] Master 127.25.1.188:41351 requested a full tablet report, sending...
21:04:12.010 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.010536 25720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.25.1.129:34625
21:04:12.011 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.011340 25792 ts_manager.cc:194] Registered new tserver with Master: 0dc85df147164d5e871f9897afcd19a6 (127.25.1.129:33151)
21:04:12.109 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.109511 26025 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:12.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.109723 26025 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:12.110 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.109764 26025 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:12.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.113083 26025 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:12.113 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.113183 26025 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.25.1.130
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.117062 26025 tablet_server_runner.cc:78] Tablet server non-default flags:
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.130:0
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data/info.pb
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.130
21:04:12.117 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.26025
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.130
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/logs
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:12.118 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.118186 26025 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:04:12.119 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.119216 26025 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:12.125 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.125622 26033 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:04:12.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.125622 26031 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:04:12.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.125722 26030 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:04:12.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.125896 26025 server_base.cc:1061] running on GCE node
21:04:12.126 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.126515 26025 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:12.127 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.127065 26025 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:12.128 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.128216 26025 hybrid_clock.cc:648] HybridClock initialized: now 1783544652128201 us; error 35 us; skew 500 ppm
21:04:12.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.129977 26025 webserver.cc:534] Webserver started at http://127.25.1.130:44201/ using document root <none> and password file <none>
21:04:12.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.130475 26025 fs_manager.cc:362] Metadata directory not provided
21:04:12.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.130527 26025 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:12.130 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.130676 26025 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.132270 26025 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data/instance:
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2a22e1e936bb465ebac0cd3b3fc83091"
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.132692 26025 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal/instance:
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2a22e1e936bb465ebac0cd3b3fc83091"
21:04:12.132 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.135 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.135777 26025 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.003s	sys 0.001s
21:04:12.137 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.137771 26039 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.138837 26025 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.138959 26025 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "2a22e1e936bb465ebac0cd3b3fc83091"
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.139104 26025 fs_report.cc:389] FS layout report
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data/data
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:12.139 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:12.140 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:12.158 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.158033 26025 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:12.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.158810 26025 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:04:12.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.159055 26025 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:12.159 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.159685 26025 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:04:12.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.160885 26025 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:04:12.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.160964 26025 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:04:12.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.161021 26025 ts_tablet_manager.cc:616] Registered 0 tablets
21:04:12.161 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.161046 26025 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:04:12.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.170436 26025 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.130:43451
21:04:12.170 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.170492 26152 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.130:43451 every 8 connection(s)
21:04:12.171 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.171563 26025 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/data/info.pb
21:04:12.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.172744 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 26025
21:04:12.173 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.172844 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-1/wal/instance
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.176585 25606 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --block_manager=log
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=localhost
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/logs
21:04:12.177 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data/info.pb
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) tserver
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) run
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.131:0
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.131
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.131
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:12.178 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin with env {}
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.182945 26153 heartbeater.cc:344] Connected to a master server at 127.25.1.188:41351
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183010 26155 heartbeater.cc:344] Connected to a master server at 127.25.1.189:42939
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183010 26154 heartbeater.cc:344] Connected to a master server at 127.25.1.190:38053
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183215 26153 heartbeater.cc:461] Registering TS with master...
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183212 26154 heartbeater.cc:461] Registering TS with master...
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183212 26155 heartbeater.cc:461] Registering TS with master...
21:04:12.183 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183840 26154 heartbeater.cc:507] Master 127.25.1.190:38053 requested a full tablet report, sending...
21:04:12.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183887 26153 heartbeater.cc:507] Master 127.25.1.188:41351 requested a full tablet report, sending...
21:04:12.184 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.183852 26155 heartbeater.cc:507] Master 127.25.1.189:42939 requested a full tablet report, sending...
21:04:12.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.184912 25720 ts_manager.cc:194] Registered new tserver with Master: 2a22e1e936bb465ebac0cd3b3fc83091 (127.25.1.130:43451)
21:04:12.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.184957 25648 ts_manager.cc:194] Registered new tserver with Master: 2a22e1e936bb465ebac0cd3b3fc83091 (127.25.1.130:43451)
21:04:12.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.185381 25792 ts_manager.cc:194] Registered new tserver with Master: 2a22e1e936bb465ebac0cd3b3fc83091 (127.25.1.130:43451)
21:04:12.185 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.185580 25720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.25.1.130:56143
21:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.286273 26160 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
21:04:12.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.286520 26160 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
21:04:12.287 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.286583 26160 flags.cc:432] Enabled unsafe flag: --never_fsync=true
21:04:12.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.290172 26160 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
21:04:12.290 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.290319 26160 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.25.1.131
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.294239 26160 tablet_server_runner.cc:78] Tablet server non-default flags:
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_poll_interval_ms=100
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --builtin_ntp_servers=127.25.1.148:36943
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ntp_initial_sync_wait_secs=10
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --time_source=builtin
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_data_dirs=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --fs_wal_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --ipki_server_key_size=768
21:04:12.294 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --openssl_security_level_override=0
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_bind_addresses=127.25.1.131:0
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --rpc_server_allow_ephemeral_ports=true
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --metrics_log_interval_ms=1000
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_format=pb
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --server_dump_info_path=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data/info.pb
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_interface=127.25.1.131
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --webserver_port=0
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --tserver_master_addrs=127.25.1.190:38053,127.25.1.189:42939,127.25.1.188:41351
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --never_fsync=true
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --heap_profile_path=/tmp/kudu.26160
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --redact=none
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_experimental_flags=true
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --unlock_unsafe_flags=true
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --enable_minidumps=false
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --local_ip_for_outbound_sockets=127.25.1.131
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --log_dir=/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/logs
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logbuflevel=-1
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --logtostderr=true
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Tablet server version:
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) kudu 1.19.0-SNAPSHOT
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) revision 6bec869c2320d19f2589b3f609f76e5041a21d27
21:04:12.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build type DEBUG
21:04:12.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) built by None at 08 Jul 2026 20:43:46 UTC on bdcb31816ec0
21:04:12.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) build id 16875
21:04:12.296 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.295691 26160 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:04:12.297 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.296916 26160 file_cache.cc:492] Constructed file cache file cache with capacity 419430
21:04:12.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.303452 26168 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:04:12.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.303472 26165 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:04:12.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:12.303620 26166 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:04:12.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.303970 26160 server_base.cc:1061] running on GCE node
21:04:12.304 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.304342 26160 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
21:04:12.305 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.304921 26160 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
21:04:12.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.306097 26160 hybrid_clock.cc:648] HybridClock initialized: now 1783544652306078 us; error 38 us; skew 500 ppm
21:04:12.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.307967 26160 webserver.cc:534] Webserver started at http://127.25.1.131:36349/ using document root <none> and password file <none>
21:04:12.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.308539 26160 fs_manager.cc:362] Metadata directory not provided
21:04:12.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.308621 26160 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
21:04:12.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.308858 26160 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
21:04:12.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.310451 26160 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data/instance:
21:04:12.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4dc63b2de1eb47bc81b4be210826a12f"
21:04:12.310 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.310992 26160 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal/instance:
21:04:12.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4dc63b2de1eb47bc81b4be210826a12f"
21:04:12.312 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.315 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.315562 26160 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.001s
21:04:12.318 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.318188 26174 log_block_manager.cc:4031] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.319427 26160 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.319533 26160 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data,/tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) uuid: "4dc63b2de1eb47bc81b4be210826a12f"
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) format_stamp: "Formatted at 2026-07-08 21:04:12 on dist-test-slave-nrj2"
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.319631 26160 fs_report.cc:389] FS layout report
21:04:12.319 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) --------------------
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) wal directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) metadata directory: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 1 data directories: /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data/data
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live blocks: 0
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes: 0
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total live bytes (after alignment): 0
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total number of LBM containers: 0 (0 full)
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for missing blocks
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Did not check for orphaned blocks
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM containers with extra space: 0 (0 repaired)
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total full LBM container extra space in bytes: 0 (0 repaired)
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total incomplete LBM containers: 0 (0 repaired)
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total LBM partial records: 0 (0 repaired)
21:04:12.320 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
21:04:12.352 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.352453 26160 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
21:04:12.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.353102 26160 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:04:12.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.353253 26160 kserver.cc:163] Server-wide thread pool size limit: 3276
21:04:12.353 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.353803 26160 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
21:04:12.354 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.354805 26160 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
21:04:12.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.354853 26160 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
21:04:12.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.354892 26160 ts_tablet_manager.cc:616] Registered 0 tablets
21:04:12.355 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.354908 26160 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
21:04:12.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.364027 26160 rpc_server.cc:307] RPC server started. Bound to: 127.25.1.131:35159
21:04:12.364 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.364110 26287 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.1.131:35159 every 8 connection(s)
21:04:12.365 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.364953 26160 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/data/info.pb
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.373867 26290 heartbeater.cc:344] Connected to a master server at 127.25.1.189:42939
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.373853 26288 heartbeater.cc:344] Connected to a master server at 127.25.1.188:41351
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.373834 26289 heartbeater.cc:344] Connected to a master server at 127.25.1.190:38053
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374130 26289 heartbeater.cc:461] Registering TS with master...
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374130 26290 heartbeater.cc:461] Registering TS with master...
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374365 25606 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu as pid 26160
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374465 25606 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskZMNQOV/test-tmp/mini-kudu-cluster6190299692580374050/ts-2/wal/instance
21:04:12.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374737 26290 heartbeater.cc:507] Master 127.25.1.189:42939 requested a full tablet report, sending...
21:04:12.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374737 26289 heartbeater.cc:507] Master 127.25.1.190:38053 requested a full tablet report, sending...
21:04:12.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.374130 26288 heartbeater.cc:461] Registering TS with master...
21:04:12.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.375483 26288 heartbeater.cc:507] Master 127.25.1.188:41351 requested a full tablet report, sending...
21:04:12.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.375841 25720 ts_manager.cc:194] Registered new tserver with Master: 4dc63b2de1eb47bc81b4be210826a12f (127.25.1.131:35159)
21:04:12.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.375964 25648 ts_manager.cc:194] Registered new tserver with Master: 4dc63b2de1eb47bc81b4be210826a12f (127.25.1.131:35159)
21:04:12.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.376260 25792 ts_manager.cc:194] Registered new tserver with Master: 4dc63b2de1eb47bc81b4be210826a12f (127.25.1.131:35159)
21:04:12.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.376538 25720 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.25.1.131:60761
21:04:12.381 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.380895 25606 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
21:04:12.381 [DEBUG - main] (MiniKuduCluster.java:195) Response: 
21:04:12.382 [DEBUG - main] (MiniKuduCluster.java:185) Request: get_masters {
}

21:04:12.392 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_masters {
  masters {
    id {
      type: MASTER
      index: 0
    }
    bound_rpc_address {
      host: "127.25.1.190"
      port: 38053
    }
    bound_http_address {
      host: "127.25.1.190"
      port: 43659
    }
  }
  masters {
    id {
      type: MASTER
      index: 1
    }
    bound_rpc_address {
      host: "127.25.1.189"
      port: 42939
    }
    bound_http_address {
      host: "127.25.1.189"
      port: 42139
    }
  }
  masters {
    id {
      type: MASTER
      index: 2
    }
    bound_rpc_address {
      host: "127.25.1.188"
      port: 41351
    }
    bound_http_address {
      host: "127.25.1.188"
      port: 45057
    }
  }
}

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

21:04:12.397 [DEBUG - main] (MiniKuduCluster.java:195) Response: get_tservers {
  tservers {
    id {
      type: TSERVER
      index: 0
    }
    bound_rpc_address {
      host: "127.25.1.129"
      port: 33151
    }
    bound_http_address {
      host: "127.25.1.129"
      port: 41803
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 1
    }
    bound_rpc_address {
      host: "127.25.1.130"
      port: 43451
    }
    bound_http_address {
      host: "127.25.1.130"
      port: 44201
    }
  }
  tservers {
    id {
      type: TSERVER
      index: 2
    }
    bound_rpc_address {
      host: "127.25.1.131"
      port: 35159
    }
    bound_http_address {
      host: "127.25.1.131"
      port: 36349
    }
  }
}

21:04:12.398 [INFO - main] (KuduTestHarness.java:157) Creating a new Kudu client...
21:04:12.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.519291 25848 catalog_manager.cc:1294] Loaded cluster ID: 761820ef7c6c4516bd13a7d420577a78
21:04:12.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.519381 25848 catalog_manager.cc:1587] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: loading cluster ID for follower catalog manager: success
21:04:12.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.521778 25848 catalog_manager.cc:1609] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: acquiring CA information for follower catalog manager: success
21:04:12.523 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.523204 25848 catalog_manager.cc:1637] T 00000000000000000000000000000000 P 687ff8ff42044004a9a2b4de32e50c1d: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
21:04:12.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.527940 25861 catalog_manager.cc:1294] Loaded cluster ID: 761820ef7c6c4516bd13a7d420577a78
21:04:12.530 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.528028 25861 catalog_manager.cc:1587] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: loading cluster ID for follower catalog manager: success
21:04:12.531 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.530978 25861 catalog_manager.cc:1609] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: acquiring CA information for follower catalog manager: success
21:04:12.532 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:12.532696 25861 catalog_manager.cc:1637] T 00000000000000000000000000000000 P f27a2990752d4a11a76d5585dcaa0f03: importing token verification keys for follower catalog manager: success; most recent TSK sequence number 0
21:04:12.581 [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:04:12.632 [DEBUG - main] (SecurityUtil.java:122) Could not login via JAAS. Using no credentials: Unable to obtain Principal Name for authentication 
21:04:12.765 [DEBUG - main] (Connection.java:748) [peer master-127.25.1.190:38053(127.25.1.190:38053)] connecting to peer
21:04:12.815 [DEBUG - main] (Connection.java:748) [peer master-127.25.1.189:42939(127.25.1.189:42939)] connecting to peer
21:04:12.819 [DEBUG - main] (Connection.java:748) [peer master-127.25.1.188:41351(127.25.1.188:41351)] connecting to peer
21:04:12.832 [DEBUG - kudu-nio-0] (Connection.java:757) [peer master-127.25.1.190:38053(127.25.1.190:38053)] Successfully connected to peer
21:04:12.835 [DEBUG - kudu-nio-2] (Connection.java:757) [peer master-127.25.1.188:41351(127.25.1.188:41351)] Successfully connected to peer
21:04:12.836 [DEBUG - kudu-nio-1] (Connection.java:757) [peer master-127.25.1.189:42939(127.25.1.189:42939)] Successfully connected to peer
21:04:12.929 [DEBUG - kudu-nio-1] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.25.1.189
21:04:12.930 [DEBUG - kudu-nio-0] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.25.1.190
21:04:12.931 [DEBUG - kudu-nio-2] (Negotiator.java:529) SASL mechanism PLAIN chosen for peer 127.25.1.188
21:04:13.013 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.013356 26019 heartbeater.cc:499] Master 127.25.1.189:42939 was elected leader, sending a full tablet report...
21:04:13.155 [DEBUG - kudu-nio-1] (Negotiator.java:919) Authenticated connection [id: 0x74340cba, L:/127.0.0.1:54716 - R:/127.25.1.189:42939] using SASL/PLAIN
21:04:13.155 [DEBUG - kudu-nio-2] (Negotiator.java:919) Authenticated connection [id: 0x6fe66bb2, L:/127.0.0.1:36616 - R:/127.25.1.188:41351] using SASL/PLAIN
21:04:13.155 [DEBUG - kudu-nio-0] (Negotiator.java:919) Authenticated connection [id: 0x5c6d0750, L:/127.0.0.1:58876 - R:/127.25.1.190:38053] using SASL/PLAIN
21:04:13.187 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.187423 26155 heartbeater.cc:499] Master 127.25.1.189:42939 was elected leader, sending a full tablet report...
21:04:13.192 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet Kudu Master for table 'Kudu Master' with partition [<start>, <end>)
21:04:13.193 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=CreateTable, tablet=null, attempt=1, TimeoutTracker(timeout=50000, elapsed=463), Traces: [0ms] refreshing cache from master, [23ms] Sub RPC ConnectToMaster: sending RPC to server master-127.25.1.190:38053, [81ms] Sub RPC ConnectToMaster: sending RPC to server master-127.25.1.189:42939, [86ms] Sub RPC ConnectToMaster: sending RPC to server master-127.25.1.188:41351, [435ms] Sub RPC ConnectToMaster: received response from server master-127.25.1.190:38053: OK, [436ms] Sub RPC ConnectToMaster: received response from server master-127.25.1.188:41351: OK, [436ms] Sub RPC ConnectToMaster: received response from server master-127.25.1.189:42939: OK, deferred=null) after lookup
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.233688 25720 catalog_manager.cc:2282] Servicing CreateTable request from {username='slave'} at 127.0.0.1:54716:
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) name: "org.apache.kudu.client.TestHybridTime-1783544650564"
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) schema {
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   columns {
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     name: "key"
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     type: STRING
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_key: true
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_nullable: false
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     cfile_block_size: 0
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     immutable: false
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     is_auto_incrementing: false
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) partition_schema {
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   range_schema {
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     columns {
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)       name: "key"
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)     }
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751)   }
21:04:13.236 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) }
21:04:13.237 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:13.237037 25720 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-1783544650564 in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
21:04:13.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.261122 26087 tablet_service.cc:1511] Processing CreateTablet for tablet 57d2147505544719b2baa3b7f0fa5889 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544650564 [id=33831baf73704e449302b0adb407f911]), partition=RANGE (key) PARTITION UNBOUNDED
21:04:13.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.262184 26087 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 57d2147505544719b2baa3b7f0fa5889. 1 dirs total, 0 dirs full, 0 dirs failed
21:04:13.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.262401 25951 tablet_service.cc:1511] Processing CreateTablet for tablet 57d2147505544719b2baa3b7f0fa5889 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544650564 [id=33831baf73704e449302b0adb407f911]), partition=RANGE (key) PARTITION UNBOUNDED
21:04:13.263 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.263303 25951 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 57d2147505544719b2baa3b7f0fa5889. 1 dirs total, 0 dirs full, 0 dirs failed
21:04:13.269 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.269439 26316 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Bootstrap starting.
21:04:13.270 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.270027 26317 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Bootstrap starting.
21:04:13.274 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:894) Opened table 33831baf73704e449302b0adb407f911
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.271739 26222 tablet_service.cc:1511] Processing CreateTablet for tablet 57d2147505544719b2baa3b7f0fa5889 (DEFAULT_TABLE table=org.apache.kudu.client.TestHybridTime-1783544650564 [id=33831baf73704e449302b0adb407f911]), partition=RANGE (key) PARTITION UNBOUNDED
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.272675 26222 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 57d2147505544719b2baa3b7f0fa5889. 1 dirs total, 0 dirs full, 0 dirs failed
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.273064 26317 tablet_bootstrap.cc:654] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Neither blocks nor log segments found. Creating new log.
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.273918 26317 log.cc:826] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Log is configured to *not* fsync() on all Append() calls
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.275825 26316 tablet_bootstrap.cc:654] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Neither blocks nor log segments found. Creating new log.
21:04:13.276 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.276669 26316 log.cc:826] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Log is configured to *not* fsync() on all Append() calls
21:04:13.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.278163 26316 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: No bootstrap required, opened a new log
21:04:13.278 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.278380 26316 ts_tablet_manager.cc:1403] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Time spent bootstrapping tablet: real 0.009s	user 0.004s	sys 0.000s
21:04:13.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.279994 26317 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: No bootstrap required, opened a new log
21:04:13.280 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.280351 26317 ts_tablet_manager.cc:1403] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Time spent bootstrapping tablet: real 0.010s	user 0.005s	sys 0.000s
21:04:13.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.282105 26316 raft_consensus.cc:359] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.282325 26316 raft_consensus.cc:385] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:13.282 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.282374 26316 raft_consensus.cc:740] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 2a22e1e936bb465ebac0cd3b3fc83091, State: Initialized, Role: FOLLOWER
21:04:13.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.282850 26316 consensus_queue.cc:260] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [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: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.283 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.283689 26316 ts_tablet_manager.cc:1434] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Time spent starting tablet: real 0.005s	user 0.003s	sys 0.003s
21:04:13.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.284092 26317 raft_consensus.cc:359] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.284529 26317 raft_consensus.cc:385] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:13.284 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.284739 26317 raft_consensus.cc:740] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 0dc85df147164d5e871f9897afcd19a6, State: Initialized, Role: FOLLOWER
21:04:13.285 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.285284 26317 consensus_queue.cc:260] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [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: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.286 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.286268 26317 ts_tablet_manager.cc:1434] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Time spent starting tablet: real 0.006s	user 0.004s	sys 0.000s
21:04:13.295 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.295173 26320 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Bootstrap starting.
21:04:13.300 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.300287 26320 tablet_bootstrap.cc:654] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Neither blocks nor log segments found. Creating new log.
21:04:13.301 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.301574 26320 log.cc:826] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Log is configured to *not* fsync() on all Append() calls
21:04:13.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.303416 26320 tablet_bootstrap.cc:492] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: No bootstrap required, opened a new log
21:04:13.303 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.303635 26320 ts_tablet_manager.cc:1403] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Time spent bootstrapping tablet: real 0.009s	user 0.005s	sys 0.000s
21:04:13.306 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.306634 26320 raft_consensus.cc:359] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.306810 26320 raft_consensus.cc:385] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
21:04:13.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.306856 26320 raft_consensus.cc:740] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4dc63b2de1eb47bc81b4be210826a12f, State: Initialized, Role: FOLLOWER
21:04:13.307 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.307345 26320 consensus_queue.cc:260] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [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: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.308198 26320 ts_tablet_manager.cc:1434] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Time spent starting tablet: real 0.004s	user 0.005s	sys 0.000s
21:04:13.308 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.308408 26290 heartbeater.cc:499] Master 127.25.1.189:42939 was elected leader, sending a full tablet report...
21:04:13.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.366761 26324 raft_consensus.cc:493] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
21:04:13.367 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.366977 26324 raft_consensus.cc:515] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.368 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.368152 26324 leader_election.cc:290] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 2a22e1e936bb465ebac0cd3b3fc83091 (127.25.1.130:43451), 0dc85df147164d5e871f9897afcd19a6 (127.25.1.129:33151)
21:04:13.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.373128 26107 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "57d2147505544719b2baa3b7f0fa5889" candidate_uuid: "4dc63b2de1eb47bc81b4be210826a12f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" is_pre_election: true
21:04:13.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:13.373344 26291 tablet.cc:2406] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:04:13.373 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.373420 26107 raft_consensus.cc:2468] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 4dc63b2de1eb47bc81b4be210826a12f in term 0.
21:04:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.373916 26176 leader_election.cc:304] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [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: 2a22e1e936bb465ebac0cd3b3fc83091, 4dc63b2de1eb47bc81b4be210826a12f; no voters: 
21:04:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.374197 26324 raft_consensus.cc:2804] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Leader pre-election won for term 1
21:04:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.374276 26324 raft_consensus.cc:493] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
21:04:13.374 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.374331 26324 raft_consensus.cc:3060] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 0 FOLLOWER]: Advancing to term 1
21:04:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.374622 25971 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "57d2147505544719b2baa3b7f0fa5889" candidate_uuid: "4dc63b2de1eb47bc81b4be210826a12f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0dc85df147164d5e871f9897afcd19a6" is_pre_election: true
21:04:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.374878 25971 raft_consensus.cc:2468] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 4dc63b2de1eb47bc81b4be210826a12f in term 0.
21:04:13.375 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.375510 26324 raft_consensus.cc:515] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.375876 26324 leader_election.cc:290] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [CANDIDATE]: Term 1 election: Requested vote from peers 2a22e1e936bb465ebac0cd3b3fc83091 (127.25.1.130:43451), 0dc85df147164d5e871f9897afcd19a6 (127.25.1.129:33151)
21:04:13.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.376196 26107 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "57d2147505544719b2baa3b7f0fa5889" candidate_uuid: "4dc63b2de1eb47bc81b4be210826a12f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "2a22e1e936bb465ebac0cd3b3fc83091"
21:04:13.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.376340 26107 raft_consensus.cc:3060] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 0 FOLLOWER]: Advancing to term 1
21:04:13.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.376350 25971 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "57d2147505544719b2baa3b7f0fa5889" candidate_uuid: "4dc63b2de1eb47bc81b4be210826a12f" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "0dc85df147164d5e871f9897afcd19a6"
21:04:13.376 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.376497 25971 raft_consensus.cc:3060] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 0 FOLLOWER]: Advancing to term 1
21:04:13.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.377187 26107 raft_consensus.cc:2468] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4dc63b2de1eb47bc81b4be210826a12f in term 1.
21:04:13.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.377471 26176 leader_election.cc:304] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [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: 2a22e1e936bb465ebac0cd3b3fc83091, 4dc63b2de1eb47bc81b4be210826a12f; no voters: 
21:04:13.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.377488 25971 raft_consensus.cc:2468] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 4dc63b2de1eb47bc81b4be210826a12f in term 1.
21:04:13.377 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.377626 26324 raft_consensus.cc:2804] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 1 FOLLOWER]: Leader election won for term 1
21:04:13.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.377873 26324 raft_consensus.cc:697] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [term 1 LEADER]: Becoming Leader. State: Replica: 4dc63b2de1eb47bc81b4be210826a12f, State: Running, Role: LEADER
21:04:13.378 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.378209 26324 consensus_queue.cc:237] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [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: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } }
21:04:13.382 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.381641 25719 catalog_manager.cc:5696] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f reported cstate change: term changed from 0 to 1, leader changed from <none> to 4dc63b2de1eb47bc81b4be210826a12f (127.25.1.131). New cstate: current_term: 1 leader_uuid: "4dc63b2de1eb47bc81b4be210826a12f" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "4dc63b2de1eb47bc81b4be210826a12f" member_type: VOTER last_known_addr { host: "127.25.1.131" port: 35159 } health_report { overall_health: HEALTHY } } }
21:04:13.411 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:2538) Learned about tablet 57d2147505544719b2baa3b7f0fa5889 for table 'org.apache.kudu.client.TestHybridTime-1783544650564' with partition [<start>, <end>)
21:04:13.417 [DEBUG - kudu-nio-1] (TableLocationsCache.java:192) Discovered table locations:	[Tablet{lowerBoundPartitionKey=0x, upperBoundPartitionKey=0x, ttl=299994, tablet=57d2147505544719b2baa3b7f0fa5889@[0dc85df147164d5e871f9897afcd19a6(127.25.1.129:33151),2a22e1e936bb465ebac0cd3b3fc83091(127.25.1.130:43451),4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)[L]]}]
21:04:13.419 [DEBUG - kudu-nio-1] (AsyncKuduClient.java:1488) Retrying sending RPC KuduRpc(method=Write, tablet=null, attempt=1, sequence_id=-1, TimeoutTracker(timeout=30000, elapsed=16), Traces: [0ms] refreshing cache from master, [0ms] Sub RPC GetTableLocations: sending RPC to server master-127.25.1.189:42939, [8ms] Sub RPC GetTableLocations: received response from server master-127.25.1.189:42939: OK, deferred=null) after lookup
21:04:13.426 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:13.426265 26156 tablet.cc:2406] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:04:13.428 [DEBUG - kudu-nio-1] (Connection.java:748) [peer 4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)] connecting to peer
21:04:13.430 [DEBUG - kudu-nio-3] (Connection.java:757) [peer 4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)] Successfully connected to peer
21:04:13.499 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) W20260708 21:04:13.498831 26020 tablet.cc:2406] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6: Can't schedule compaction. Clean time has not been advanced past its initial value.
21:04:13.504 [DEBUG - kudu-nio-3] (Negotiator.java:919) Authenticated connection [id: 0xb65b9a62, L:/127.0.0.1:36732 - R:/127.25.1.131:35159] using TOKEN/null
21:04:13.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.511217 26107 raft_consensus.cc:1275] T 57d2147505544719b2baa3b7f0fa5889 P 2a22e1e936bb465ebac0cd3b3fc83091 [term 1 FOLLOWER]: Refusing update from remote peer 4dc63b2de1eb47bc81b4be210826a12f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:04:13.511 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.511444 25971 raft_consensus.cc:1275] T 57d2147505544719b2baa3b7f0fa5889 P 0dc85df147164d5e871f9897afcd19a6 [term 1 FOLLOWER]: Refusing update from remote peer 4dc63b2de1eb47bc81b4be210826a12f: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
21:04:13.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.512041 26324 consensus_queue.cc:1048] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [LEADER]: Connected to new peer: Peer: permanent_uuid: "2a22e1e936bb465ebac0cd3b3fc83091" member_type: VOTER last_known_addr { host: "127.25.1.130" port: 43451 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:04:13.512 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.512252 26327 consensus_queue.cc:1048] T 57d2147505544719b2baa3b7f0fa5889 P 4dc63b2de1eb47bc81b4be210826a12f [LEADER]: Connected to new peer: Peer: permanent_uuid: "0dc85df147164d5e871f9897afcd19a6" member_type: VOTER last_known_addr { host: "127.25.1.129" port: 33151 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
21:04:13.525 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.525116 26334 mvcc.cc:204] Tried to move back new op lower bound from 7305398900773773312 to 7305398900239810560. Current Snapshot: MvccSnapshot[applied={T|T < 7305398900773773312}]
21:04:13.562 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.576 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.584 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.597 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1099069914(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:04:13.616 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.616 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@1368062259(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:04:13.624 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.625 [DEBUG - Time-limited test] (AsyncKuduSession.java:592) flushing buffer: Buffer{operations=1, operationSize=26, flusherTask=null, flushNotification=Deferred@451798442(state=PENDING, result=null, callback=<none>, errback=<none>)}
21:04:13.633 [DEBUG - Time-limited test] (TestHybridTime.java:121) Clock value after write[%d]: %s Logical value: %d
21:04:13.681 [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-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.687 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 1 rows, more = false, responseScanTimestamp = 7305398921253773313) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.691 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 2 rows, more = false, responseScanTimestamp = 7305398921253773317) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.695 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 3 rows, more = false, responseScanTimestamp = 7305398921253773321) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.701 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 4 rows, more = false, responseScanTimestamp = 7305398921253773325) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.705 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 5 rows, more = false, responseScanTimestamp = 7305398921253773329) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.708 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 6 rows, more = false, responseScanTimestamp = 7305398921253773335) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.712 [DEBUG - kudu-nio-3] (AsyncKuduScanner.java:1370) AsyncKuduScanner$Response(scannerId = "", data = RowwiseRowResultIterator for 7 rows, more = false, responseScanTimestamp = 7305398921253773336) for scanner KuduScanner(table=org.apache.kudu.client.TestHybridTime-1783544650564, tablet=57d2147505544719b2baa3b7f0fa5889, scannerId=null, scanRequestTimeout=30000, startPrimaryKey=<start>, endPrimaryKey=<end>, lastPrimaryKey=<last>)
21:04:13.715 [DEBUG - main] (Connection.java:575) [peer master-127.25.1.189:42939(127.25.1.189:42939)] disconnecting while in state READY
21:04:13.716 [DEBUG - main] (Connection.java:575) [peer 4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)] disconnecting while in state READY
21:04:13.716 [DEBUG - main] (Connection.java:575) [peer master-127.25.1.190:38053(127.25.1.190:38053)] disconnecting while in state READY
21:04:13.719 [DEBUG - main] (Connection.java:575) [peer master-127.25.1.188:41351(127.25.1.188:41351)] disconnecting while in state READY
21:04:13.721 [DEBUG - kudu-nio-1] (Connection.java:239) [peer master-127.25.1.189:42939(127.25.1.189:42939)] handling channelInactive
21:04:13.721 [DEBUG - kudu-nio-2] (Connection.java:239) [peer master-127.25.1.188:41351(127.25.1.188:41351)] handling channelInactive
21:04:13.722 [DEBUG - kudu-nio-2] (Connection.java:709) [peer master-127.25.1.188:41351(127.25.1.188:41351)] cleaning up while in state READY due to: connection closed
21:04:13.722 [DEBUG - kudu-nio-0] (Connection.java:239) [peer master-127.25.1.190:38053(127.25.1.190:38053)] handling channelInactive
21:04:13.723 [DEBUG - kudu-nio-0] (Connection.java:709) [peer master-127.25.1.190:38053(127.25.1.190:38053)] cleaning up while in state READY due to: connection closed
21:04:13.723 [DEBUG - kudu-nio-1] (Connection.java:709) [peer master-127.25.1.189:42939(127.25.1.189:42939)] cleaning up while in state READY due to: connection closed
21:04:13.723 [DEBUG - kudu-nio-3] (AsyncKuduClient.java:2704) Releasing all remaining resources
21:04:13.727 [DEBUG - kudu-nio-3] (Connection.java:239) [peer 4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)] handling channelInactive
21:04:13.727 [DEBUG - kudu-nio-3] (Connection.java:709) [peer 4dc63b2de1eb47bc81b4be210826a12f(127.25.1.131:35159)] cleaning up while in state READY due to: connection closed
21:04:13.728 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.727356 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 25889
21:04:13.738 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.737879 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 26025
21:04:13.744 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.744509 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 26160
21:04:13.750 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.750010 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 25617
21:04:13.757 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.756184 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 25686
21:04:13.762 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) I20260708 21:04:13.762434 25606 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskZMNQOV/build/debug/bin/kudu with pid 25758
21:04:13.796 [INFO - cluster stderr printer] (MiniKuduCluster.java:751) 2026-07-08T21:04:13Z chronyd exiting

Time: 3.169

OK (1 test)

