2025-12-12T11:56:53.878852Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [0] Write session: try to update token
2025-12-12T11:56:53.879093Z :INFO: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [0] Get partition location async, partition 0, delay 0.000000s
2025-12-12T11:56:53.879129Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [0]  Getting partition location, partition 0
2025-12-12T11:56:53.880708Z :INFO: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [0] Got PartitionLocation response. Status SUCCESS, proto:
partition {
  active: true
  partition_location {
    node_id: 1
    generation: 1
  }
}
2025-12-12T11:56:53.880739Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [0] GetPreferredEndpoint: partitionId 0, partitionNodeId 1 exists in the endpoint pool.
2025-12-12T11:56:53.880746Z :INFO: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Start write session. Will connect to nodeId: 1
2025-12-12T11:56:53.880997Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Write session: direct write to partition: 0, generation 1
2025-12-12T11:56:53.881050Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Write session: send init request: init_request { path: "sdk_tests/TxUsageTable-DirectRead_WriteToTopic_Demo_31/topic_A" producer_id: "test-message_group_id" partition_with_generation { generation: 1 } }
2025-12-12T11:56:53.881155Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Write session: OnWriteDone gRpcStatusCode: 0
2025-12-12T11:56:53.887586Z :DEBUG: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T11:56:53.887613Z :INFO: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1765540613887 BytesWritten: 0 MessagesWritten: 0 BytesWrittenCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T11:56:53.887649Z :INFO: [local]  TraceId []  SessionId []  PartitionId [0]  Generation [1] Write session established. Init response: session_id: "test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0"
2025-12-12T11:56:53.887734Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnWrite: seqNo=1, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qkqm9v67wgd7bf1wwenj}, WriteCount=1, AckCount=0
2025-12-12T11:56:53.889037Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write 1 messages with Id from 1 to 1
2025-12-12T11:56:53.897731Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: try to update token
2025-12-12T11:56:53.897760Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Send 1 message(s) (0 left), first sequence number is 1
2025-12-12T11:56:53.927912Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T11:56:53.927987Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session got write response: acks { seq_no: 1 written_in_tx { } } write_statistics { persisting_time { nanos: 12000000 } min_queue_wait_time { } max_queue_wait_time { } partition_quota_wait_time { } topic_quota_wait_time { } }
2025-12-12T11:56:53.928012Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnAck: seqNo=1, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qkqm9v67wgd7bf1wwenj}, WriteCount=1, AckCount=1
2025-12-12T11:56:53.928294Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: acknoledged message 1
2025-12-12T11:56:53.941786Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnWrite: seqNo=2, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qksm4568jwzv17v1xef3}, WriteCount=1, AckCount=0
2025-12-12T11:56:53.942528Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write 1 messages with Id from 2 to 2
2025-12-12T11:56:53.944124Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: try to update token
2025-12-12T11:56:53.944139Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Send 1 message(s) (0 left), first sequence number is 2
2025-12-12T11:56:53.947347Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnWrite: seqNo=3, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qksm4568jwzv17v1xef3}, WriteCount=2, AckCount=0
2025-12-12T11:56:53.947375Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write 1 messages with Id from 3 to 3
2025-12-12T11:56:53.947401Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: try to update token
2025-12-12T11:56:53.947408Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Send 1 message(s) (0 left), first sequence number is 3
2025-12-12T11:56:53.981582Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T11:56:53.981657Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session got write response: acks { seq_no: 2 written_in_tx { } } write_statistics { persisting_time { nanos: 14000000 } min_queue_wait_time { } max_queue_wait_time { } partition_quota_wait_time { } topic_quota_wait_time { } }
2025-12-12T11:56:53.981686Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnAck: seqNo=2, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qksm4568jwzv17v1xef3}, WriteCount=2, AckCount=1
2025-12-12T11:56:53.981692Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: acknoledged message 2
2025-12-12T11:56:53.982831Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T11:56:53.982898Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session got write response: acks { seq_no: 3 written_in_tx { } } write_statistics { persisting_time { nanos: 2000000 } min_queue_wait_time { nanos: 9000000 } max_queue_wait_time { nanos: 9000000 } partition_quota_wait_time { } topic_quota_wait_time { } }
2025-12-12T11:56:53.982909Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] OnAck: seqNo=3, txId={ydb://session/3?node_id=1&id=MWVhMWIzZGMtOGIzMzVlZTQtZmI5YmY1ZGItNTBhYjEyNDY=, 01kc96qksm4568jwzv17v1xef3}, WriteCount=2, AckCount=2
2025-12-12T11:56:53.983230Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: acknoledged message 3
2025-12-12T11:56:53.985241Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: close. Timeout 0.000000s
2025-12-12T11:56:53.985256Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session will now close
2025-12-12T11:56:53.985264Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: aborting
2025-12-12T11:56:53.985430Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: gracefully shut down, all writes complete
2025-12-12T11:56:53.985438Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|8f0c4bc3-e83f7047-d3aaefd5-5c6b5e06_0]  PartitionId [0]  Generation [1] Write session: destroy
