[==========] Running 3 tests from 1 test suite.
[----------] Global test environment set-up.
[----------] 3 tests from VarcharItest
[ RUN      ] VarcharItest.TestVarcharTruncation
2026-08-12T08:03:54Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
2026-08-12T08:03:54Z Disabled control of system clock
WARNING: Logging before InitGoogleLogging() is written to STDERR
I20260812 08:03:54.209085  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
master
run
--ipki_ca_key_size=768
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:35919
--webserver_interface=127.4.183.126
--webserver_port=0
--builtin_ntp_servers=127.4.183.84:35161
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--rpc_reuseport=true
--master_addresses=127.4.183.126:35919 with env {}
W20260812 08:03:54.321943  4838 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:54.322216  4838 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:54.322259  4838 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:54.326109  4838 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
W20260812 08:03:54.326197  4838 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:54.326220  4838 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
W20260812 08:03:54.326237  4838 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
I20260812 08:03:54.330482  4838 master_runner.cc:387] Master server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:35161
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal
--ipki_ca_key_size=768
--master_addresses=127.4.183.126:35919
--ipki_server_key_size=768
--openssl_security_level_override=0
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:35919
--rpc_reuseport=true
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--webserver_interface=127.4.183.126
--webserver_port=0
--never_fsync=true
--heap_profile_path=/tmp/kudu.4838
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false

Master server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:54.331799  4838 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:54.333122  4838 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:54.339602  4843 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
W20260812 08:03:54.339573  4847 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
W20260812 08:03:54.339578  4845 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
I20260812 08:03:54.339956  4838 server_base.cc:1061] running on GCE node
I20260812 08:03:54.340583  4838 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:54.341583  4838 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:54.342794  4838 hybrid_clock.cc:648] HybridClock initialized: now 1786521834342742 us; error 87 us; skew 500 ppm
I20260812 08:03:54.345227  4838 webserver.cc:533] Webserver started at http://127.4.183.126:34993/ using document root <none> and password file <none>
I20260812 08:03:54.345896  4838 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:54.345963  4838 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:54.346167  4838 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:54.347986  4838 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data/instance:
uuid: "66db6dfe9a2d43aaaca44cf61f77a06d"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.348503  4838 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal/instance:
uuid: "66db6dfe9a2d43aaaca44cf61f77a06d"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.352490  4838 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
I20260812 08:03:54.355137  4853 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.356419  4838 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
I20260812 08:03:54.356554  4838 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal
uuid: "66db6dfe9a2d43aaaca44cf61f77a06d"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.356645  4838 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:54.367993  4838 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:54.368677  4838 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:54.368845  4838 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:54.377007  4911 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.126:35919 every 8 connection(s)
I20260812 08:03:54.377017  4838 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.126:35919
I20260812 08:03:54.378281  4838 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
I20260812 08:03:54.381466  4912 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:54.386623  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 4838
I20260812 08:03:54.386979  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/master-0/wal/instance
I20260812 08:03:54.387097  4912 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d: Bootstrap starting.
I20260812 08:03:54.389609  4912 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:54.390502  4912 log.cc:826] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:54.392506  4912 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d: No bootstrap required, opened a new log
I20260812 08:03:54.395772  4912 raft_consensus.cc:359] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } }
I20260812 08:03:54.396042  4912 raft_consensus.cc:385] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:54.396102  4912 raft_consensus.cc:740] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 66db6dfe9a2d43aaaca44cf61f77a06d, State: Initialized, Role: FOLLOWER
I20260812 08:03:54.396633  4912 consensus_queue.cc:260] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } }
I20260812 08:03:54.396801  4912 raft_consensus.cc:399] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:03:54.396893  4912 raft_consensus.cc:493] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:03:54.397013  4912 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:54.398052  4912 raft_consensus.cc:515] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } }
I20260812 08:03:54.398473  4912 leader_election.cc:304] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 66db6dfe9a2d43aaaca44cf61f77a06d; no voters: 
I20260812 08:03:54.398854  4912 leader_election.cc:290] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:03:54.399004  4917 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:54.399232  4917 raft_consensus.cc:697] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [term 1 LEADER]: Becoming Leader. State: Replica: 66db6dfe9a2d43aaaca44cf61f77a06d, State: Running, Role: LEADER
I20260812 08:03:54.399685  4917 consensus_queue.cc:237] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } }
I20260812 08:03:54.400197  4912 sys_catalog.cc:565] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [sys.catalog]: configured and running, proceeding with master startup.
I20260812 08:03:54.401490  4919 sys_catalog.cc:455] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } } }
I20260812 08:03:54.401619  4919 sys_catalog.cc:458] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:54.401624  4920 sys_catalog.cc:455] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [sys.catalog]: SysCatalogTable state changed. Reason: New leader 66db6dfe9a2d43aaaca44cf61f77a06d. Latest consensus state: current_term: 1 leader_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "66db6dfe9a2d43aaaca44cf61f77a06d" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 35919 } } }
I20260812 08:03:54.401748  4920 sys_catalog.cc:458] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:54.402446  4928 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 08:03:54.405714  4928 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 08:03:54.412410  4928 catalog_manager.cc:1383] Generated new cluster ID: a3b72940de5b4347b70012a961e88db6
I20260812 08:03:54.412536  4928 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 08:03:54.424150  4928 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 08:03:54.425491  4928 catalog_manager.cc:1540] Loading token signing keys...
I20260812 08:03:54.434726  4928 catalog_manager.cc:6092] T 00000000000000000000000000000000 P 66db6dfe9a2d43aaaca44cf61f77a06d: Generated new TSK 0
I20260812 08:03:54.435431  4928 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 08:03:54.443575  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.65:0
--local_ip_for_outbound_sockets=127.4.183.65
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--builtin_ntp_servers=127.4.183.84:35161
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
W20260812 08:03:54.563022  4939 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:54.563277  4939 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:54.563354  4939 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:54.566985  4939 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:54.567139  4939 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.65
I20260812 08:03:54.571470  4939 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:35161
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.65:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--never_fsync=true
--heap_profile_path=/tmp/kudu.4939
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.65

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:54.572685  4939 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:54.573899  4939 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:54.581210  4946 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
W20260812 08:03:54.581219  4948 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
W20260812 08:03:54.581224  4945 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
I20260812 08:03:54.582177  4939 server_base.cc:1061] running on GCE node
I20260812 08:03:54.582664  4939 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:54.583359  4939 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:54.584582  4939 hybrid_clock.cc:648] HybridClock initialized: now 1786521834584549 us; error 52 us; skew 500 ppm
I20260812 08:03:54.587033  4939 webserver.cc:533] Webserver started at http://127.4.183.65:37709/ using document root <none> and password file <none>
I20260812 08:03:54.587711  4939 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:54.587823  4939 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:54.588114  4939 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:54.589972  4939 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data/instance:
uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.590600  4939 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance:
uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.594998  4939 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.004s	sys 0.000s
I20260812 08:03:54.598060  4956 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.599784  4939 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
I20260812 08:03:54.599964  4939 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal
uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.600135  4939 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:54.640064  4939 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:54.640970  4939 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:54.641219  4939 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:54.642009  4939 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:54.643287  4939 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:54.643378  4939 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.643473  4939 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:54.643529  4939 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.655133  4939 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.65:42225
I20260812 08:03:54.655233  5081 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.65:42225 every 8 connection(s)
I20260812 08:03:54.656332  4939 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
I20260812 08:03:54.661929  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 4939
I20260812 08:03:54.662072  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance
I20260812 08:03:54.664649  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.66:0
--local_ip_for_outbound_sockets=127.4.183.66
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--builtin_ntp_servers=127.4.183.84:35161
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:54.668553  5082 heartbeater.cc:344] Connected to a master server at 127.4.183.126:35919
I20260812 08:03:54.668913  5082 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:54.669591  5082 heartbeater.cc:507] Master 127.4.183.126:35919 requested a full tablet report, sending...
I20260812 08:03:54.671810  4871 ts_manager.cc:194] Registered new tserver with Master: 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65:42225)
I20260812 08:03:54.673738  4871 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.65:58439
W20260812 08:03:54.780826  5085 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:54.781101  5085 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:54.781153  5085 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:54.785310  5085 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:54.785456  5085 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.66
I20260812 08:03:54.789755  5085 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:35161
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.66:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--never_fsync=true
--heap_profile_path=/tmp/kudu.5085
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.66

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:54.791051  5085 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:54.792249  5085 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:54.799031  5091 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
W20260812 08:03:54.799055  5094 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
W20260812 08:03:54.799031  5090 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
I20260812 08:03:54.799299  5085 server_base.cc:1061] running on GCE node
I20260812 08:03:54.799758  5085 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:54.800402  5085 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:54.801612  5085 hybrid_clock.cc:648] HybridClock initialized: now 1786521834801579 us; error 42 us; skew 500 ppm
I20260812 08:03:54.803828  5085 webserver.cc:533] Webserver started at http://127.4.183.66:41043/ using document root <none> and password file <none>
I20260812 08:03:54.804464  5085 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:54.804555  5085 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:54.804800  5085 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:54.806528  5085 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data/instance:
uuid: "6d73a1531c67413caee6856eed7754c9"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.807116  5085 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance:
uuid: "6d73a1531c67413caee6856eed7754c9"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.811144  5085 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.003s	sys 0.000s
I20260812 08:03:54.813732  5101 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.815101  5085 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
I20260812 08:03:54.815272  5085 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal
uuid: "6d73a1531c67413caee6856eed7754c9"
format_stamp: "Formatted at 2026-08-12 08:03:54 on dist-test-slave-8tdl"
I20260812 08:03:54.815398  5085 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:54.828712  5085 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:54.829757  5085 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:54.830042  5085 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:54.830839  5085 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:54.832120  5085 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:54.832203  5085 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.832285  5085 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:54.832330  5085 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:54.844005  5085 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.66:44613
I20260812 08:03:54.844048  5231 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.66:44613 every 8 connection(s)
I20260812 08:03:54.845139  5085 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
I20260812 08:03:54.853080  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5085
I20260812 08:03:54.853260  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance
I20260812 08:03:54.856910  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.67:0
--local_ip_for_outbound_sockets=127.4.183.67
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--builtin_ntp_servers=127.4.183.84:35161
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:54.857192  5232 heartbeater.cc:344] Connected to a master server at 127.4.183.126:35919
I20260812 08:03:54.857441  5232 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:54.858090  5232 heartbeater.cc:507] Master 127.4.183.126:35919 requested a full tablet report, sending...
I20260812 08:03:54.859405  4871 ts_manager.cc:194] Registered new tserver with Master: 6d73a1531c67413caee6856eed7754c9 (127.4.183.66:44613)
I20260812 08:03:54.860030  4871 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.66:35077
W20260812 08:03:54.984683  5237 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:54.984944  5237 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:54.984989  5237 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:54.988770  5237 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:54.988909  5237 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.67
I20260812 08:03:54.993242  5237 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:35161
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.67:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:35919
--never_fsync=true
--heap_profile_path=/tmp/kudu.5237
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.67

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:54.994537  5237 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:54.995846  5237 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:55.003629  5245 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
W20260812 08:03:55.003676  5243 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
W20260812 08:03:55.003657  5249 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
I20260812 08:03:55.004302  5237 server_base.cc:1061] running on GCE node
I20260812 08:03:55.004822  5237 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:55.005496  5237 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:55.006775  5237 hybrid_clock.cc:648] HybridClock initialized: now 1786521835006694 us; error 139 us; skew 500 ppm
I20260812 08:03:55.009174  5237 webserver.cc:533] Webserver started at http://127.4.183.67:39757/ using document root <none> and password file <none>
I20260812 08:03:55.009899  5237 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:55.009999  5237 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:55.010248  5237 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:55.012254  5237 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data/instance:
uuid: "629359e5e6fa458b8d85e0137a0c11ce"
format_stamp: "Formatted at 2026-08-12 08:03:55 on dist-test-slave-8tdl"
I20260812 08:03:55.012851  5237 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance:
uuid: "629359e5e6fa458b8d85e0137a0c11ce"
format_stamp: "Formatted at 2026-08-12 08:03:55 on dist-test-slave-8tdl"
I20260812 08:03:55.017725  5237 fs_manager.cc:696] Time spent creating directory manager: real 0.005s	user 0.004s	sys 0.002s
I20260812 08:03:55.020550  5261 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:55.022070  5237 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.000s
I20260812 08:03:55.022266  5237 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal
uuid: "629359e5e6fa458b8d85e0137a0c11ce"
format_stamp: "Formatted at 2026-08-12 08:03:55 on dist-test-slave-8tdl"
I20260812 08:03:55.022434  5237 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:55.037909  5237 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:55.038853  5237 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:55.039237  5237 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:55.040030  5237 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:55.041222  5237 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:55.041302  5237 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:55.041379  5237 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:55.041424  5237 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:55.052501  5237 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.67:42405
I20260812 08:03:55.052528  5385 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.67:42405 every 8 connection(s)
I20260812 08:03:55.053691  5237 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
I20260812 08:03:55.055075  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5237
I20260812 08:03:55.055171  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharTruncation.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance
I20260812 08:03:55.064625  5386 heartbeater.cc:344] Connected to a master server at 127.4.183.126:35919
I20260812 08:03:55.064968  5386 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:55.065693  5386 heartbeater.cc:507] Master 127.4.183.126:35919 requested a full tablet report, sending...
I20260812 08:03:55.067165  4871 ts_manager.cc:194] Registered new tserver with Master: 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.067780  4871 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.67:36927
I20260812 08:03:55.070988  4829 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
I20260812 08:03:55.086822  4871 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:48930:
name: "varchar-table"
schema {
  columns {
    name: "key"
    type: INT64
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "value"
    type: VARCHAR
    is_key: false
    is_nullable: true
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    type_attributes {
      length: 10
    }
    immutable: false
  }
}
num_replicas: 3
split_rows_range_bounds {
}
partition_schema {
  hash_schema {
    columns {
      name: "key"
    }
    num_buckets: 3
    seed: 0
  }
}
W20260812 08:03:55.089723  4871 catalog_manager.cc:7099] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table varchar-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
I20260812 08:03:55.112433  5009 tablet_service.cc:1511] Processing CreateTablet for tablet 01a7e52959684100a394e6a73b974947 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 1, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.112619  5312 tablet_service.cc:1511] Processing CreateTablet for tablet 01a7e52959684100a394e6a73b974947 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 1, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.113085  5313 tablet_service.cc:1511] Processing CreateTablet for tablet e6079da578cc4814826f4657bc59a706 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 0, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.112437  5311 tablet_service.cc:1511] Processing CreateTablet for tablet e81245000cff4f3991c7935956762caf (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 2, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.113703  5312 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 01a7e52959684100a394e6a73b974947. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.113780  5009 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 01a7e52959684100a394e6a73b974947. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.114784  5313 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e6079da578cc4814826f4657bc59a706. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.116628  5156 tablet_service.cc:1511] Processing CreateTablet for tablet e81245000cff4f3991c7935956762caf (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 2, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.116496  5158 tablet_service.cc:1511] Processing CreateTablet for tablet e6079da578cc4814826f4657bc59a706 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 0, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.116505  5157 tablet_service.cc:1511] Processing CreateTablet for tablet 01a7e52959684100a394e6a73b974947 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 1, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.117695  5158 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e6079da578cc4814826f4657bc59a706. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.118878  5156 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e81245000cff4f3991c7935956762caf. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.112434  5010 tablet_service.cc:1511] Processing CreateTablet for tablet e6079da578cc4814826f4657bc59a706 (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 0, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.112439  5008 tablet_service.cc:1511] Processing CreateTablet for tablet e81245000cff4f3991c7935956762caf (DEFAULT_TABLE table=varchar-table [id=28822b25abdf47818ff9a340e8202b8a]), partition=HASH (key) PARTITION 2, RANGE (key) PARTITION UNBOUNDED
I20260812 08:03:55.120517  5010 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e6079da578cc4814826f4657bc59a706. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.120690  5008 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e81245000cff4f3991c7935956762caf. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.123677  5405 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Bootstrap starting.
I20260812 08:03:55.123673  5404 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Bootstrap starting.
I20260812 08:03:55.123956  5157 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 01a7e52959684100a394e6a73b974947. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.125231  5311 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet e81245000cff4f3991c7935956762caf. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:55.126494  5405 tablet_bootstrap.cc:654] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.127815  5405 log.cc:826] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:55.128966  5406 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Bootstrap starting.
I20260812 08:03:55.129246  5404 tablet_bootstrap.cc:654] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.130937  5404 log.cc:826] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:55.131965  5406 tablet_bootstrap.cc:654] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.132369  5405 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: No bootstrap required, opened a new log
I20260812 08:03:55.132633  5405 ts_tablet_manager.cc:1403] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent bootstrapping tablet: real 0.009s	user 0.005s	sys 0.000s
I20260812 08:03:55.132967  5406 log.cc:826] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:55.133183  5404 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: No bootstrap required, opened a new log
I20260812 08:03:55.133446  5404 ts_tablet_manager.cc:1403] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Time spent bootstrapping tablet: real 0.010s	user 0.007s	sys 0.000s
I20260812 08:03:55.136292  5406 tablet_bootstrap.cc:492] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: No bootstrap required, opened a new log
I20260812 08:03:55.136775  5406 ts_tablet_manager.cc:1403] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Time spent bootstrapping tablet: real 0.008s	user 0.007s	sys 0.000s
I20260812 08:03:55.137097  5405 raft_consensus.cc:359] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.137444  5405 raft_consensus.cc:385] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.137573  5405 raft_consensus.cc:740] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 88f55e3e9f0e4648b8db4bd385cc5dfe, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.138293  5405 consensus_queue.cc:260] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.139488  5405 ts_tablet_manager.cc:1434] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent starting tablet: real 0.007s	user 0.007s	sys 0.000s
I20260812 08:03:55.140004  5082 heartbeater.cc:499] Master 127.4.183.126:35919 was elected leader, sending a full tablet report...
I20260812 08:03:55.140031  5405 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe: Bootstrap starting.
I20260812 08:03:55.141456  5405 tablet_bootstrap.cc:654] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.141824  5406 raft_consensus.cc:359] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.142155  5406 raft_consensus.cc:385] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.142241  5406 raft_consensus.cc:740] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6d73a1531c67413caee6856eed7754c9, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.142753  5406 consensus_queue.cc:260] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.143860  5405 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe: No bootstrap required, opened a new log
I20260812 08:03:55.143918  5406 ts_tablet_manager.cc:1434] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Time spent starting tablet: real 0.007s	user 0.006s	sys 0.000s
I20260812 08:03:55.143975  5405 ts_tablet_manager.cc:1403] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent bootstrapping tablet: real 0.004s	user 0.000s	sys 0.003s
I20260812 08:03:55.144357  5406 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9: Bootstrap starting.
I20260812 08:03:55.144362  5232 heartbeater.cc:499] Master 127.4.183.126:35919 was elected leader, sending a full tablet report...
I20260812 08:03:55.144677  5405 raft_consensus.cc:359] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.144791  5405 raft_consensus.cc:385] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.144822  5405 raft_consensus.cc:740] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 88f55e3e9f0e4648b8db4bd385cc5dfe, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.144982  5405 consensus_queue.cc:260] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.145253  5405 ts_tablet_manager.cc:1434] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent starting tablet: real 0.001s	user 0.000s	sys 0.001s
I20260812 08:03:55.145653  5406 tablet_bootstrap.cc:654] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.145972  5405 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Bootstrap starting.
I20260812 08:03:55.147751  5405 tablet_bootstrap.cc:654] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.148690  5406 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9: No bootstrap required, opened a new log
I20260812 08:03:55.148797  5406 ts_tablet_manager.cc:1403] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9: Time spent bootstrapping tablet: real 0.004s	user 0.003s	sys 0.000s
I20260812 08:03:55.148643  5404 raft_consensus.cc:359] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.148947  5404 raft_consensus.cc:385] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.149013  5404 raft_consensus.cc:740] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 629359e5e6fa458b8d85e0137a0c11ce, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.149507  5406 raft_consensus.cc:359] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.149622  5406 raft_consensus.cc:385] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.149547  5404 consensus_queue.cc:260] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.149662  5406 raft_consensus.cc:740] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6d73a1531c67413caee6856eed7754c9, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.149789  5406 consensus_queue.cc:260] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.150146  5406 ts_tablet_manager.cc:1434] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9: Time spent starting tablet: real 0.001s	user 0.000s	sys 0.000s
I20260812 08:03:55.150354  5406 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9: Bootstrap starting.
I20260812 08:03:55.150736  5404 ts_tablet_manager.cc:1434] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Time spent starting tablet: real 0.017s	user 0.007s	sys 0.000s
I20260812 08:03:55.151187  5404 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce: Bootstrap starting.
I20260812 08:03:55.151530  5406 tablet_bootstrap.cc:654] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.151845  5405 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe: No bootstrap required, opened a new log
I20260812 08:03:55.151944  5405 ts_tablet_manager.cc:1403] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent bootstrapping tablet: real 0.006s	user 0.000s	sys 0.002s
I20260812 08:03:55.152421  5386 heartbeater.cc:499] Master 127.4.183.126:35919 was elected leader, sending a full tablet report...
I20260812 08:03:55.152464  5404 tablet_bootstrap.cc:654] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.152573  5405 raft_consensus.cc:359] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.152699  5405 raft_consensus.cc:385] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.152740  5405 raft_consensus.cc:740] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 88f55e3e9f0e4648b8db4bd385cc5dfe, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.152879  5405 consensus_queue.cc:260] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.153201  5405 ts_tablet_manager.cc:1434] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Time spent starting tablet: real 0.001s	user 0.001s	sys 0.001s
I20260812 08:03:55.154269  5404 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce: No bootstrap required, opened a new log
I20260812 08:03:55.154455  5404 ts_tablet_manager.cc:1403] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce: Time spent bootstrapping tablet: real 0.003s	user 0.003s	sys 0.000s
I20260812 08:03:55.154505  5406 tablet_bootstrap.cc:492] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9: No bootstrap required, opened a new log
I20260812 08:03:55.154641  5406 ts_tablet_manager.cc:1403] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9: Time spent bootstrapping tablet: real 0.004s	user 0.002s	sys 0.000s
I20260812 08:03:55.155340  5406 raft_consensus.cc:359] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.155474  5406 raft_consensus.cc:385] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.155529  5406 raft_consensus.cc:740] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 6d73a1531c67413caee6856eed7754c9, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.155369  5404 raft_consensus.cc:359] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.155678  5406 consensus_queue.cc:260] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.155697  5404 raft_consensus.cc:385] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.155865  5404 raft_consensus.cc:740] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 629359e5e6fa458b8d85e0137a0c11ce, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.155964  5406 ts_tablet_manager.cc:1434] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9: Time spent starting tablet: real 0.001s	user 0.000s	sys 0.000s
I20260812 08:03:55.156180  5404 consensus_queue.cc:260] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.156548  5404 ts_tablet_manager.cc:1434] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce: Time spent starting tablet: real 0.002s	user 0.001s	sys 0.000s
I20260812 08:03:55.156747  5404 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce: Bootstrap starting.
W20260812 08:03:55.157722  5083 tablet.cc:2406] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe: Can't schedule compaction. Clean time has not been advanced past its initial value.
I20260812 08:03:55.158151  5404 tablet_bootstrap.cc:654] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:55.159621  5404 tablet_bootstrap.cc:492] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce: No bootstrap required, opened a new log
I20260812 08:03:55.159844  5404 ts_tablet_manager.cc:1403] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
I20260812 08:03:55.160451  5404 raft_consensus.cc:359] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.160561  5404 raft_consensus.cc:385] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:55.160626  5404 raft_consensus.cc:740] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 629359e5e6fa458b8d85e0137a0c11ce, State: Initialized, Role: FOLLOWER
I20260812 08:03:55.160769  5404 consensus_queue.cc:260] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.161108  5404 ts_tablet_manager.cc:1434] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce: Time spent starting tablet: real 0.001s	user 0.000s	sys 0.000s
I20260812 08:03:55.166527  5411 raft_consensus.cc:493] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
I20260812 08:03:55.166795  5411 raft_consensus.cc:515] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.168015  5411 leader_election.cc:290] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 6d73a1531c67413caee6856eed7754c9 (127.4.183.66:44613), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.172888  5181 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "01a7e52959684100a394e6a73b974947" candidate_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6d73a1531c67413caee6856eed7754c9" is_pre_election: true
I20260812 08:03:55.173285  5181 raft_consensus.cc:2468] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 88f55e3e9f0e4648b8db4bd385cc5dfe in term 0.
I20260812 08:03:55.173735  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "01a7e52959684100a394e6a73b974947" candidate_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce" is_pre_election: true
I20260812 08:03:55.174034  5336 raft_consensus.cc:2468] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 88f55e3e9f0e4648b8db4bd385cc5dfe in term 0.
I20260812 08:03:55.173976  4959 leader_election.cc:304] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: 6d73a1531c67413caee6856eed7754c9, 88f55e3e9f0e4648b8db4bd385cc5dfe; no voters: 
I20260812 08:03:55.174806  5411 raft_consensus.cc:2804] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Leader pre-election won for term 1
I20260812 08:03:55.175014  5411 raft_consensus.cc:493] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
I20260812 08:03:55.175073  5411 raft_consensus.cc:3060] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.175972  5411 raft_consensus.cc:515] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.176344  5411 leader_election.cc:290] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [CANDIDATE]: Term 1 election: Requested vote from peers 6d73a1531c67413caee6856eed7754c9 (127.4.183.66:44613), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.176813  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "01a7e52959684100a394e6a73b974947" candidate_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce"
I20260812 08:03:55.176966  5336 raft_consensus.cc:3060] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.176939  5181 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "01a7e52959684100a394e6a73b974947" candidate_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "6d73a1531c67413caee6856eed7754c9"
I20260812 08:03:55.177093  5181 raft_consensus.cc:3060] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.178452  5336 raft_consensus.cc:2468] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 88f55e3e9f0e4648b8db4bd385cc5dfe in term 1.
I20260812 08:03:55.178977  4958 leader_election.cc:304] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: 629359e5e6fa458b8d85e0137a0c11ce, 88f55e3e9f0e4648b8db4bd385cc5dfe; no voters: 
I20260812 08:03:55.178929  5181 raft_consensus.cc:2468] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 88f55e3e9f0e4648b8db4bd385cc5dfe in term 1.
I20260812 08:03:55.179229  5411 raft_consensus.cc:2804] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:55.179500  5411 raft_consensus.cc:697] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 LEADER]: Becoming Leader. State: Replica: 88f55e3e9f0e4648b8db4bd385cc5dfe, State: Running, Role: LEADER
I20260812 08:03:55.179862  5411 consensus_queue.cc:237] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.183746  4871 catalog_manager.cc:5719] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe reported cstate change: term changed from 0 to 1, leader changed from <none> to 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65). New cstate: current_term: 1 leader_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } health_report { overall_health: UNKNOWN } } }
I20260812 08:03:55.266036  5413 raft_consensus.cc:493] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
I20260812 08:03:55.266196  5413 raft_consensus.cc:515] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.267593  5413 leader_election.cc:290] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65:42225), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.272207  5028 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e81245000cff4f3991c7935956762caf" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" is_pre_election: true
I20260812 08:03:55.272220  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e81245000cff4f3991c7935956762caf" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce" is_pre_election: true
I20260812 08:03:55.272416  5336 raft_consensus.cc:2468] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 0.
I20260812 08:03:55.272531  5028 raft_consensus.cc:2468] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 0.
I20260812 08:03:55.272918  5103 leader_election.cc:304] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [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: 629359e5e6fa458b8d85e0137a0c11ce, 6d73a1531c67413caee6856eed7754c9; no voters: 
I20260812 08:03:55.273216  5413 raft_consensus.cc:2804] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Leader pre-election won for term 1
I20260812 08:03:55.273301  5413 raft_consensus.cc:493] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
I20260812 08:03:55.273353  5413 raft_consensus.cc:3060] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.274746  5413 raft_consensus.cc:515] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.275215  5413 leader_election.cc:290] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [CANDIDATE]: Term 1 election: Requested vote from peers 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65:42225), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.275650  5028 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e81245000cff4f3991c7935956762caf" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe"
I20260812 08:03:55.275802  5028 raft_consensus.cc:3060] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.275828  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e81245000cff4f3991c7935956762caf" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce"
I20260812 08:03:55.275949  5336 raft_consensus.cc:3060] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.276993  5028 raft_consensus.cc:2468] T e81245000cff4f3991c7935956762caf P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 1.
I20260812 08:03:55.276993  5336 raft_consensus.cc:2468] T e81245000cff4f3991c7935956762caf P 629359e5e6fa458b8d85e0137a0c11ce [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 1.
I20260812 08:03:55.277392  5103 leader_election.cc:304] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [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: 6d73a1531c67413caee6856eed7754c9, 88f55e3e9f0e4648b8db4bd385cc5dfe; no voters: 
I20260812 08:03:55.277583  5413 raft_consensus.cc:2804] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:55.277827  5413 raft_consensus.cc:697] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [term 1 LEADER]: Becoming Leader. State: Replica: 6d73a1531c67413caee6856eed7754c9, State: Running, Role: LEADER
I20260812 08:03:55.278213  5413 consensus_queue.cc:237] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } }
I20260812 08:03:55.281651  4871 catalog_manager.cc:5719] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 reported cstate change: term changed from 0 to 1, leader changed from <none> to 6d73a1531c67413caee6856eed7754c9 (127.4.183.66). New cstate: current_term: 1 leader_uuid: "6d73a1531c67413caee6856eed7754c9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } health_report { overall_health: UNKNOWN } } }
W20260812 08:03:55.304764  5387 tablet.cc:2406] T 01a7e52959684100a394e6a73b974947 P 629359e5e6fa458b8d85e0137a0c11ce: Can't schedule compaction. Clean time has not been advanced past its initial value.
W20260812 08:03:55.346546  5234 tablet.cc:2406] T 01a7e52959684100a394e6a73b974947 P 6d73a1531c67413caee6856eed7754c9: Can't schedule compaction. Clean time has not been advanced past its initial value.
I20260812 08:03:55.413834  5413 raft_consensus.cc:493] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
I20260812 08:03:55.414037  5413 raft_consensus.cc:515] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.414740  5413 leader_election.cc:290] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65:42225), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.415520  5028 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e6079da578cc4814826f4657bc59a706" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" is_pre_election: true
I20260812 08:03:55.415589  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e6079da578cc4814826f4657bc59a706" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce" is_pre_election: true
I20260812 08:03:55.415719  5028 raft_consensus.cc:2468] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 0.
I20260812 08:03:55.415732  5336 raft_consensus.cc:2468] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 0.
I20260812 08:03:55.416126  5103 leader_election.cc:304] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [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: 6d73a1531c67413caee6856eed7754c9, 88f55e3e9f0e4648b8db4bd385cc5dfe; no voters: 
I20260812 08:03:55.416373  5413 raft_consensus.cc:2804] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Leader pre-election won for term 1
I20260812 08:03:55.416452  5413 raft_consensus.cc:493] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
I20260812 08:03:55.416501  5413 raft_consensus.cc:3060] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.417454  5413 raft_consensus.cc:515] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.417935  5413 leader_election.cc:290] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [CANDIDATE]: Term 1 election: Requested vote from peers 88f55e3e9f0e4648b8db4bd385cc5dfe (127.4.183.65:42225), 629359e5e6fa458b8d85e0137a0c11ce (127.4.183.67:42405)
I20260812 08:03:55.418584  5028 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e6079da578cc4814826f4657bc59a706" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe"
I20260812 08:03:55.418803  5028 raft_consensus.cc:3060] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.419121  5336 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "e6079da578cc4814826f4657bc59a706" candidate_uuid: "6d73a1531c67413caee6856eed7754c9" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "629359e5e6fa458b8d85e0137a0c11ce"
I20260812 08:03:55.419294  5336 raft_consensus.cc:3060] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:55.419812  5028 raft_consensus.cc:2468] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 1.
I20260812 08:03:55.420296  5336 raft_consensus.cc:2468] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 6d73a1531c67413caee6856eed7754c9 in term 1.
I20260812 08:03:55.420296  5103 leader_election.cc:304] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [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: 6d73a1531c67413caee6856eed7754c9, 88f55e3e9f0e4648b8db4bd385cc5dfe; no voters: 
I20260812 08:03:55.420547  5413 raft_consensus.cc:2804] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:55.420691  5413 raft_consensus.cc:697] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [term 1 LEADER]: Becoming Leader. State: Replica: 6d73a1531c67413caee6856eed7754c9, State: Running, Role: LEADER
I20260812 08:03:55.420918  5413 consensus_queue.cc:237] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [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: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } }
I20260812 08:03:55.423288  4871 catalog_manager.cc:5719] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 reported cstate change: term changed from 0 to 1, leader changed from <none> to 6d73a1531c67413caee6856eed7754c9 (127.4.183.66). New cstate: current_term: 1 leader_uuid: "6d73a1531c67413caee6856eed7754c9" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 } health_report { overall_health: HEALTHY } } }
I20260812 08:03:55.498301  5028 raft_consensus.cc:1275] T e6079da578cc4814826f4657bc59a706 P 88f55e3e9f0e4648b8db4bd385cc5dfe [term 1 FOLLOWER]: Refusing update from remote peer 6d73a1531c67413caee6856eed7754c9: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
I20260812 08:03:55.498432  5336 raft_consensus.cc:1275] T e6079da578cc4814826f4657bc59a706 P 629359e5e6fa458b8d85e0137a0c11ce [term 1 FOLLOWER]: Refusing update from remote peer 6d73a1531c67413caee6856eed7754c9: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
I20260812 08:03:55.499187  5413 consensus_queue.cc:1048] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:55.499475  5427 consensus_queue.cc:1048] T e6079da578cc4814826f4657bc59a706 P 6d73a1531c67413caee6856eed7754c9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:55.506769  5432 mvcc.cc:204] Tried to move back new op lower bound from 7317593438190977024 to 7317593437885988864. Current Snapshot: MvccSnapshot[applied={T|T < 7317593438190977024}]
I20260812 08:03:55.507750  5433 mvcc.cc:204] Tried to move back new op lower bound from 7317593438190977024 to 7317593437885988864. Current Snapshot: MvccSnapshot[applied={T|T < 7317593438190977024}]
I20260812 08:03:55.787071  5411 consensus_queue.cc:1048] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [LEADER]: Connected to new peer: Peer: permanent_uuid: "6d73a1531c67413caee6856eed7754c9" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44613 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:55.790799  5411 consensus_queue.cc:1048] T 01a7e52959684100a394e6a73b974947 P 88f55e3e9f0e4648b8db4bd385cc5dfe [LEADER]: Connected to new peer: Peer: permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:55.869423  5413 consensus_queue.cc:1048] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "88f55e3e9f0e4648b8db4bd385cc5dfe" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 42225 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:55.875290  5413 consensus_queue.cc:1048] T e81245000cff4f3991c7935956762caf P 6d73a1531c67413caee6856eed7754c9 [LEADER]: Connected to new peer: Peer: permanent_uuid: "629359e5e6fa458b8d85e0137a0c11ce" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 42405 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
W20260812 08:03:56.057557  4829 scanner-internal.cc:458] Time spent opening tablet: real 0.543s	user 0.002s	sys 0.000s
I20260812 08:03:56.066457  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 4939
I20260812 08:03:56.082077  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5085
I20260812 08:03:56.098280  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5237
I20260812 08:03:56.111172  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 4838
2026-08-12T08:03:56Z chronyd exiting
[       OK ] VarcharItest.TestVarcharTruncation (1949 ms)
[ RUN      ] VarcharItest.TestInvalidLength
2026-08-12T08:03:56Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
2026-08-12T08:03:56Z Disabled control of system clock
I20260812 08:03:56.151062  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
master
run
--ipki_ca_key_size=768
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:42997
--webserver_interface=127.4.183.126
--webserver_port=0
--builtin_ntp_servers=127.4.183.84:41549
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--rpc_reuseport=true
--master_addresses=127.4.183.126:42997 with env {}
W20260812 08:03:56.283915  5454 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:56.284174  5454 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:56.284215  5454 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:56.287827  5454 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
W20260812 08:03:56.287910  5454 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:56.287933  5454 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
W20260812 08:03:56.287951  5454 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
I20260812 08:03:56.292338  5454 master_runner.cc:387] Master server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:41549
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal
--ipki_ca_key_size=768
--master_addresses=127.4.183.126:42997
--ipki_server_key_size=768
--openssl_security_level_override=0
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:42997
--rpc_reuseport=true
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--webserver_interface=127.4.183.126
--webserver_port=0
--never_fsync=true
--heap_profile_path=/tmp/kudu.5454
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false

Master server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:56.293519  5454 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:56.294786  5454 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:56.300542  5464 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
W20260812 08:03:56.300714  5460 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
W20260812 08:03:56.300770  5461 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
I20260812 08:03:56.301021  5454 server_base.cc:1061] running on GCE node
I20260812 08:03:56.301556  5454 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:56.302541  5454 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:56.303738  5454 hybrid_clock.cc:648] HybridClock initialized: now 1786521836303719 us; error 34 us; skew 500 ppm
I20260812 08:03:56.305751  5454 webserver.cc:533] Webserver started at http://127.4.183.126:44173/ using document root <none> and password file <none>
I20260812 08:03:56.306363  5454 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:56.306452  5454 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:56.306725  5454 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:56.308431  5454 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data/instance:
uuid: "441ac5b04c3d42ada9cc1e237d5a551e"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.308970  5454 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal/instance:
uuid: "441ac5b04c3d42ada9cc1e237d5a551e"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.312631  5454 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
I20260812 08:03:56.315042  5470 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.316200  5454 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.001s
I20260812 08:03:56.316439  5454 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal
uuid: "441ac5b04c3d42ada9cc1e237d5a551e"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.316661  5454 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:56.334623  5454 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:56.335497  5454 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:56.335719  5454 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:56.344098  5454 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.126:42997
I20260812 08:03:56.344123  5526 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.126:42997 every 8 connection(s)
I20260812 08:03:56.345239  5454 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
I20260812 08:03:56.348086  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5454
I20260812 08:03:56.348232  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/master-0/wal/instance
I20260812 08:03:56.348841  5527 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:56.356313  5527 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e: Bootstrap starting.
I20260812 08:03:56.358976  5527 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:56.359776  5527 log.cc:826] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:56.361759  5527 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e: No bootstrap required, opened a new log
I20260812 08:03:56.364603  5527 raft_consensus.cc:359] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } }
I20260812 08:03:56.364838  5527 raft_consensus.cc:385] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:56.364933  5527 raft_consensus.cc:740] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 441ac5b04c3d42ada9cc1e237d5a551e, State: Initialized, Role: FOLLOWER
I20260812 08:03:56.365396  5527 consensus_queue.cc:260] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } }
I20260812 08:03:56.365563  5527 raft_consensus.cc:399] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:03:56.365657  5527 raft_consensus.cc:493] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:03:56.365806  5527 raft_consensus.cc:3060] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:56.366832  5527 raft_consensus.cc:515] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } }
I20260812 08:03:56.367285  5527 leader_election.cc:304] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: 441ac5b04c3d42ada9cc1e237d5a551e; no voters: 
I20260812 08:03:56.367654  5527 leader_election.cc:290] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:03:56.367816  5532 raft_consensus.cc:2804] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:56.368253  5532 raft_consensus.cc:697] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [term 1 LEADER]: Becoming Leader. State: Replica: 441ac5b04c3d42ada9cc1e237d5a551e, State: Running, Role: LEADER
I20260812 08:03:56.368578  5532 consensus_queue.cc:237] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } }
I20260812 08:03:56.369059  5527 sys_catalog.cc:565] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [sys.catalog]: configured and running, proceeding with master startup.
I20260812 08:03:56.370447  5534 sys_catalog.cc:455] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } } }
I20260812 08:03:56.370620  5534 sys_catalog.cc:458] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:56.370915  5535 sys_catalog.cc:455] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [sys.catalog]: SysCatalogTable state changed. Reason: New leader 441ac5b04c3d42ada9cc1e237d5a551e. Latest consensus state: current_term: 1 leader_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "441ac5b04c3d42ada9cc1e237d5a551e" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 42997 } } }
I20260812 08:03:56.371012  5535 sys_catalog.cc:458] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:56.371706  5544 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 08:03:56.374588  5544 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 08:03:56.380919  5544 catalog_manager.cc:1383] Generated new cluster ID: c9b52efa1ed84645bd86bc205bbafe5c
I20260812 08:03:56.381034  5544 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 08:03:56.399626  5544 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 08:03:56.400657  5544 catalog_manager.cc:1540] Loading token signing keys...
I20260812 08:03:56.409235  5544 catalog_manager.cc:6092] T 00000000000000000000000000000000 P 441ac5b04c3d42ada9cc1e237d5a551e: Generated new TSK 0
I20260812 08:03:56.410032  5544 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 08:03:56.424129  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.65:0
--local_ip_for_outbound_sockets=127.4.183.65
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--builtin_ntp_servers=127.4.183.84:41549
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
W20260812 08:03:56.545811  5556 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:56.546119  5556 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:56.546218  5556 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:56.550361  5556 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:56.550609  5556 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.65
I20260812 08:03:56.555482  5556 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:41549
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.65:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--never_fsync=true
--heap_profile_path=/tmp/kudu.5556
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.65

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:56.556798  5556 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:56.558166  5556 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:56.566033  5565 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
W20260812 08:03:56.566030  5561 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
I20260812 08:03:56.566121  5556 server_base.cc:1061] running on GCE node
W20260812 08:03:56.566033  5563 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
I20260812 08:03:56.566898  5556 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:56.567534  5556 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:56.568704  5556 hybrid_clock.cc:648] HybridClock initialized: now 1786521836568684 us; error 34 us; skew 500 ppm
I20260812 08:03:56.570986  5556 webserver.cc:533] Webserver started at http://127.4.183.65:33757/ using document root <none> and password file <none>
I20260812 08:03:56.571698  5556 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:56.571765  5556 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:56.572009  5556 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:56.573840  5556 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data/instance:
uuid: "34a4ded3e247442badec155c127be8d5"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.574442  5556 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance:
uuid: "34a4ded3e247442badec155c127be8d5"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.578500  5556 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.000s	sys 0.003s
I20260812 08:03:56.581158  5572 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.582382  5556 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
I20260812 08:03:56.582579  5556 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal
uuid: "34a4ded3e247442badec155c127be8d5"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.582734  5556 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:56.599428  5556 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:56.600278  5556 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:56.600513  5556 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:56.601205  5556 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:56.602468  5556 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:56.602550  5556 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.602630  5556 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:56.602676  5556 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.614295  5556 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.65:38479
I20260812 08:03:56.614323  5700 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.65:38479 every 8 connection(s)
I20260812 08:03:56.615521  5556 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
I20260812 08:03:56.622113  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5556
I20260812 08:03:56.622213  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance
I20260812 08:03:56.624567  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.66:0
--local_ip_for_outbound_sockets=127.4.183.66
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--builtin_ntp_servers=127.4.183.84:41549
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:56.626210  5701 heartbeater.cc:344] Connected to a master server at 127.4.183.126:42997
I20260812 08:03:56.626539  5701 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:56.627351  5701 heartbeater.cc:507] Master 127.4.183.126:42997 requested a full tablet report, sending...
I20260812 08:03:56.629280  5488 ts_manager.cc:194] Registered new tserver with Master: 34a4ded3e247442badec155c127be8d5 (127.4.183.65:38479)
I20260812 08:03:56.631163  5488 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.65:47277
W20260812 08:03:56.743958  5704 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:56.744230  5704 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:56.744279  5704 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:56.748258  5704 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:56.748415  5704 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.66
I20260812 08:03:56.752933  5704 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:41549
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.66:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--never_fsync=true
--heap_profile_path=/tmp/kudu.5704
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.66

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:56.754184  5704 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:56.755610  5704 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:56.763800  5711 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
W20260812 08:03:56.763819  5713 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
I20260812 08:03:56.764142  5704 server_base.cc:1061] running on GCE node
W20260812 08:03:56.763819  5710 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
I20260812 08:03:56.765149  5704 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:56.765873  5704 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:56.767092  5704 hybrid_clock.cc:648] HybridClock initialized: now 1786521836767069 us; error 38 us; skew 500 ppm
I20260812 08:03:56.769420  5704 webserver.cc:533] Webserver started at http://127.4.183.66:45599/ using document root <none> and password file <none>
I20260812 08:03:56.770174  5704 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:56.770267  5704 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:56.770527  5704 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:56.772409  5704 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data/instance:
uuid: "9f673411e8914797a9ae9747d983a971"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.772928  5704 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance:
uuid: "9f673411e8914797a9ae9747d983a971"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.776862  5704 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.005s	sys 0.000s
I20260812 08:03:56.779417  5719 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.780596  5704 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.000s	sys 0.003s
I20260812 08:03:56.780781  5704 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal
uuid: "9f673411e8914797a9ae9747d983a971"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.780901  5704 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:56.797066  5704 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:56.797772  5704 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:56.797943  5704 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:56.798511  5704 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:56.799714  5704 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:56.799793  5704 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.799870  5704 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:56.799922  5704 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.809962  5704 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.66:45051
I20260812 08:03:56.810024  5846 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.66:45051 every 8 connection(s)
I20260812 08:03:56.811373  5704 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
I20260812 08:03:56.812606  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5704
I20260812 08:03:56.812747  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance
I20260812 08:03:56.816357  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.67:0
--local_ip_for_outbound_sockets=127.4.183.67
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--builtin_ntp_servers=127.4.183.84:41549
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:56.823654  5847 heartbeater.cc:344] Connected to a master server at 127.4.183.126:42997
I20260812 08:03:56.824005  5847 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:56.824648  5847 heartbeater.cc:507] Master 127.4.183.126:42997 requested a full tablet report, sending...
I20260812 08:03:56.826025  5488 ts_manager.cc:194] Registered new tserver with Master: 9f673411e8914797a9ae9747d983a971 (127.4.183.66:45051)
I20260812 08:03:56.826756  5488 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.66:36801
W20260812 08:03:56.937747  5850 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:56.938068  5850 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:56.938153  5850 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:56.941761  5850 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:56.941987  5850 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.67
I20260812 08:03:56.946362  5850 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:41549
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.67:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:42997
--never_fsync=true
--heap_profile_path=/tmp/kudu.5850
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.67

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:56.947700  5850 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:56.949004  5850 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:56.956830  5859 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
W20260812 08:03:56.956979  5856 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
W20260812 08:03:56.956823  5857 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
I20260812 08:03:56.957201  5850 server_base.cc:1061] running on GCE node
I20260812 08:03:56.957649  5850 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:56.958360  5850 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:56.959590  5850 hybrid_clock.cc:648] HybridClock initialized: now 1786521836959558 us; error 49 us; skew 500 ppm
I20260812 08:03:56.961730  5850 webserver.cc:533] Webserver started at http://127.4.183.67:45367/ using document root <none> and password file <none>
I20260812 08:03:56.962383  5850 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:56.962493  5850 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:56.962793  5850 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:56.964493  5850 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data/instance:
uuid: "953484de9c5940c692dbe53e683a373d"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.965058  5850 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance:
uuid: "953484de9c5940c692dbe53e683a373d"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.968834  5850 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.004s
I20260812 08:03:56.972012  5866 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.973255  5850 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.003s	sys 0.000s
I20260812 08:03:56.973423  5850 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal
uuid: "953484de9c5940c692dbe53e683a373d"
format_stamp: "Formatted at 2026-08-12 08:03:56 on dist-test-slave-8tdl"
I20260812 08:03:56.973536  5850 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:56.988085  5850 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:56.988883  5850 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:56.989110  5850 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:56.989785  5850 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:56.990957  5850 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:56.991011  5850 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:56.991055  5850 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:56.991070  5850 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.001390  5850 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.67:40899
I20260812 08:03:57.001479  6007 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.67:40899 every 8 connection(s)
I20260812 08:03:57.002619  5850 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
I20260812 08:03:57.004822  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 5850
I20260812 08:03:57.004968  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestInvalidLength.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance
I20260812 08:03:57.013523  6008 heartbeater.cc:344] Connected to a master server at 127.4.183.126:42997
I20260812 08:03:57.013784  6008 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:57.014380  6008 heartbeater.cc:507] Master 127.4.183.126:42997 requested a full tablet report, sending...
I20260812 08:03:57.015666  5488 ts_manager.cc:194] Registered new tserver with Master: 953484de9c5940c692dbe53e683a373d (127.4.183.67:40899)
I20260812 08:03:57.016286  5488 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.67:39315
I20260812 08:03:57.020658  4829 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
I20260812 08:03:57.030560  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5556
I20260812 08:03:57.040159  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5704
I20260812 08:03:57.053124  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5850
I20260812 08:03:57.064680  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 5454
2026-08-12T08:03:57Z chronyd exiting
[       OK ] VarcharItest.TestInvalidLength (951 ms)
[ RUN      ] VarcharItest.TestVarcharRangePartition
2026-08-12T08:03:57Z chronyd version 4.6.1 starting (+CMDMON +NTP +REFCLOCK +RTC -PRIVDROP -SCFILTER -SIGND +ASYNCDNS -NTS -SECHASH -IPV6 +DEBUG)
2026-08-12T08:03:57Z Disabled control of system clock
I20260812 08:03:57.101802  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
master
run
--ipki_ca_key_size=768
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:36603
--webserver_interface=127.4.183.126
--webserver_port=0
--builtin_ntp_servers=127.4.183.84:33701
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--rpc_reuseport=true
--master_addresses=127.4.183.126:36603 with env {}
W20260812 08:03:57.217957  6022 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:57.218235  6022 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:57.218277  6022 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:57.221987  6022 flags.cc:432] Enabled experimental flag: --ipki_ca_key_size=768
W20260812 08:03:57.222076  6022 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:57.222098  6022 flags.cc:432] Enabled experimental flag: --tsk_num_rsa_bits=512
W20260812 08:03:57.222116  6022 flags.cc:432] Enabled experimental flag: --rpc_reuseport=true
I20260812 08:03:57.226469  6022 master_runner.cc:387] Master server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:33701
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal
--ipki_ca_key_size=768
--master_addresses=127.4.183.126:36603
--ipki_server_key_size=768
--openssl_security_level_override=0
--tsk_num_rsa_bits=512
--rpc_bind_addresses=127.4.183.126:36603
--rpc_reuseport=true
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
--webserver_interface=127.4.183.126
--webserver_port=0
--never_fsync=true
--heap_profile_path=/tmp/kudu.6022
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false

Master server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:57.227887  6022 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:57.229151  6022 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:57.235752  6028 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
W20260812 08:03:57.235759  6027 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
W20260812 08:03:57.236075  6030 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
I20260812 08:03:57.236439  6022 server_base.cc:1061] running on GCE node
I20260812 08:03:57.237114  6022 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:57.238230  6022 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:57.239429  6022 hybrid_clock.cc:648] HybridClock initialized: now 1786521837239399 us; error 35 us; skew 500 ppm
I20260812 08:03:57.241616  6022 webserver.cc:533] Webserver started at http://127.4.183.126:37811/ using document root <none> and password file <none>
I20260812 08:03:57.242223  6022 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:57.242280  6022 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:57.242465  6022 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:57.244225  6022 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data/instance:
uuid: "a620380ebcce405aa3a4dadaff15c0fd"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.244735  6022 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal/instance:
uuid: "a620380ebcce405aa3a4dadaff15c0fd"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.248579  6022 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.000s	sys 0.005s
I20260812 08:03:57.251281  6037 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.252727  6022 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
I20260812 08:03:57.252880  6022 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal
uuid: "a620380ebcce405aa3a4dadaff15c0fd"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.253046  6022 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:57.280400  6022 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:57.281212  6022 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:57.281446  6022 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:57.289796  6098 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.126:36603 every 8 connection(s)
I20260812 08:03:57.289808  6022 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.126:36603
I20260812 08:03:57.291252  6022 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/data/info.pb
I20260812 08:03:57.294479  6099 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 00000000000000000000000000000000. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:57.299362  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 6022
I20260812 08:03:57.299480  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/master-0/wal/instance
I20260812 08:03:57.300530  6099 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd: Bootstrap starting.
I20260812 08:03:57.302991  6099 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:57.303911  6099 log.cc:826] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:57.306406  6099 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd: No bootstrap required, opened a new log
I20260812 08:03:57.309698  6099 raft_consensus.cc:359] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } }
I20260812 08:03:57.309981  6099 raft_consensus.cc:385] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:57.310045  6099 raft_consensus.cc:740] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: a620380ebcce405aa3a4dadaff15c0fd, State: Initialized, Role: FOLLOWER
I20260812 08:03:57.310528  6099 consensus_queue.cc:260] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [NON_LEADER]: Queue going to NON_LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 0, Majority size: -1, State: 0, Mode: NON_LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } }
I20260812 08:03:57.310722  6099 raft_consensus.cc:399] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:03:57.310783  6099 raft_consensus.cc:493] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:03:57.310899  6099 raft_consensus.cc:3060] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:57.311965  6099 raft_consensus.cc:515] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } }
I20260812 08:03:57.312294  6099 leader_election.cc:304] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [CANDIDATE]: Term 1 election: Election decided. Result: candidate won. Election summary: received 1 responses out of 1 voters: 1 yes votes; 0 no votes. yes voters: a620380ebcce405aa3a4dadaff15c0fd; no voters: 
I20260812 08:03:57.312608  6099 leader_election.cc:290] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:03:57.312700  6105 raft_consensus.cc:2804] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:57.312872  6105 raft_consensus.cc:697] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [term 1 LEADER]: Becoming Leader. State: Replica: a620380ebcce405aa3a4dadaff15c0fd, State: Running, Role: LEADER
I20260812 08:03:57.313190  6105 consensus_queue.cc:237] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [LEADER]: Queue going to LEADER mode. State: All replicated index: 0, Majority replicated index: 0, Committed index: 0, Last appended: 0.0, Last appended by leader: 0, Current term: 1, Majority size: 1, State: 0, Mode: LEADER, active raft config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } }
I20260812 08:03:57.313922  6099 sys_catalog.cc:565] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [sys.catalog]: configured and running, proceeding with master startup.
I20260812 08:03:57.315059  6106 sys_catalog.cc:455] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [sys.catalog]: SysCatalogTable state changed. Reason: New leader a620380ebcce405aa3a4dadaff15c0fd. Latest consensus state: current_term: 1 leader_uuid: "a620380ebcce405aa3a4dadaff15c0fd" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } } }
I20260812 08:03:57.315207  6106 sys_catalog.cc:458] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:57.315554  6107 sys_catalog.cc:455] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "a620380ebcce405aa3a4dadaff15c0fd" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "a620380ebcce405aa3a4dadaff15c0fd" member_type: VOTER last_known_addr { host: "127.4.183.126" port: 36603 } } }
I20260812 08:03:57.315657  6107 sys_catalog.cc:458] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd [sys.catalog]: This master's current role is: LEADER
I20260812 08:03:57.316318  6114 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 08:03:57.319270  6114 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 08:03:57.325335  6114 catalog_manager.cc:1383] Generated new cluster ID: 4d5a4d2a6f984fc1bd735b9c3d53d5f8
I20260812 08:03:57.325436  6114 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 08:03:57.345316  6114 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 08:03:57.346581  6114 catalog_manager.cc:1540] Loading token signing keys...
I20260812 08:03:57.369238  6114 catalog_manager.cc:6092] T 00000000000000000000000000000000 P a620380ebcce405aa3a4dadaff15c0fd: Generated new TSK 0
I20260812 08:03:57.370067  6114 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 08:03:57.384763  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.65:0
--local_ip_for_outbound_sockets=127.4.183.65
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--builtin_ntp_servers=127.4.183.84:33701
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
W20260812 08:03:57.500685  6127 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:57.500988  6127 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:57.501088  6127 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:57.504733  6127 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:57.504956  6127 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.65
I20260812 08:03:57.509300  6127 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:33701
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.65:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
--webserver_interface=127.4.183.65
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--never_fsync=true
--heap_profile_path=/tmp/kudu.6127
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.65

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:57.510639  6127 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:57.511920  6127 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:57.519152  6132 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
W20260812 08:03:57.519172  6137 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
W20260812 08:03:57.519140  6134 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
I20260812 08:03:57.519595  6127 server_base.cc:1061] running on GCE node
I20260812 08:03:57.520140  6127 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:57.520823  6127 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:57.522029  6127 hybrid_clock.cc:648] HybridClock initialized: now 1786521837522010 us; error 45 us; skew 500 ppm
I20260812 08:03:57.524996  6127 webserver.cc:533] Webserver started at http://127.4.183.65:33195/ using document root <none> and password file <none>
I20260812 08:03:57.525748  6127 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:57.525861  6127 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:57.526113  6127 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:57.528026  6127 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data/instance:
uuid: "3da758746b334b668b5d9e843bbeb5a5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.528585  6127 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance:
uuid: "3da758746b334b668b5d9e843bbeb5a5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.532671  6127 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.001s	sys 0.004s
I20260812 08:03:57.535284  6143 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.536433  6127 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.003s	sys 0.000s
I20260812 08:03:57.536588  6127 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal
uuid: "3da758746b334b668b5d9e843bbeb5a5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.536711  6127 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:57.577191  6127 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:57.577972  6127 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:57.578234  6127 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:57.578948  6127 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:57.580054  6127 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:57.580132  6127 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.580205  6127 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:57.580248  6127 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.591215  6127 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.65:40639
I20260812 08:03:57.591303  6275 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.65:40639 every 8 connection(s)
I20260812 08:03:57.592360  6127 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/data/info.pb
I20260812 08:03:57.593113  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 6127
I20260812 08:03:57.593235  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-0/wal/instance
I20260812 08:03:57.595939  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.66:0
--local_ip_for_outbound_sockets=127.4.183.66
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--builtin_ntp_servers=127.4.183.84:33701
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:57.604008  6276 heartbeater.cc:344] Connected to a master server at 127.4.183.126:36603
I20260812 08:03:57.604334  6276 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:57.604974  6276 heartbeater.cc:507] Master 127.4.183.126:36603 requested a full tablet report, sending...
I20260812 08:03:57.607101  6057 ts_manager.cc:194] Registered new tserver with Master: 3da758746b334b668b5d9e843bbeb5a5 (127.4.183.65:40639)
I20260812 08:03:57.608951  6057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.65:55451
W20260812 08:03:57.715092  6279 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:57.715356  6279 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:57.715405  6279 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:57.719208  6279 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:57.719336  6279 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.66
I20260812 08:03:57.726178  6279 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:33701
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.66:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
--webserver_interface=127.4.183.66
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--never_fsync=true
--heap_profile_path=/tmp/kudu.6279
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.66

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:57.727859  6279 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:57.729326  6279 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:57.737237  6285 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
W20260812 08:03:57.737367  6286 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
W20260812 08:03:57.737247  6289 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
I20260812 08:03:57.737643  6279 server_base.cc:1061] running on GCE node
I20260812 08:03:57.738206  6279 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:57.739007  6279 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:57.740232  6279 hybrid_clock.cc:648] HybridClock initialized: now 1786521837740219 us; error 40 us; skew 500 ppm
I20260812 08:03:57.742617  6279 webserver.cc:533] Webserver started at http://127.4.183.66:44619/ using document root <none> and password file <none>
I20260812 08:03:57.743317  6279 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:57.743445  6279 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:57.743693  6279 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:57.745409  6279 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data/instance:
uuid: "daf42f6fc59149e4ad62cfd026ce4eb5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.745942  6279 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance:
uuid: "daf42f6fc59149e4ad62cfd026ce4eb5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.749861  6279 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.006s	sys 0.000s
I20260812 08:03:57.753697  6298 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.755172  6279 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.001s	sys 0.002s
I20260812 08:03:57.755333  6279 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal
uuid: "daf42f6fc59149e4ad62cfd026ce4eb5"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.755457  6279 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:57.776893  6279 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:57.777736  6279 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:57.777961  6279 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:57.778617  6279 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:57.779771  6279 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:57.779850  6279 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.779922  6279 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:57.779979  6279 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.791357  6279 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.66:44729
I20260812 08:03:57.791416  6425 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.66:44729 every 8 connection(s)
I20260812 08:03:57.792505  6279 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/data/info.pb
I20260812 08:03:57.794924  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 6279
I20260812 08:03:57.795033  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-1/wal/instance
I20260812 08:03:57.797487  4829 external_mini_cluster.cc:1372] Running /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
/tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data
--block_manager=log
--webserver_interface=localhost
--never_fsync
--enable_minidumps=false
--redact=none
--metrics_log_interval_ms=1000
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/logs
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--server_dump_info_format=pb
--rpc_server_allow_ephemeral_ports
--unlock_experimental_flags
--unlock_unsafe_flags
--logtostderr
--logbuflevel=-1
--ipki_server_key_size=768
--openssl_security_level_override=0
tserver
run
--rpc_bind_addresses=127.4.183.67:0
--local_ip_for_outbound_sockets=127.4.183.67
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--builtin_ntp_servers=127.4.183.84:33701
--builtin_ntp_poll_interval_ms=100
--ntp_initial_sync_wait_secs=10
--time_source=builtin with env {}
I20260812 08:03:57.803030  6426 heartbeater.cc:344] Connected to a master server at 127.4.183.126:36603
I20260812 08:03:57.803357  6426 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:57.804060  6426 heartbeater.cc:507] Master 127.4.183.126:36603 requested a full tablet report, sending...
I20260812 08:03:57.805302  6057 ts_manager.cc:194] Registered new tserver with Master: daf42f6fc59149e4ad62cfd026ce4eb5 (127.4.183.66:44729)
I20260812 08:03:57.805929  6057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.66:54327
W20260812 08:03:57.915788  6429 flags.cc:432] Enabled unsafe flag: --openssl_security_level_override=0
W20260812 08:03:57.916064  6429 flags.cc:432] Enabled unsafe flag: --rpc_server_allow_ephemeral_ports=true
W20260812 08:03:57.916116  6429 flags.cc:432] Enabled unsafe flag: --never_fsync=true
W20260812 08:03:57.919898  6429 flags.cc:432] Enabled experimental flag: --ipki_server_key_size=768
W20260812 08:03:57.920039  6429 flags.cc:432] Enabled experimental flag: --local_ip_for_outbound_sockets=127.4.183.67
I20260812 08:03:57.924414  6429 tablet_server_runner.cc:78] Tablet server non-default flags:
--log_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/logs
--logbuflevel=-1
--logtostderr=true
--builtin_ntp_poll_interval_ms=100
--builtin_ntp_servers=127.4.183.84:33701
--ntp_initial_sync_wait_secs=10
--time_source=builtin
--fs_data_dirs=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data
--fs_wal_dir=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal
--ipki_server_key_size=768
--openssl_security_level_override=0
--rpc_bind_addresses=127.4.183.67:0
--rpc_server_allow_ephemeral_ports=true
--metrics_log_interval_ms=1000
--server_dump_info_format=pb
--server_dump_info_path=/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
--webserver_interface=127.4.183.67
--webserver_port=0
--tserver_master_addrs=127.4.183.126:36603
--never_fsync=true
--heap_profile_path=/tmp/kudu.6429
--redact=none
--unlock_experimental_flags=true
--unlock_unsafe_flags=true
--enable_minidumps=false
--local_ip_for_outbound_sockets=127.4.183.67

Tablet server version:
kudu 1.19.0-SNAPSHOT
revision 70c51312f1186a8ae9f46647160b7730123f7601-dirty
build type DEBUG
built by None at 12 Aug 2026 06:06:26 UTC on 39be9dd7121a
I20260812 08:03:57.925786  6429 env_posix.cc:2285] Not raising this process' open files per process limit of 1048576; it is already as high as it can go
I20260812 08:03:57.927078  6429 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:03:57.934660  6437 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
W20260812 08:03:57.934643  6435 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
W20260812 08:03:57.934646  6439 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
I20260812 08:03:57.935168  6429 server_base.cc:1061] running on GCE node
I20260812 08:03:57.935585  6429 hybrid_clock.cc:584] initializing the hybrid clock with 'builtin' time source
I20260812 08:03:57.936285  6429 hybrid_clock.cc:630] waiting up to --ntp_initial_sync_wait_secs=10 seconds for the clock to synchronize
I20260812 08:03:57.937470  6429 hybrid_clock.cc:648] HybridClock initialized: now 1786521837937444 us; error 40 us; skew 500 ppm
I20260812 08:03:57.940155  6429 webserver.cc:533] Webserver started at http://127.4.183.67:37033/ using document root <none> and password file <none>
I20260812 08:03:57.940868  6429 fs_manager.cc:362] Metadata directory not provided
I20260812 08:03:57.940939  6429 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:03:57.941254  6429 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:03:57.943259  6429 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data/instance:
uuid: "74afda23376e47c1b8c7a0fcbfb21e00"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.943835  6429 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance:
uuid: "74afda23376e47c1b8c7a0fcbfb21e00"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.947970  6429 fs_manager.cc:696] Time spent creating directory manager: real 0.004s	user 0.000s	sys 0.004s
I20260812 08:03:57.950832  6447 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.952149  6429 fs_manager.cc:730] Time spent opening block manager: real 0.003s	user 0.002s	sys 0.001s
I20260812 08:03:57.952327  6429 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data,/tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal
uuid: "74afda23376e47c1b8c7a0fcbfb21e00"
format_stamp: "Formatted at 2026-08-12 08:03:57 on dist-test-slave-8tdl"
I20260812 08:03:57.952450  6429 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal
metadata directory: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal
1 data directories: /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data/data
Total live blocks: 0
Total live bytes: 0
Total live bytes (after alignment): 0
Total number of LBM containers: 0 (0 full)
Did not check for missing blocks
Did not check for orphaned blocks
Total full LBM containers with extra space: 0 (0 repaired)
Total full LBM container extra space in bytes: 0 (0 repaired)
Total incomplete LBM containers: 0 (0 repaired)
Total LBM partial records: 0 (0 repaired)
Total corrupted LBM metadata records in RocksDB: 0 (0 repaired)
I20260812 08:03:57.968271  6429 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:03:57.969062  6429 env_posix.cc:2285] Not raising this process' running threads per effective uid limit of 18446744073709551615; it is already as high as it can go
I20260812 08:03:57.969285  6429 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:03:57.969942  6429 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:03:57.971117  6429 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:03:57.971169  6429 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.971238  6429 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:03:57.971280  6429 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:03:57.982232  6429 rpc_server.cc:307] RPC server started. Bound to: 127.4.183.67:44633
I20260812 08:03:57.982271  6572 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.4.183.67:44633 every 8 connection(s)
I20260812 08:03:57.983459  6429 server_base.cc:1193] Dumped server information to /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/data/info.pb
I20260812 08:03:57.986128  4829 external_mini_cluster.cc:1434] Started /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu as pid 6429
I20260812 08:03:57.986274  4829 external_mini_cluster.cc:1448] Reading /tmp/dist-test-taskgf4Dl6/test-tmp/varchar-itest.0.VarcharItest.TestVarcharRangePartition.1786521834180027-4829-0/minicluster-data/ts-2/wal/instance
I20260812 08:03:57.994202  6575 heartbeater.cc:344] Connected to a master server at 127.4.183.126:36603
I20260812 08:03:57.994545  6575 heartbeater.cc:461] Registering TS with master...
I20260812 08:03:57.995283  6575 heartbeater.cc:507] Master 127.4.183.126:36603 requested a full tablet report, sending...
I20260812 08:03:57.996582  6057 ts_manager.cc:194] Registered new tserver with Master: 74afda23376e47c1b8c7a0fcbfb21e00 (127.4.183.67:44633)
I20260812 08:03:57.997189  6057 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.4.183.67:46897
I20260812 08:03:58.001766  4829 external_mini_cluster.cc:955] 3 TS(s) registered with all masters
I20260812 08:03:58.013273  6057 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:44170:
name: "varchar-table"
schema {
  columns {
    name: "key"
    type: VARCHAR
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    type_attributes {
      length: 10
    }
    immutable: false
  }
  columns {
    name: "value"
    type: VARCHAR
    is_key: false
    is_nullable: true
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    type_attributes {
      length: 10
    }
    immutable: false
  }
}
num_replicas: 3
split_rows_range_bounds {
  rows: "<redacted>""\006\001\000\000\000\000\000\000\000\000\000\003\000\000\000\000\000\000\000\007\001\000\003\000\000\000\000\000\000\000\003\000\000\000\000\000\000\000"
  indirect_data: "<redacted>""barfoo"
}
partition_schema {
  range_schema {
    columns {
      name: "key"
    }
  }
}
W20260812 08:03:58.016335  6057 catalog_manager.cc:7099] The number of live tablet servers is not enough to re-replicate a tablet replica of the newly created table varchar-table in case of a server failure: 4 tablet servers would be needed, 3 are available. Consider bringing up more tablet servers.
I20260812 08:03:58.035663  6353 tablet_service.cc:1511] Processing CreateTablet for tablet cba164cf752a4dc48e77404c3bcffd4f (DEFAULT_TABLE table=varchar-table [id=3c201bebdce34de3b091dbf41a3905ab]), partition=RANGE (key) PARTITION "bar" <= VALUES < "foo"
I20260812 08:03:58.035642  6503 tablet_service.cc:1511] Processing CreateTablet for tablet cba164cf752a4dc48e77404c3bcffd4f (DEFAULT_TABLE table=varchar-table [id=3c201bebdce34de3b091dbf41a3905ab]), partition=RANGE (key) PARTITION "bar" <= VALUES < "foo"
I20260812 08:03:58.035633  6201 tablet_service.cc:1511] Processing CreateTablet for tablet cba164cf752a4dc48e77404c3bcffd4f (DEFAULT_TABLE table=varchar-table [id=3c201bebdce34de3b091dbf41a3905ab]), partition=RANGE (key) PARTITION "bar" <= VALUES < "foo"
I20260812 08:03:58.036908  6353 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet cba164cf752a4dc48e77404c3bcffd4f. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:58.036921  6503 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet cba164cf752a4dc48e77404c3bcffd4f. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:58.036921  6201 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet cba164cf752a4dc48e77404c3bcffd4f. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:03:58.042496  6598 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: Bootstrap starting.
I20260812 08:03:58.043754  6599 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Bootstrap starting.
I20260812 08:03:58.045754  6598 tablet_bootstrap.cc:654] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:58.045753  6599 tablet_bootstrap.cc:654] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:58.046305  6600 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Bootstrap starting.
I20260812 08:03:58.046633  6598 log.cc:826] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:58.046664  6599 log.cc:826] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:58.048731  6598 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: No bootstrap required, opened a new log
I20260812 08:03:58.048820  6600 tablet_bootstrap.cc:654] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Neither blocks nor log segments found. Creating new log.
I20260812 08:03:58.048983  6598 ts_tablet_manager.cc:1403] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: Time spent bootstrapping tablet: real 0.007s	user 0.005s	sys 0.000s
I20260812 08:03:58.049722  6600 log.cc:826] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Log is configured to *not* fsync() on all Append() calls
I20260812 08:03:58.050266  6599 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: No bootstrap required, opened a new log
I20260812 08:03:58.050493  6599 ts_tablet_manager.cc:1403] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Time spent bootstrapping tablet: real 0.007s	user 0.004s	sys 0.000s
I20260812 08:03:58.051661  6600 tablet_bootstrap.cc:492] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: No bootstrap required, opened a new log
I20260812 08:03:58.051863  6600 ts_tablet_manager.cc:1403] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Time spent bootstrapping tablet: real 0.006s	user 0.000s	sys 0.004s
I20260812 08:03:58.052438  6598 raft_consensus.cc:359] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.052697  6598 raft_consensus.cc:385] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:58.052783  6598 raft_consensus.cc:740] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: daf42f6fc59149e4ad62cfd026ce4eb5, State: Initialized, Role: FOLLOWER
I20260812 08:03:58.053284  6598 consensus_queue.cc:260] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [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: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.053328  6599 raft_consensus.cc:359] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.053578  6599 raft_consensus.cc:385] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:58.053670  6599 raft_consensus.cc:740] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 3da758746b334b668b5d9e843bbeb5a5, State: Initialized, Role: FOLLOWER
I20260812 08:03:58.054173  6426 heartbeater.cc:499] Master 127.4.183.126:36603 was elected leader, sending a full tablet report...
I20260812 08:03:58.054141  6599 consensus_queue.cc:260] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [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: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.054340  6598 ts_tablet_manager.cc:1434] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5: Time spent starting tablet: real 0.005s	user 0.005s	sys 0.000s
I20260812 08:03:58.054884  6276 heartbeater.cc:499] Master 127.4.183.126:36603 was elected leader, sending a full tablet report...
I20260812 08:03:58.055054  6599 ts_tablet_manager.cc:1434] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Time spent starting tablet: real 0.004s	user 0.005s	sys 0.000s
I20260812 08:03:58.056569  6600 raft_consensus.cc:359] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.056828  6600 raft_consensus.cc:385] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:03:58.056908  6600 raft_consensus.cc:740] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 74afda23376e47c1b8c7a0fcbfb21e00, State: Initialized, Role: FOLLOWER
I20260812 08:03:58.057535  6600 consensus_queue.cc:260] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [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: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.058854  6600 ts_tablet_manager.cc:1434] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Time spent starting tablet: real 0.007s	user 0.005s	sys 0.001s
I20260812 08:03:58.059350  6575 heartbeater.cc:499] Master 127.4.183.126:36603 was elected leader, sending a full tablet report...
W20260812 08:03:58.093780  6277 tablet.cc:2406] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5: Can't schedule compaction. Clean time has not been advanced past its initial value.
I20260812 08:03:58.192725  6607 raft_consensus.cc:493] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Starting pre-election (no leader contacted us within the election timeout)
I20260812 08:03:58.193049  6607 raft_consensus.cc:515] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Starting pre-election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.194344  6607 leader_election.cc:290] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [CANDIDATE]: Term 1 pre-election: Requested pre-vote from peers 74afda23376e47c1b8c7a0fcbfb21e00 (127.4.183.67:44633), daf42f6fc59149e4ad62cfd026ce4eb5 (127.4.183.66:44729)
I20260812 08:03:58.199244  6524 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "cba164cf752a4dc48e77404c3bcffd4f" candidate_uuid: "3da758746b334b668b5d9e843bbeb5a5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" is_pre_election: true
I20260812 08:03:58.199687  6524 raft_consensus.cc:2468] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3da758746b334b668b5d9e843bbeb5a5 in term 0.
I20260812 08:03:58.199920  6374 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "cba164cf752a4dc48e77404c3bcffd4f" candidate_uuid: "3da758746b334b668b5d9e843bbeb5a5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" is_pre_election: true
I20260812 08:03:58.200258  6374 raft_consensus.cc:2468] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 0 FOLLOWER]: Leader pre-election vote request: Granting yes vote for candidate 3da758746b334b668b5d9e843bbeb5a5 in term 0.
I20260812 08:03:58.200364  6144 leader_election.cc:304] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [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: 3da758746b334b668b5d9e843bbeb5a5, 74afda23376e47c1b8c7a0fcbfb21e00; no voters: 
I20260812 08:03:58.200726  6607 raft_consensus.cc:2804] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Leader pre-election won for term 1
I20260812 08:03:58.200820  6607 raft_consensus.cc:493] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Starting leader election (no leader contacted us within the election timeout)
I20260812 08:03:58.200865  6607 raft_consensus.cc:3060] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:58.201862  6607 raft_consensus.cc:515] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.202284  6607 leader_election.cc:290] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [CANDIDATE]: Term 1 election: Requested vote from peers 74afda23376e47c1b8c7a0fcbfb21e00 (127.4.183.67:44633), daf42f6fc59149e4ad62cfd026ce4eb5 (127.4.183.66:44729)
I20260812 08:03:58.202742  6374 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "cba164cf752a4dc48e77404c3bcffd4f" candidate_uuid: "3da758746b334b668b5d9e843bbeb5a5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5"
I20260812 08:03:58.202791  6524 tablet_service.cc:1917] Received RequestConsensusVote() RPC: tablet_id: "cba164cf752a4dc48e77404c3bcffd4f" candidate_uuid: "3da758746b334b668b5d9e843bbeb5a5" candidate_term: 1 candidate_status { last_received { term: 0 index: 0 } } ignore_live_leader: false dest_uuid: "74afda23376e47c1b8c7a0fcbfb21e00"
I20260812 08:03:58.202915  6524 raft_consensus.cc:3060] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:58.202914  6374 raft_consensus.cc:3060] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:03:58.204936  6374 raft_consensus.cc:2468] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3da758746b334b668b5d9e843bbeb5a5 in term 1.
I20260812 08:03:58.205016  6524 raft_consensus.cc:2468] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 1 FOLLOWER]: Leader election vote request: Granting yes vote for candidate 3da758746b334b668b5d9e843bbeb5a5 in term 1.
I20260812 08:03:58.205508  6144 leader_election.cc:304] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [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: 3da758746b334b668b5d9e843bbeb5a5, 74afda23376e47c1b8c7a0fcbfb21e00; no voters: 
I20260812 08:03:58.205817  6607 raft_consensus.cc:2804] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:03:58.206187  6607 raft_consensus.cc:697] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [term 1 LEADER]: Becoming Leader. State: Replica: 3da758746b334b668b5d9e843bbeb5a5, State: Running, Role: LEADER
I20260812 08:03:58.206549  6607 consensus_queue.cc:237] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [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: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } }
I20260812 08:03:58.210654  6057 catalog_manager.cc:5719] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 reported cstate change: term changed from 0 to 1, leader changed from <none> to 3da758746b334b668b5d9e843bbeb5a5 (127.4.183.65). New cstate: current_term: 1 leader_uuid: "3da758746b334b668b5d9e843bbeb5a5" committed_config { opid_index: -1 OBSOLETE_local: false peers { permanent_uuid: "3da758746b334b668b5d9e843bbeb5a5" member_type: VOTER last_known_addr { host: "127.4.183.65" port: 40639 } health_report { overall_health: HEALTHY } } peers { permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 } health_report { overall_health: UNKNOWN } } peers { permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 } health_report { overall_health: UNKNOWN } } }
I20260812 08:03:58.232849  6374 raft_consensus.cc:1275] T cba164cf752a4dc48e77404c3bcffd4f P daf42f6fc59149e4ad62cfd026ce4eb5 [term 1 FOLLOWER]: Refusing update from remote peer 3da758746b334b668b5d9e843bbeb5a5: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
I20260812 08:03:58.232849  6524 raft_consensus.cc:1275] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00 [term 1 FOLLOWER]: Refusing update from remote peer 3da758746b334b668b5d9e843bbeb5a5: Log matching property violated. Preceding OpId in replica: term: 0 index: 0. Preceding OpId from leader: term: 1 index: 2. (index mismatch)
I20260812 08:03:58.233676  6615 consensus_queue.cc:1048] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [LEADER]: Connected to new peer: Peer: permanent_uuid: "74afda23376e47c1b8c7a0fcbfb21e00" member_type: VOTER last_known_addr { host: "127.4.183.67" port: 44633 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
I20260812 08:03:58.233901  6607 consensus_queue.cc:1048] T cba164cf752a4dc48e77404c3bcffd4f P 3da758746b334b668b5d9e843bbeb5a5 [LEADER]: Connected to new peer: Peer: permanent_uuid: "daf42f6fc59149e4ad62cfd026ce4eb5" member_type: VOTER last_known_addr { host: "127.4.183.66" port: 44729 }, Status: LMP_MISMATCH, Last received: 0.0, Next index: 1, Last known committed idx: 0, Time since last communication: 0.000s
W20260812 08:03:58.234524  6576 tablet.cc:2406] T cba164cf752a4dc48e77404c3bcffd4f P 74afda23376e47c1b8c7a0fcbfb21e00: Can't schedule compaction. Clean time has not been advanced past its initial value.
W20260812 08:03:58.762635  4829 scanner-internal.cc:458] Time spent opening tablet: real 0.514s	user 0.001s	sys 0.000s
I20260812 08:03:58.763545  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 6127
I20260812 08:03:58.774799  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 6279
I20260812 08:03:58.785969  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 6429
I20260812 08:03:58.797744  4829 external_mini_cluster.cc:1664] Killing /tmp/dist-test-taskgf4Dl6/build/debug/bin/kudu with pid 6022
2026-08-12T08:03:58Z chronyd exiting
[       OK ] VarcharItest.TestVarcharRangePartition (1733 ms)
[----------] 3 tests from VarcharItest (4634 ms total)

[----------] Global test environment tear-down
[==========] 3 tests from 1 test suite ran. (4634 ms total)
[  PASSED  ] 3 tests.
