[==========] Running 2 tests from 1 test suite.
[----------] Global test environment set-up.
[----------] 2 tests from RpcLineItemDAOTest
[ RUN      ] RpcLineItemDAOTest.TestInsert
WARNING: Logging before InitGoogleLogging() is written to STDERR
I20260812 06:37:49.311400 26327 internal_mini_cluster.cc:156] Creating distributed mini masters. Addrs: 127.25.181.254:34317
I20260812 06:37:49.312338 26327 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 06:37:49.312948 26327 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 06:37:49.318795 26341 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 06:37:49.318926 26339 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 06:37:49.318819 26338 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 06:37:49.319116 26327 server_base.cc:1061] running on GCE node
I20260812 06:37:49.319553 26327 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 06:37:49.319674 26327 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
I20260812 06:37:49.319737 26327 hybrid_clock.cc:648] HybridClock initialized: now 1786516669319734 us; error 0 us; skew 500 ppm
I20260812 06:37:49.321429 26327 webserver.cc:533] Webserver started at http://127.25.181.254:38271/ using document root <none> and password file <none>
I20260812 06:37:49.321975 26327 fs_manager.cc:362] Metadata directory not provided
I20260812 06:37:49.322054 26327 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 06:37:49.322278 26327 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 06:37:49.323766 26327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/master-0-root/instance:
uuid: "ca9c81a72aa44320ab0b00ed8961d9f4"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.326936 26327 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.005s	sys 0.000s
I20260812 06:37:49.328874 26350 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.329849 26327 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.002s	sys 0.000s
I20260812 06:37:49.329993 26327 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/master-0-root
uuid: "ca9c81a72aa44320ab0b00ed8961d9f4"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.330089 26327 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/master-0-root
metadata directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/master-0-root
1 data directories: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/master-0-root/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 06:37:49.342361 26327 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 06:37:49.342906 26327 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 06:37:49.343075 26327 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 06:37:49.350423 26327 rpc_server.cc:307] RPC server started. Bound to: 127.25.181.254:34317
I20260812 06:37:49.350427 26451 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.181.254:34317 every 8 connection(s)
I20260812 06:37:49.353102 26453 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 06:37:49.358425 26453 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: Bootstrap starting.
I20260812 06:37:49.361044 26453 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: Neither blocks nor log segments found. Creating new log.
I20260812 06:37:49.361897 26453 log.cc:826] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: Log is configured to *not* fsync() on all Append() calls
I20260812 06:37:49.363448 26453 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: No bootstrap required, opened a new log
I20260812 06:37:49.366227 26453 raft_consensus.cc:359] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER }
I20260812 06:37:49.366381 26453 raft_consensus.cc:385] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 06:37:49.366421 26453 raft_consensus.cc:740] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: ca9c81a72aa44320ab0b00ed8961d9f4, State: Initialized, Role: FOLLOWER
I20260812 06:37:49.366925 26453 consensus_queue.cc:260] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [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: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER }
I20260812 06:37:49.367051 26453 raft_consensus.cc:399] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 06:37:49.367095 26453 raft_consensus.cc:493] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 06:37:49.367182 26453 raft_consensus.cc:3060] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 0 FOLLOWER]: Advancing to term 1
I20260812 06:37:49.367849 26453 raft_consensus.cc:515] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER }
I20260812 06:37:49.368211 26453 leader_election.cc:304] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [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: ca9c81a72aa44320ab0b00ed8961d9f4; no voters: 
I20260812 06:37:49.368523 26453 leader_election.cc:290] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 06:37:49.368649 26456 raft_consensus.cc:2804] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 06:37:49.368898 26456 raft_consensus.cc:697] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 1 LEADER]: Becoming Leader. State: Replica: ca9c81a72aa44320ab0b00ed8961d9f4, State: Running, Role: LEADER
I20260812 06:37:49.369297 26456 consensus_queue.cc:237] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [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: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER }
I20260812 06:37:49.369577 26453 sys_catalog.cc:565] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [sys.catalog]: configured and running, proceeding with master startup.
I20260812 06:37:49.371170 26458 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER } }
I20260812 06:37:49.371275 26458 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [sys.catalog]: This master's current role is: LEADER
I20260812 06:37:49.371223 26459 sys_catalog.cc:455] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [sys.catalog]: SysCatalogTable state changed. Reason: New leader ca9c81a72aa44320ab0b00ed8961d9f4. Latest consensus state: current_term: 1 leader_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "ca9c81a72aa44320ab0b00ed8961d9f4" member_type: VOTER } }
I20260812 06:37:49.371325 26459 sys_catalog.cc:458] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [sys.catalog]: This master's current role is: LEADER
I20260812 06:37:49.371661 26471 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 06:37:49.371990 26327 internal_mini_cluster.cc:184] Waiting to initialize catalog manager on master 0
I20260812 06:37:49.374027 26471 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 06:37:49.378643 26471 catalog_manager.cc:1383] Generated new cluster ID: ce03100419774760bf8c76c9f47761e8
I20260812 06:37:49.378703 26471 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 06:37:49.400449 26471 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 06:37:49.401552 26471 catalog_manager.cc:1540] Loading token signing keys...
I20260812 06:37:49.408357 26471 catalog_manager.cc:6092] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: Generated new TSK 0
I20260812 06:37:49.409086 26471 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 06:37:49.436993 26327 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 06:37:49.439605 26499 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 06:37:49.439654 26498 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 06:37:49.439663 26505 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 06:37:49.439998 26327 server_base.cc:1061] running on GCE node
I20260812 06:37:49.440169 26327 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 06:37:49.440214 26327 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
I20260812 06:37:49.440237 26327 hybrid_clock.cc:648] HybridClock initialized: now 1786516669440237 us; error 0 us; skew 500 ppm
I20260812 06:37:49.441174 26327 webserver.cc:533] Webserver started at http://127.25.181.193:45843/ using document root <none> and password file <none>
I20260812 06:37:49.441334 26327 fs_manager.cc:362] Metadata directory not provided
I20260812 06:37:49.441391 26327 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 06:37:49.441464 26327 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 06:37:49.441888 26327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/ts-0-root/instance:
uuid: "217a9f123fb3415981decce3fa519b53"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.443634 26327 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.000s	sys 0.002s
I20260812 06:37:49.444676 26518 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.444978 26327 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.001s
I20260812 06:37:49.445056 26327 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/ts-0-root
uuid: "217a9f123fb3415981decce3fa519b53"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.445143 26327 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/ts-0-root
metadata directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/ts-0-root
1 data directories: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786516669302358-26327-0/minicluster-data/ts-0-root/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 06:37:49.456480 26327 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 06:37:49.456957 26327 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 06:37:49.457454 26327 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 06:37:49.458511 26327 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 06:37:49.458578 26327 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.458688 26327 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 06:37:49.458725 26327 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.465528 26327 rpc_server.cc:307] RPC server started. Bound to: 127.25.181.193:46863
I20260812 06:37:49.465570 26632 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.181.193:46863 every 8 connection(s)
I20260812 06:37:49.483383 26633 heartbeater.cc:344] Connected to a master server at 127.25.181.254:34317
I20260812 06:37:49.483630 26633 heartbeater.cc:461] Registering TS with master...
I20260812 06:37:49.484148 26633 heartbeater.cc:507] Master 127.25.181.254:34317 requested a full tablet report, sending...
I20260812 06:37:49.485584 26387 ts_manager.cc:194] Registered new tserver with Master: 217a9f123fb3415981decce3fa519b53 (127.25.181.193:46863)
I20260812 06:37:49.486172 26327 internal_mini_cluster.cc:371] 1 TS(s) registered with all masters after 0.020028239s
I20260812 06:37:49.487068 26387 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.0.0.1:56104
I20260812 06:37:49.498508 26387 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:56106:
name: "tpch1"
schema {
  columns {
    name: "l_orderkey"
    type: INT64
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_linenumber"
    type: INT32
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_partkey"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_suppkey"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_quantity"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_extendedprice"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_discount"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_tax"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_returnflag"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_linestatus"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_commitdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_receiptdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipinstruct"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipmode"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_comment"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: LZ4
    cfile_block_size: 0
    immutable: false
  }
}
num_replicas: 1
split_rows_range_bounds {
}
partition_schema {
  range_schema {
    columns {
      name: "l_orderkey"
    }
    columns {
      name: "l_linenumber"
    }
  }
}
I20260812 06:37:49.512071 26564 tablet_service.cc:1511] Processing CreateTablet for tablet 350e08988a764ff0a29ca9123f873a31 (DEFAULT_TABLE table=tpch1 [id=c38bfbf93d074d64baab0f39aec8da16]), partition=RANGE (l_orderkey, l_linenumber) PARTITION UNBOUNDED
I20260812 06:37:49.512542 26564 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 350e08988a764ff0a29ca9123f873a31. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 06:37:49.514940 26649 tablet_bootstrap.cc:492] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: Bootstrap starting.
I20260812 06:37:49.515875 26649 tablet_bootstrap.cc:654] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: Neither blocks nor log segments found. Creating new log.
I20260812 06:37:49.517163 26649 tablet_bootstrap.cc:492] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: No bootstrap required, opened a new log
I20260812 06:37:49.517285 26649 ts_tablet_manager.cc:1403] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: Time spent bootstrapping tablet: real 0.002s	user 0.002s	sys 0.000s
I20260812 06:37:49.517735 26649 raft_consensus.cc:359] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "217a9f123fb3415981decce3fa519b53" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 46863 } }
I20260812 06:37:49.517851 26649 raft_consensus.cc:385] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 06:37:49.517899 26649 raft_consensus.cc:740] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 217a9f123fb3415981decce3fa519b53, State: Initialized, Role: FOLLOWER
I20260812 06:37:49.518050 26649 consensus_queue.cc:260] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [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: "217a9f123fb3415981decce3fa519b53" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 46863 } }
I20260812 06:37:49.518146 26649 raft_consensus.cc:399] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 06:37:49.518193 26649 raft_consensus.cc:493] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 06:37:49.518245 26649 raft_consensus.cc:3060] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 0 FOLLOWER]: Advancing to term 1
I20260812 06:37:49.519070 26649 raft_consensus.cc:515] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "217a9f123fb3415981decce3fa519b53" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 46863 } }
I20260812 06:37:49.519246 26649 leader_election.cc:304] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [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: 217a9f123fb3415981decce3fa519b53; no voters: 
I20260812 06:37:49.519455 26649 leader_election.cc:290] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 06:37:49.519577 26652 raft_consensus.cc:2804] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 06:37:49.519791 26649 ts_tablet_manager.cc:1434] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
I20260812 06:37:49.519850 26652 raft_consensus.cc:697] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 1 LEADER]: Becoming Leader. State: Replica: 217a9f123fb3415981decce3fa519b53, State: Running, Role: LEADER
I20260812 06:37:49.519979 26633 heartbeater.cc:499] Master 127.25.181.254:34317 was elected leader, sending a full tablet report...
I20260812 06:37:49.520080 26652 consensus_queue.cc:237] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [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: "217a9f123fb3415981decce3fa519b53" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 46863 } }
I20260812 06:37:49.522840 26387 catalog_manager.cc:5719] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 reported cstate change: term changed from 0 to 1, leader changed from <none> to 217a9f123fb3415981decce3fa519b53 (127.25.181.193). New cstate: current_term: 1 leader_uuid: "217a9f123fb3415981decce3fa519b53" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "217a9f123fb3415981decce3fa519b53" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 46863 } health_report { overall_health: HEALTHY } } }
I20260812 06:37:49.575313 26327 tablet_server.cc:179] TabletServer@127.25.181.193:0 shutting down...
I20260812 06:37:49.581722 26327 ts_tablet_manager.cc:1507] Shutting down tablet manager...
I20260812 06:37:49.582149 26327 tablet_replica.cc:333] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53: stopping tablet replica
I20260812 06:37:49.582391 26327 raft_consensus.cc:2243] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 1 LEADER]: Raft consensus shutting down.
I20260812 06:37:49.582584 26327 raft_consensus.cc:2272] T 350e08988a764ff0a29ca9123f873a31 P 217a9f123fb3415981decce3fa519b53 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 06:37:49.597302 26327 tablet_server.cc:196] TabletServer@127.25.181.193:0 shutdown complete.
I20260812 06:37:49.600951 26327 master.cc:562] Master@127.25.181.254:34317 shutting down...
I20260812 06:37:49.605521 26327 raft_consensus.cc:2243] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 1 LEADER]: Raft consensus shutting down.
I20260812 06:37:49.605679 26327 raft_consensus.cc:2272] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 06:37:49.605820 26327 tablet_replica.cc:333] T 00000000000000000000000000000000 P ca9c81a72aa44320ab0b00ed8961d9f4: stopping tablet replica
I20260812 06:37:49.618707 26327 master.cc:584] Master@127.25.181.254:34317 shutdown complete.
[       OK ] RpcLineItemDAOTest.TestInsert (314 ms)
[ RUN      ] RpcLineItemDAOTest.TestUpdate
I20260812 06:37:49.624930 26327 internal_mini_cluster.cc:156] Creating distributed mini masters. Addrs: 127.25.181.254:34083
I20260812 06:37:49.625284 26327 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 06:37:49.626893 26660 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 06:37:49.627045 26667 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 06:37:49.627182 26663 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 06:37:49.627224 26327 server_base.cc:1061] running on GCE node
I20260812 06:37:49.627462 26327 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 06:37:49.627519 26327 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
I20260812 06:37:49.627542 26327 hybrid_clock.cc:648] HybridClock initialized: now 1786516669627541 us; error 0 us; skew 500 ppm
I20260812 06:37:49.628645 26327 webserver.cc:533] Webserver started at http://127.25.181.254:39883/ using document root <none> and password file <none>
I20260812 06:37:49.628825 26327 fs_manager.cc:362] Metadata directory not provided
I20260812 06:37:49.628881 26327 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 06:37:49.628957 26327 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 06:37:49.629388 26327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/master-0-root/instance:
uuid: "c122c49a9abe45ef9316e70c39a87c2e"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.631125 26327 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.002s	sys 0.001s
I20260812 06:37:49.632133 26675 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.632438 26327 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
I20260812 06:37:49.632503 26327 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/master-0-root
uuid: "c122c49a9abe45ef9316e70c39a87c2e"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.632591 26327 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/master-0-root
metadata directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/master-0-root
1 data directories: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/master-0-root/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 06:37:49.642892 26327 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 06:37:49.643216 26327 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 06:37:49.648424 26327 rpc_server.cc:307] RPC server started. Bound to: 127.25.181.254:34083
I20260812 06:37:49.650264 26765 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.181.254:34083 every 8 connection(s)
I20260812 06:37:49.650770 26766 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 06:37:49.652938 26766 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e: Bootstrap starting.
I20260812 06:37:49.653843 26766 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e: Neither blocks nor log segments found. Creating new log.
I20260812 06:37:49.654893 26766 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e: No bootstrap required, opened a new log
I20260812 06:37:49.655328 26766 raft_consensus.cc:359] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER }
I20260812 06:37:49.655427 26766 raft_consensus.cc:385] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 06:37:49.655460 26766 raft_consensus.cc:740] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c122c49a9abe45ef9316e70c39a87c2e, State: Initialized, Role: FOLLOWER
I20260812 06:37:49.655628 26766 consensus_queue.cc:260] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [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: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER }
I20260812 06:37:49.655714 26766 raft_consensus.cc:399] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 06:37:49.655762 26766 raft_consensus.cc:493] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 06:37:49.655812 26766 raft_consensus.cc:3060] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 0 FOLLOWER]: Advancing to term 1
I20260812 06:37:49.656625 26766 raft_consensus.cc:515] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER }
I20260812 06:37:49.656770 26766 leader_election.cc:304] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [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: c122c49a9abe45ef9316e70c39a87c2e; no voters: 
I20260812 06:37:49.656946 26766 leader_election.cc:290] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 06:37:49.657074 26771 raft_consensus.cc:2804] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 1 FOLLOWER]: Leader election won for term 1
I20260812 06:37:49.657292 26771 raft_consensus.cc:697] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 1 LEADER]: Becoming Leader. State: Replica: c122c49a9abe45ef9316e70c39a87c2e, State: Running, Role: LEADER
I20260812 06:37:49.657418 26766 sys_catalog.cc:565] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [sys.catalog]: configured and running, proceeding with master startup.
I20260812 06:37:49.657424 26771 consensus_queue.cc:237] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [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: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER }
I20260812 06:37:49.657886 26773 sys_catalog.cc:455] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "c122c49a9abe45ef9316e70c39a87c2e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER } }
I20260812 06:37:49.657974 26773 sys_catalog.cc:458] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [sys.catalog]: This master's current role is: LEADER
I20260812 06:37:49.658197 26774 sys_catalog.cc:455] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [sys.catalog]: SysCatalogTable state changed. Reason: New leader c122c49a9abe45ef9316e70c39a87c2e. Latest consensus state: current_term: 1 leader_uuid: "c122c49a9abe45ef9316e70c39a87c2e" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c122c49a9abe45ef9316e70c39a87c2e" member_type: VOTER } }
I20260812 06:37:49.658283 26774 sys_catalog.cc:458] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [sys.catalog]: This master's current role is: LEADER
I20260812 06:37:49.658483 26777 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 06:37:49.659484 26777 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 06:37:49.659651 26327 internal_mini_cluster.cc:184] Waiting to initialize catalog manager on master 0
I20260812 06:37:49.661377 26777 catalog_manager.cc:1383] Generated new cluster ID: ec8630c97d3a4b1c82e0d595698cd7f9
I20260812 06:37:49.661453 26777 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 06:37:49.665583 26777 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 06:37:49.666281 26777 catalog_manager.cc:1540] Loading token signing keys...
I20260812 06:37:49.681357 26777 catalog_manager.cc:6092] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e: Generated new TSK 0
I20260812 06:37:49.681529 26777 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 06:37:49.691928 26327 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 06:37:49.693984 26798 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 06:37:49.694128 26796 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 06:37:49.694378 26804 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 06:37:49.694518 26327 server_base.cc:1061] running on GCE node
I20260812 06:37:49.694711 26327 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 06:37:49.694749 26327 system_unsync_time.cc:38] NTP support is disabled. Clock error bounds will not be accurate. This configuration is not suitable for distributed clusters.
I20260812 06:37:49.694765 26327 hybrid_clock.cc:648] HybridClock initialized: now 1786516669694765 us; error 0 us; skew 500 ppm
I20260812 06:37:49.695751 26327 webserver.cc:533] Webserver started at http://127.25.181.193:45307/ using document root <none> and password file <none>
I20260812 06:37:49.695937 26327 fs_manager.cc:362] Metadata directory not provided
I20260812 06:37:49.695993 26327 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 06:37:49.696089 26327 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 06:37:49.696550 26327 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/ts-0-root/instance:
uuid: "9498511ccd5c49fca6fbf39e6ee146c6"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.698024 26327 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.000s
I20260812 06:37:49.699015 26813 log_block_manager.cc:4127] Time spent loading block containers with low live blocks: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.699265 26327 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
I20260812 06:37:49.699342 26327 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/ts-0-root
uuid: "9498511ccd5c49fca6fbf39e6ee146c6"
format_stamp: "Formatted at 2026-08-12 06:37:49 on dist-test-slave-zpvx"
I20260812 06:37:49.699430 26327 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/ts-0-root
metadata directory: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/ts-0-root
1 data directories: /tmp/dist-test-task4a2yQc/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786516669302358-26327-0/minicluster-data/ts-0-root/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 06:37:49.707403 26327 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 06:37:49.707753 26327 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 06:37:49.708050 26327 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 06:37:49.708575 26327 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 06:37:49.708616 26327 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.708671 26327 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 06:37:49.708709 26327 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 06:37:49.714128 26327 rpc_server.cc:307] RPC server started. Bound to: 127.25.181.193:35981
I20260812 06:37:49.714998 26926 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.25.181.193:35981 every 8 connection(s)
I20260812 06:37:49.720122 26927 heartbeater.cc:344] Connected to a master server at 127.25.181.254:34083
I20260812 06:37:49.720221 26927 heartbeater.cc:461] Registering TS with master...
I20260812 06:37:49.720459 26927 heartbeater.cc:507] Master 127.25.181.254:34083 requested a full tablet report, sending...
I20260812 06:37:49.721063 26709 ts_manager.cc:194] Registered new tserver with Master: 9498511ccd5c49fca6fbf39e6ee146c6 (127.25.181.193:35981)
I20260812 06:37:49.721665 26327 internal_mini_cluster.cc:371] 1 TS(s) registered with all masters after 0.006680325s
I20260812 06:37:49.721925 26709 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.0.0.1:48046
I20260812 06:37:49.729987 26709 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:48058:
name: "tpch1"
schema {
  columns {
    name: "l_orderkey"
    type: INT64
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_linenumber"
    type: INT32
    is_key: true
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_partkey"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_suppkey"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_quantity"
    type: INT32
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_extendedprice"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_discount"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_tax"
    type: DOUBLE
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_returnflag"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_linestatus"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_commitdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_receiptdate"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipinstruct"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_shipmode"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: DEFAULT_COMPRESSION
    cfile_block_size: 0
    immutable: false
  }
  columns {
    name: "l_comment"
    type: STRING
    is_key: false
    is_nullable: false
    encoding: AUTO_ENCODING
    compression: LZ4
    cfile_block_size: 0
    immutable: false
  }
}
num_replicas: 1
split_rows_range_bounds {
}
partition_schema {
  range_schema {
    columns {
      name: "l_orderkey"
    }
    columns {
      name: "l_linenumber"
    }
  }
}
I20260812 06:37:49.738935 26856 tablet_service.cc:1511] Processing CreateTablet for tablet 74290915919c488494b03bc237e54e51 (DEFAULT_TABLE table=tpch1 [id=28225012c5124d2dae2500c85b400b28]), partition=RANGE (l_orderkey, l_linenumber) PARTITION UNBOUNDED
I20260812 06:37:49.739225 26856 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 74290915919c488494b03bc237e54e51. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 06:37:49.741483 26948 tablet_bootstrap.cc:492] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: Bootstrap starting.
I20260812 06:37:49.742592 26948 tablet_bootstrap.cc:654] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: Neither blocks nor log segments found. Creating new log.
I20260812 06:37:49.743880 26948 tablet_bootstrap.cc:492] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: No bootstrap required, opened a new log
I20260812 06:37:49.743966 26948 ts_tablet_manager.cc:1403] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: Time spent bootstrapping tablet: real 0.003s	user 0.002s	sys 0.000s
I20260812 06:37:49.744448 26948 raft_consensus.cc:359] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9498511ccd5c49fca6fbf39e6ee146c6" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 35981 } }
I20260812 06:37:49.744561 26948 raft_consensus.cc:385] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 06:37:49.744596 26948 raft_consensus.cc:740] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 9498511ccd5c49fca6fbf39e6ee146c6, State: Initialized, Role: FOLLOWER
I20260812 06:37:49.744720 26948 consensus_queue.cc:260] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [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: "9498511ccd5c49fca6fbf39e6ee146c6" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 35981 } }
I20260812 06:37:49.744813 26948 raft_consensus.cc:399] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 06:37:49.744844 26948 raft_consensus.cc:493] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 06:37:49.744889 26948 raft_consensus.cc:3060] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 0 FOLLOWER]: Advancing to term 1
I20260812 06:37:49.745798 26948 raft_consensus.cc:515] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9498511ccd5c49fca6fbf39e6ee146c6" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 35981 } }
I20260812 06:37:49.745939 26948 leader_election.cc:304] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [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: 9498511ccd5c49fca6fbf39e6ee146c6; no voters: 
I20260812 06:37:49.746125 26948 leader_election.cc:290] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 06:37:49.746248 26950 raft_consensus.cc:2804] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 06:37:49.746418 26948 ts_tablet_manager.cc:1434] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: Time spent starting tablet: real 0.002s	user 0.003s	sys 0.000s
I20260812 06:37:49.746505 26927 heartbeater.cc:499] Master 127.25.181.254:34083 was elected leader, sending a full tablet report...
I20260812 06:37:49.746502 26950 raft_consensus.cc:697] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 1 LEADER]: Becoming Leader. State: Replica: 9498511ccd5c49fca6fbf39e6ee146c6, State: Running, Role: LEADER
I20260812 06:37:49.746809 26950 consensus_queue.cc:237] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [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: "9498511ccd5c49fca6fbf39e6ee146c6" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 35981 } }
I20260812 06:37:49.748065 26709 catalog_manager.cc:5719] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 reported cstate change: term changed from 0 to 1, leader changed from <none> to 9498511ccd5c49fca6fbf39e6ee146c6 (127.25.181.193). New cstate: current_term: 1 leader_uuid: "9498511ccd5c49fca6fbf39e6ee146c6" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "9498511ccd5c49fca6fbf39e6ee146c6" member_type: VOTER last_known_addr { host: "127.25.181.193" port: 35981 } health_report { overall_health: HEALTHY } } }
I20260812 06:37:49.766877 26327 tablet_server.cc:179] TabletServer@127.25.181.193:0 shutting down...
I20260812 06:37:49.770581 26327 ts_tablet_manager.cc:1507] Shutting down tablet manager...
I20260812 06:37:49.770859 26327 tablet_replica.cc:333] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6: stopping tablet replica
I20260812 06:37:49.770963 26327 raft_consensus.cc:2243] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 1 LEADER]: Raft consensus shutting down.
I20260812 06:37:49.771072 26327 raft_consensus.cc:2272] T 74290915919c488494b03bc237e54e51 P 9498511ccd5c49fca6fbf39e6ee146c6 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 06:37:49.774097 26327 tablet_server.cc:196] TabletServer@127.25.181.193:0 shutdown complete.
I20260812 06:37:49.776013 26327 master.cc:562] Master@127.25.181.254:34083 shutting down...
I20260812 06:37:49.780735 26327 raft_consensus.cc:2243] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 1 LEADER]: Raft consensus shutting down.
I20260812 06:37:49.780884 26327 raft_consensus.cc:2272] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 06:37:49.781003 26327 tablet_replica.cc:333] T 00000000000000000000000000000000 P c122c49a9abe45ef9316e70c39a87c2e: stopping tablet replica
I20260812 06:37:49.783655 26327 master.cc:584] Master@127.25.181.254:34083 shutdown complete.
[       OK ] RpcLineItemDAOTest.TestUpdate (164 ms)
[----------] 2 tests from RpcLineItemDAOTest (478 ms total)

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