[==========] 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 08:04:06.126149 17463 internal_mini_cluster.cc:156] Creating distributed mini masters. Addrs: 127.17.13.254:39305
I20260812 08:04:06.127278 17463 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:04:06.127904 17463 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:04:06.135192 17470 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:04:06.135455 17463 server_base.cc:1061] running on GCE node
W20260812 08:04:06.135188 17478 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:04:06.135192 17476 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:04:06.136085 17463 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 08:04:06.136232 17463 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 08:04:06.136288 17463 hybrid_clock.cc:648] HybridClock initialized: now 1786521846136286 us; error 0 us; skew 500 ppm
I20260812 08:04:06.138466 17463 webserver.cc:533] Webserver started at http://127.17.13.254:39451/ using document root <none> and password file <none>
I20260812 08:04:06.139073 17463 fs_manager.cc:362] Metadata directory not provided
I20260812 08:04:06.139134 17463 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:04:06.139432 17463 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:04:06.141201 17463 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/master-0-root/instance:
uuid: "fd46610605a8490faff534823ad3c6d9"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.144913 17463 fs_manager.cc:696] Time spent creating directory manager: real 0.003s	user 0.002s	sys 0.001s
I20260812 08:04:06.147259 17488 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:04:06.148353 17463 fs_manager.cc:730] Time spent opening block manager: real 0.002s	user 0.001s	sys 0.000s
I20260812 08:04:06.148519 17463 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/master-0-root
uuid: "fd46610605a8490faff534823ad3c6d9"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.148625 17463 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/master-0-root
metadata directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/master-0-root
1 data directories: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-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 08:04:06.160642 17463 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:04:06.161309 17463 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:04:06.161497 17463 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:04:06.169673 17463 rpc_server.cc:307] RPC server started. Bound to: 127.17.13.254:39305
I20260812 08:04:06.169695 17564 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.13.254:39305 every 8 connection(s)
I20260812 08:04:06.172660 17565 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:04:06.178944 17565 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: Bootstrap starting.
I20260812 08:04:06.181914 17565 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: Neither blocks nor log segments found. Creating new log.
I20260812 08:04:06.182894 17565 log.cc:826] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: Log is configured to *not* fsync() on all Append() calls
I20260812 08:04:06.184649 17565 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: No bootstrap required, opened a new log
I20260812 08:04:06.187584 17565 raft_consensus.cc:359] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER }
I20260812 08:04:06.187754 17565 raft_consensus.cc:385] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:04:06.187817 17565 raft_consensus.cc:740] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: fd46610605a8490faff534823ad3c6d9, State: Initialized, Role: FOLLOWER
I20260812 08:04:06.188462 17565 consensus_queue.cc:260] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [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: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER }
I20260812 08:04:06.188607 17565 raft_consensus.cc:399] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:04:06.188656 17565 raft_consensus.cc:493] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:04:06.188743 17565 raft_consensus.cc:3060] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:04:06.189484 17565 raft_consensus.cc:515] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER }
I20260812 08:04:06.189951 17565 leader_election.cc:304] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [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: fd46610605a8490faff534823ad3c6d9; no voters: 
I20260812 08:04:06.190285 17565 leader_election.cc:290] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:04:06.190443 17569 raft_consensus.cc:2804] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:04:06.190702 17569 raft_consensus.cc:697] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 1 LEADER]: Becoming Leader. State: Replica: fd46610605a8490faff534823ad3c6d9, State: Running, Role: LEADER
I20260812 08:04:06.191169 17569 consensus_queue.cc:237] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [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: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER }
I20260812 08:04:06.191457 17565 sys_catalog.cc:565] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [sys.catalog]: configured and running, proceeding with master startup.
I20260812 08:04:06.193097 17572 sys_catalog.cc:455] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "fd46610605a8490faff534823ad3c6d9" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER } }
I20260812 08:04:06.193228 17572 sys_catalog.cc:458] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [sys.catalog]: This master's current role is: LEADER
I20260812 08:04:06.193570 17575 sys_catalog.cc:455] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [sys.catalog]: SysCatalogTable state changed. Reason: New leader fd46610605a8490faff534823ad3c6d9. Latest consensus state: current_term: 1 leader_uuid: "fd46610605a8490faff534823ad3c6d9" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "fd46610605a8490faff534823ad3c6d9" member_type: VOTER } }
I20260812 08:04:06.193671 17575 sys_catalog.cc:458] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [sys.catalog]: This master's current role is: LEADER
I20260812 08:04:06.193830 17463 internal_mini_cluster.cc:184] Waiting to initialize catalog manager on master 0
W20260812 08:04:06.196477 17597 catalog_manager.cc:1594] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: loading cluster ID for follower catalog manager: Not found: cluster ID entry not found
W20260812 08:04:06.196566 17597 catalog_manager.cc:883] Not found: cluster ID entry not found: failed to prepare follower catalog manager, will retry
I20260812 08:04:06.196640 17592 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 08:04:06.197638 17592 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 08:04:06.206954 17592 catalog_manager.cc:1383] Generated new cluster ID: a19307a789d84960a9c47e30d3a0dd2f
I20260812 08:04:06.207036 17592 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 08:04:06.234382 17592 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 08:04:06.235632 17592 catalog_manager.cc:1540] Loading token signing keys...
I20260812 08:04:06.244415 17592 catalog_manager.cc:6092] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: Generated new TSK 0
I20260812 08:04:06.245278 17592 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 08:04:06.261217 17463 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:04:06.264098 17606 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:04:06.264161 17603 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:04:06.264125 17602 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:04:06.264127 17463 server_base.cc:1061] running on GCE node
I20260812 08:04:06.264611 17463 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 08:04:06.264668 17463 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 08:04:06.264684 17463 hybrid_clock.cc:648] HybridClock initialized: now 1786521846264684 us; error 0 us; skew 500 ppm
I20260812 08:04:06.265715 17463 webserver.cc:533] Webserver started at http://127.17.13.193:44715/ using document root <none> and password file <none>
I20260812 08:04:06.265918 17463 fs_manager.cc:362] Metadata directory not provided
I20260812 08:04:06.265990 17463 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:04:06.266080 17463 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:04:06.266597 17463 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/ts-0-root/instance:
uuid: "c812a46026774f26a64a7e8397c74ee5"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.268471 17463 fs_manager.cc:696] Time spent creating directory manager: real 0.002s	user 0.001s	sys 0.001s
I20260812 08:04:06.269508 17617 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:04:06.269817 17463 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
I20260812 08:04:06.269922 17463 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/ts-0-root
uuid: "c812a46026774f26a64a7e8397c74ee5"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.269996 17463 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/ts-0-root
metadata directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-0/minicluster-data/ts-0-root
1 data directories: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestInsert.1786521846115509-17463-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 08:04:06.281239 17463 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:04:06.282378 17463 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:04:06.283138 17463 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:04:06.284428 17463 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:04:06.284559 17463 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:04:06.284718 17463 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:04:06.284798 17463 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:04:06.295532 17463 rpc_server.cc:307] RPC server started. Bound to: 127.17.13.193:36481
I20260812 08:04:06.295567 17711 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.13.193:36481 every 8 connection(s)
I20260812 08:04:06.311887 17712 heartbeater.cc:344] Connected to a master server at 127.17.13.254:39305
I20260812 08:04:06.312217 17712 heartbeater.cc:461] Registering TS with master...
I20260812 08:04:06.312772 17712 heartbeater.cc:507] Master 127.17.13.254:39305 requested a full tablet report, sending...
I20260812 08:04:06.314330 17513 ts_manager.cc:194] Registered new tserver with Master: c812a46026774f26a64a7e8397c74ee5 (127.17.13.193:36481)
I20260812 08:04:06.314744 17463 internal_mini_cluster.cc:371] 1 TS(s) registered with all masters after 0.018301667s
I20260812 08:04:06.316951 17513 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.0.0.1:48344
I20260812 08:04:06.333709 17513 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:48352:
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 08:04:06.350332 17660 tablet_service.cc:1511] Processing CreateTablet for tablet c5897c581e4f4040823bdc4327549dc4 (DEFAULT_TABLE table=tpch1 [id=c747ec5bc5bc4b2abc21c5c1c6f6730d]), partition=RANGE (l_orderkey, l_linenumber) PARTITION UNBOUNDED
I20260812 08:04:06.350971 17660 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet c5897c581e4f4040823bdc4327549dc4. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:04:06.354463 17728 tablet_bootstrap.cc:492] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: Bootstrap starting.
I20260812 08:04:06.355876 17728 tablet_bootstrap.cc:654] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: Neither blocks nor log segments found. Creating new log.
I20260812 08:04:06.357123 17728 tablet_bootstrap.cc:492] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: No bootstrap required, opened a new log
I20260812 08:04:06.357241 17728 ts_tablet_manager.cc:1403] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: Time spent bootstrapping tablet: real 0.003s	user 0.003s	sys 0.000s
I20260812 08:04:06.357744 17728 raft_consensus.cc:359] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c812a46026774f26a64a7e8397c74ee5" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 36481 } }
I20260812 08:04:06.357858 17728 raft_consensus.cc:385] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:04:06.357889 17728 raft_consensus.cc:740] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: c812a46026774f26a64a7e8397c74ee5, State: Initialized, Role: FOLLOWER
I20260812 08:04:06.358011 17728 consensus_queue.cc:260] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [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: "c812a46026774f26a64a7e8397c74ee5" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 36481 } }
I20260812 08:04:06.358084 17728 raft_consensus.cc:399] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:04:06.358114 17728 raft_consensus.cc:493] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:04:06.358165 17728 raft_consensus.cc:3060] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:04:06.359059 17728 raft_consensus.cc:515] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c812a46026774f26a64a7e8397c74ee5" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 36481 } }
I20260812 08:04:06.359210 17728 leader_election.cc:304] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [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: c812a46026774f26a64a7e8397c74ee5; no voters: 
I20260812 08:04:06.359393 17728 leader_election.cc:290] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:04:06.359675 17728 ts_tablet_manager.cc:1434] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
I20260812 08:04:06.360191 17712 heartbeater.cc:499] Master 127.17.13.254:39305 was elected leader, sending a full tablet report...
I20260812 08:04:06.361651 17733 raft_consensus.cc:2804] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:04:06.361948 17733 raft_consensus.cc:697] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 1 LEADER]: Becoming Leader. State: Replica: c812a46026774f26a64a7e8397c74ee5, State: Running, Role: LEADER
I20260812 08:04:06.362171 17733 consensus_queue.cc:237] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [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: "c812a46026774f26a64a7e8397c74ee5" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 36481 } }
I20260812 08:04:06.365078 17510 catalog_manager.cc:5719] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 reported cstate change: term changed from 0 to 1, leader changed from <none> to c812a46026774f26a64a7e8397c74ee5 (127.17.13.193). New cstate: current_term: 1 leader_uuid: "c812a46026774f26a64a7e8397c74ee5" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "c812a46026774f26a64a7e8397c74ee5" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 36481 } health_report { overall_health: HEALTHY } } }
I20260812 08:04:06.422762 17463 tablet_server.cc:179] TabletServer@127.17.13.193:0 shutting down...
I20260812 08:04:06.428869 17463 ts_tablet_manager.cc:1507] Shutting down tablet manager...
I20260812 08:04:06.429476 17463 tablet_replica.cc:333] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5: stopping tablet replica
I20260812 08:04:06.429842 17463 raft_consensus.cc:2243] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 1 LEADER]: Raft consensus shutting down.
I20260812 08:04:06.430089 17463 raft_consensus.cc:2272] T c5897c581e4f4040823bdc4327549dc4 P c812a46026774f26a64a7e8397c74ee5 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 08:04:06.446264 17463 tablet_server.cc:196] TabletServer@127.17.13.193:0 shutdown complete.
I20260812 08:04:06.450433 17463 master.cc:562] Master@127.17.13.254:39305 shutting down...
I20260812 08:04:06.455153 17463 raft_consensus.cc:2243] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 1 LEADER]: Raft consensus shutting down.
I20260812 08:04:06.455312 17463 raft_consensus.cc:2272] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 08:04:06.455504 17463 tablet_replica.cc:333] T 00000000000000000000000000000000 P fd46610605a8490faff534823ad3c6d9: stopping tablet replica
I20260812 08:04:06.468894 17463 master.cc:584] Master@127.17.13.254:39305 shutdown complete.
[       OK ] RpcLineItemDAOTest.TestInsert (350 ms)
[ RUN      ] RpcLineItemDAOTest.TestUpdate
I20260812 08:04:06.475543 17463 internal_mini_cluster.cc:156] Creating distributed mini masters. Addrs: 127.17.13.254:44983
I20260812 08:04:06.475906 17463 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:04:06.477520 17747 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:04:06.477568 17740 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:04:06.477895 17743 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:04:06.477929 17463 server_base.cc:1061] running on GCE node
I20260812 08:04:06.478179 17463 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 08:04:06.478242 17463 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 08:04:06.478274 17463 hybrid_clock.cc:648] HybridClock initialized: now 1786521846478274 us; error 0 us; skew 500 ppm
I20260812 08:04:06.479188 17463 webserver.cc:533] Webserver started at http://127.17.13.254:45993/ using document root <none> and password file <none>
I20260812 08:04:06.479373 17463 fs_manager.cc:362] Metadata directory not provided
I20260812 08:04:06.479444 17463 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:04:06.479523 17463 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:04:06.479923 17463 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/master-0-root/instance:
uuid: "f912c30ff12742d4bc01dd8b6d27fbd8"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.481444 17463 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.001s	sys 0.001s
I20260812 08:04:06.482503 17754 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:04:06.482760 17463 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.001s	sys 0.000s
I20260812 08:04:06.482836 17463 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/master-0-root
uuid: "f912c30ff12742d4bc01dd8b6d27fbd8"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.482925 17463 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/master-0-root
metadata directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/master-0-root
1 data directories: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-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 08:04:06.492547 17463 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:04:06.492944 17463 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:04:06.498462 17463 rpc_server.cc:307] RPC server started. Bound to: 127.17.13.254:44983
I20260812 08:04:06.500315 17835 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.13.254:44983 every 8 connection(s)
I20260812 08:04:06.500806 17836 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:04:06.502722 17836 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8: Bootstrap starting.
I20260812 08:04:06.503597 17836 tablet_bootstrap.cc:654] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8: Neither blocks nor log segments found. Creating new log.
I20260812 08:04:06.504626 17836 tablet_bootstrap.cc:492] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8: No bootstrap required, opened a new log
I20260812 08:04:06.505050 17836 raft_consensus.cc:359] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER }
I20260812 08:04:06.505162 17836 raft_consensus.cc:385] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:04:06.505214 17836 raft_consensus.cc:740] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: f912c30ff12742d4bc01dd8b6d27fbd8, State: Initialized, Role: FOLLOWER
I20260812 08:04:06.505393 17836 consensus_queue.cc:260] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [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: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER }
I20260812 08:04:06.505504 17836 raft_consensus.cc:399] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:04:06.505575 17836 raft_consensus.cc:493] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:04:06.505633 17836 raft_consensus.cc:3060] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:04:06.506341 17836 raft_consensus.cc:515] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER }
I20260812 08:04:06.506492 17836 leader_election.cc:304] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [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: f912c30ff12742d4bc01dd8b6d27fbd8; no voters: 
I20260812 08:04:06.506704 17836 leader_election.cc:290] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:04:06.506825 17842 raft_consensus.cc:2804] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:04:06.507016 17842 raft_consensus.cc:697] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 1 LEADER]: Becoming Leader. State: Replica: f912c30ff12742d4bc01dd8b6d27fbd8, State: Running, Role: LEADER
I20260812 08:04:06.507180 17836 sys_catalog.cc:565] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [sys.catalog]: configured and running, proceeding with master startup.
I20260812 08:04:06.507166 17842 consensus_queue.cc:237] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [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: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER }
I20260812 08:04:06.507606 17842 sys_catalog.cc:455] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [sys.catalog]: SysCatalogTable state changed. Reason: New leader f912c30ff12742d4bc01dd8b6d27fbd8. Latest consensus state: current_term: 1 leader_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER } }
I20260812 08:04:06.507690 17842 sys_catalog.cc:458] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [sys.catalog]: This master's current role is: LEADER
I20260812 08:04:06.508199 17845 sys_catalog.cc:455] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [sys.catalog]: SysCatalogTable state changed. Reason: RaftConsensus started. Latest consensus state: current_term: 1 leader_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "f912c30ff12742d4bc01dd8b6d27fbd8" member_type: VOTER } }
I20260812 08:04:06.508287 17845 sys_catalog.cc:458] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [sys.catalog]: This master's current role is: LEADER
I20260812 08:04:06.508777 17850 catalog_manager.cc:1511] Loading table and tablet metadata into memory...
I20260812 08:04:06.509873 17850 catalog_manager.cc:1520] Initializing Kudu cluster ID...
I20260812 08:04:06.510068 17463 internal_mini_cluster.cc:184] Waiting to initialize catalog manager on master 0
I20260812 08:04:06.511886 17850 catalog_manager.cc:1383] Generated new cluster ID: f5cc965d71154abf9b1a655a8eb3f84c
I20260812 08:04:06.511945 17850 catalog_manager.cc:1531] Initializing Kudu internal certificate authority...
I20260812 08:04:06.522751 17850 catalog_manager.cc:1406] Generated new certificate authority record
I20260812 08:04:06.523561 17850 catalog_manager.cc:1540] Loading token signing keys...
I20260812 08:04:06.531635 17850 catalog_manager.cc:6092] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8: Generated new TSK 0
I20260812 08:04:06.531857 17850 catalog_manager.cc:1550] Initializing in-progress tserver states...
I20260812 08:04:06.542711 17463 file_cache.cc:504] Constructed file cache file cache with capacity 419430
W20260812 08:04:06.544893 17872 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:04:06.544915 17876 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:04:06.544894 17873 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:04:06.545372 17463 server_base.cc:1061] running on GCE node
I20260812 08:04:06.545610 17463 hybrid_clock.cc:584] initializing the hybrid clock with 'system_unsync' time source
W20260812 08:04:06.545677 17463 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 08:04:06.545718 17463 hybrid_clock.cc:648] HybridClock initialized: now 1786521846545718 us; error 0 us; skew 500 ppm
I20260812 08:04:06.546672 17463 webserver.cc:533] Webserver started at http://127.17.13.193:37091/ using document root <none> and password file <none>
I20260812 08:04:06.546868 17463 fs_manager.cc:362] Metadata directory not provided
I20260812 08:04:06.546947 17463 fs_manager.cc:368] Using write-ahead log directory (fs_wal_dir) as metadata directory
I20260812 08:04:06.547030 17463 server_base.cc:909] This appears to be a new deployment of Kudu; creating new FS layout
I20260812 08:04:06.547442 17463 fs_manager.cc:1068] Generated new instance metadata in path /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/ts-0-root/instance:
uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.548992 17463 fs_manager.cc:696] Time spent creating directory manager: real 0.001s	user 0.002s	sys 0.000s
I20260812 08:04:06.550058 17884 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:04:06.550328 17463 fs_manager.cc:730] Time spent opening block manager: real 0.001s	user 0.000s	sys 0.000s
I20260812 08:04:06.550393 17463 fs_manager.cc:647] Opened local filesystem: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/ts-0-root
uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03"
format_stamp: "Formatted at 2026-08-12 08:04:06 on dist-test-slave-gkw7"
I20260812 08:04:06.550483 17463 fs_report.cc:389] FS layout report
--------------------
wal directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/ts-0-root
metadata directory: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-0/minicluster-data/ts-0-root
1 data directories: /tmp/dist-test-taskxhKgMh/test-tmp/rpc_line_item_dao-test.0.RpcLineItemDAOTest.TestUpdate.1786521846115509-17463-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 08:04:06.563470 17463 rpc_server.cc:225] running with OpenSSL 1.1.1  11 Sep 2018
I20260812 08:04:06.563905 17463 kserver.cc:163] Server-wide thread pool size limit: 3276
I20260812 08:04:06.564239 17463 txn_system_client.cc:432] TxnSystemClient initialization is disabled...
I20260812 08:04:06.564729 17463 ts_tablet_manager.cc:585] Loaded tablet metadata (0 total tablets, 0 live tablets)
I20260812 08:04:06.564767 17463 ts_tablet_manager.cc:531] Time spent load tablet metadata: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:04:06.564826 17463 ts_tablet_manager.cc:616] Registered 0 tablets
I20260812 08:04:06.564862 17463 ts_tablet_manager.cc:595] Time spent register tablets: real 0.000s	user 0.000s	sys 0.000s
I20260812 08:04:06.570593 17463 rpc_server.cc:307] RPC server started. Bound to: 127.17.13.193:46739
I20260812 08:04:06.570623 17976 acceptor_pool.cc:272] collecting diagnostics on the listening RPC socket 127.17.13.193:46739 every 8 connection(s)
I20260812 08:04:06.576033 17978 heartbeater.cc:344] Connected to a master server at 127.17.13.254:44983
I20260812 08:04:06.576134 17978 heartbeater.cc:461] Registering TS with master...
I20260812 08:04:06.576388 17978 heartbeater.cc:507] Master 127.17.13.254:44983 requested a full tablet report, sending...
I20260812 08:04:06.577087 17782 ts_manager.cc:194] Registered new tserver with Master: 4ad3e8ceb0fd47bf8969a6fb469c0f03 (127.17.13.193:46739)
I20260812 08:04:06.577752 17463 internal_mini_cluster.cc:371] 1 TS(s) registered with all masters after 0.006673463s
I20260812 08:04:06.577950 17782 master_service.cc:502] Signed X509 certificate for tserver {username='slave'} at 127.0.0.1:38798
I20260812 08:04:06.586351 17782 catalog_manager.cc:2283] Servicing CreateTable request from {username='slave'} at 127.0.0.1:38810:
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 08:04:06.596675 17928 tablet_service.cc:1511] Processing CreateTablet for tablet 9e7f60f39398484ab747e989ef229d89 (DEFAULT_TABLE table=tpch1 [id=a2ab40f6d4c84004ae9c65118778a88d]), partition=RANGE (l_orderkey, l_linenumber) PARTITION UNBOUNDED
I20260812 08:04:06.597011 17928 data_dirs.cc:400] Could only allocate 1 dirs of requested 3 for tablet 9e7f60f39398484ab747e989ef229d89. 1 dirs total, 0 dirs full, 0 dirs failed
I20260812 08:04:06.599298 18000 tablet_bootstrap.cc:492] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: Bootstrap starting.
I20260812 08:04:06.600150 18000 tablet_bootstrap.cc:654] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: Neither blocks nor log segments found. Creating new log.
I20260812 08:04:06.601368 18000 tablet_bootstrap.cc:492] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: No bootstrap required, opened a new log
I20260812 08:04:06.601481 18000 ts_tablet_manager.cc:1403] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: Time spent bootstrapping tablet: real 0.002s	user 0.001s	sys 0.000s
I20260812 08:04:06.601996 18000 raft_consensus.cc:359] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Replica starting. Triggering 0 pending ops. Active config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 46739 } }
I20260812 08:04:06.602113 18000 raft_consensus.cc:385] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Consensus starting up: Expiring failure detector timer to make a prompt election more likely
I20260812 08:04:06.602159 18000 raft_consensus.cc:740] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Becoming Follower/Learner. State: Replica: 4ad3e8ceb0fd47bf8969a6fb469c0f03, State: Initialized, Role: FOLLOWER
I20260812 08:04:06.602309 18000 consensus_queue.cc:260] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [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: "4ad3e8ceb0fd47bf8969a6fb469c0f03" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 46739 } }
I20260812 08:04:06.602402 18000 raft_consensus.cc:399] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Only one voter in the Raft config. Triggering election immediately
I20260812 08:04:06.602447 18000 raft_consensus.cc:493] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Starting leader election (initial election of a single-replica configuration)
I20260812 08:04:06.602501 18000 raft_consensus.cc:3060] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 0 FOLLOWER]: Advancing to term 1
I20260812 08:04:06.603199 18000 raft_consensus.cc:515] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 1 FOLLOWER]: Starting leader election with config: opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 46739 } }
I20260812 08:04:06.603367 18000 leader_election.cc:304] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [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: 4ad3e8ceb0fd47bf8969a6fb469c0f03; no voters: 
I20260812 08:04:06.603610 18000 leader_election.cc:290] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [CANDIDATE]: Term 1 election: Requested vote from peers 
I20260812 08:04:06.603695 18004 raft_consensus.cc:2804] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 1 FOLLOWER]: Leader election won for term 1
I20260812 08:04:06.603890 18004 raft_consensus.cc:697] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 1 LEADER]: Becoming Leader. State: Replica: 4ad3e8ceb0fd47bf8969a6fb469c0f03, State: Running, Role: LEADER
I20260812 08:04:06.603963 18000 ts_tablet_manager.cc:1434] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: Time spent starting tablet: real 0.002s	user 0.002s	sys 0.000s
I20260812 08:04:06.604034 18004 consensus_queue.cc:237] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [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: "4ad3e8ceb0fd47bf8969a6fb469c0f03" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 46739 } }
I20260812 08:04:06.604089 17978 heartbeater.cc:499] Master 127.17.13.254:44983 was elected leader, sending a full tablet report...
I20260812 08:04:06.605434 17780 catalog_manager.cc:5719] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 reported cstate change: term changed from 0 to 1, leader changed from <none> to 4ad3e8ceb0fd47bf8969a6fb469c0f03 (127.17.13.193). New cstate: current_term: 1 leader_uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03" committed_config { opid_index: -1 OBSOLETE_local: true peers { permanent_uuid: "4ad3e8ceb0fd47bf8969a6fb469c0f03" member_type: VOTER last_known_addr { host: "127.17.13.193" port: 46739 } health_report { overall_health: HEALTHY } } }
I20260812 08:04:06.625656 17463 tablet_server.cc:179] TabletServer@127.17.13.193:0 shutting down...
I20260812 08:04:06.629485 17463 ts_tablet_manager.cc:1507] Shutting down tablet manager...
I20260812 08:04:06.629810 17463 tablet_replica.cc:333] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03: stopping tablet replica
I20260812 08:04:06.629940 17463 raft_consensus.cc:2243] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 1 LEADER]: Raft consensus shutting down.
I20260812 08:04:06.630077 17463 raft_consensus.cc:2272] T 9e7f60f39398484ab747e989ef229d89 P 4ad3e8ceb0fd47bf8969a6fb469c0f03 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 08:04:06.633148 17463 tablet_server.cc:196] TabletServer@127.17.13.193:0 shutdown complete.
I20260812 08:04:06.635205 17463 master.cc:562] Master@127.17.13.254:44983 shutting down...
I20260812 08:04:06.639797 17463 raft_consensus.cc:2243] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 1 LEADER]: Raft consensus shutting down.
I20260812 08:04:06.639984 17463 raft_consensus.cc:2272] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8 [term 1 FOLLOWER]: Raft consensus is shut down!
I20260812 08:04:06.640121 17463 tablet_replica.cc:333] T 00000000000000000000000000000000 P f912c30ff12742d4bc01dd8b6d27fbd8: stopping tablet replica
I20260812 08:04:06.653465 17463 master.cc:584] Master@127.17.13.254:44983 shutdown complete.
[       OK ] RpcLineItemDAOTest.TestUpdate (183 ms)
[----------] 2 tests from RpcLineItemDAOTest (534 ms total)

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