2025-12-12T12:00:24.899667Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: try to update token
2025-12-12T12:00:24.899854Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Start write session. Will connect to nodeId: 0
2025-12-12T12:00:24.900117Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: try to update token
2025-12-12T12:00:24.900123Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: write to message_group: test-message_group_id
2025-12-12T12:00:24.900132Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Start write session. Will connect to nodeId: 0
2025-12-12T12:00:24.900168Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: send init request: init_request { path: "sdk_tests/TxUsageTable-DirectRead_WriteToTopic_Two_WriteSession/topic_A" message_group_id: "test-message_group_id" }
2025-12-12T12:00:24.900356Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: write to message_group: test-message_group_id
2025-12-12T12:00:24.900372Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: OnWriteDone gRpcStatusCode: 0
2025-12-12T12:00:24.900387Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: send init request: init_request { path: "sdk_tests/TxUsageTable-DirectRead_WriteToTopic_Two_WriteSession/topic_B" message_group_id: "test-message_group_id" }
2025-12-12T12:00:24.900486Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: OnWriteDone gRpcStatusCode: 0
2025-12-12T12:00:24.907563Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.907590Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1765540824907 BytesWritten: 0 MessagesWritten: 0 BytesWrittenCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:00:24.907627Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session established. Init response: session_id: "test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0"
2025-12-12T12:00:24.907634Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  MessageGroupId [test-message_group_id] Write session: set DirectWriteToPartitionId 0
2025-12-12T12:00:24.907675Z :DEBUG: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.907699Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [0] Get partition location async, partition 0, delay 0.000000s
2025-12-12T12:00:24.907692Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1765540824907 BytesWritten: 0 MessagesWritten: 0 BytesWrittenCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:00:24.907727Z :INFO: [local]  TraceId []  SessionId []  MessageGroupId [test-message_group_id] Write session established. Init response: session_id: "test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0"
2025-12-12T12:00:24.907731Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  MessageGroupId [test-message_group_id] Write session: set DirectWriteToPartitionId 0
2025-12-12T12:00:24.907755Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [0] Get partition location async, partition 0, delay 0.000000s
2025-12-12T12:00:24.907776Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [0]  Getting partition location, partition 0
2025-12-12T12:00:24.907934Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [0]  Getting partition location, partition 0
2025-12-12T12:00:24.909349Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [0] Got PartitionLocation response. Status SUCCESS, proto:
partition {
  active: true
  partition_location {
    node_id: 1
    generation: 1
  }
}
2025-12-12T12:00:24.909367Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [0] GetPreferredEndpoint: partitionId 0, partitionNodeId 1 exists in the endpoint pool.
2025-12-12T12:00:24.909366Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [0] Got PartitionLocation response. Status SUCCESS, proto:
partition {
  active: true
  partition_location {
    node_id: 1
    generation: 1
  }
}
2025-12-12T12:00:24.909373Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Start write session. Will connect to nodeId: 1
2025-12-12T12:00:24.909380Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [0] GetPreferredEndpoint: partitionId 0, partitionNodeId 1 exists in the endpoint pool.
2025-12-12T12:00:24.909385Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Start write session. Will connect to nodeId: 1
2025-12-12T12:00:24.909653Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 1, Msg: CANCELLED, Details: , InternalError: 0
2025-12-12T12:00:24.909676Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 1, Msg: CANCELLED, Details: , InternalError: 0
2025-12-12T12:00:24.909750Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session: direct write to partition: 0, generation 1
2025-12-12T12:00:24.909767Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session: direct write to partition: 0, generation 1
2025-12-12T12:00:24.909777Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session: send init request: init_request { path: "sdk_tests/TxUsageTable-DirectRead_WriteToTopic_Two_WriteSession/topic_A" partition_with_generation { generation: 1 } }
2025-12-12T12:00:24.909787Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session: send init request: init_request { path: "sdk_tests/TxUsageTable-DirectRead_WriteToTopic_Two_WriteSession/topic_B" partition_with_generation { generation: 1 } }
2025-12-12T12:00:24.909872Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session: OnWriteDone gRpcStatusCode: 0
2025-12-12T12:00:24.909930Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session: OnWriteDone gRpcStatusCode: 0
2025-12-12T12:00:24.911184Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.911197Z :DEBUG: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.911212Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|175c40df-bd675a68-df789c7e-7ae4377_0]  PartitionId [0]  Generation [1] Write session established. Init response: session_id: "a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0"
2025-12-12T12:00:24.911213Z :INFO: [local]  TraceId []  SessionId [test-message_group_id|ff3c1413-c1867b7-b4fb4da4-a8f0ca31_0]  PartitionId [0]  Generation [1] Write session established. Init response: session_id: "f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0"
2025-12-12T12:00:24.911223Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: set DirectWriteToPartitionId 0
2025-12-12T12:00:24.911226Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: set DirectWriteToPartitionId 0
2025-12-12T12:00:24.911283Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] OnWrite: seqNo=1, txId={ydb://session/3?node_id=1&id=ZjVkYmM2NGEtODI4ODJkZjAtZTVjZDYzMDMtYjhmNDBlNTY=, 01kc96y1t3257dde2n9rw3aybq}, WriteCount=1, AckCount=0
2025-12-12T12:00:24.911298Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write 1 messages with Id from 1 to 1
2025-12-12T12:00:24.911341Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] OnWrite: seqNo=1, txId={ydb://session/3?node_id=1&id=ZjVkYmM2NGEtODI4ODJkZjAtZTVjZDYzMDMtYjhmNDBlNTY=, 01kc96y1t3257dde2n9rw3aybq}, WriteCount=1, AckCount=0
2025-12-12T12:00:24.911376Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write 1 messages with Id from 1 to 1
2025-12-12T12:00:24.911506Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: try to update token
2025-12-12T12:00:24.911519Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Send 1 message(s) (0 left), first sequence number is 1
2025-12-12T12:00:24.911590Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: try to update token
2025-12-12T12:00:24.911610Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Send 1 message(s) (0 left), first sequence number is 1
2025-12-12T12:00:24.915459Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.915600Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session got write response: acks { seq_no: 1 written_in_tx { } } write_statistics { persisting_time { nanos: 1000000 } min_queue_wait_time { } max_queue_wait_time { } partition_quota_wait_time { } topic_quota_wait_time { } }
2025-12-12T12:00:24.915613Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] OnAck: seqNo=1, txId={ydb://session/3?node_id=1&id=ZjVkYmM2NGEtODI4ODJkZjAtZTVjZDYzMDMtYjhmNDBlNTY=, 01kc96y1t3257dde2n9rw3aybq}, WriteCount=1, AckCount=1
2025-12-12T12:00:24.915617Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: acknoledged message 1
2025-12-12T12:00:24.921489Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: OnReadDone gRpcStatusCode: 0
2025-12-12T12:00:24.921529Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session got write response: acks { seq_no: 1 written_in_tx { } } write_statistics { persisting_time { nanos: 1000000 } min_queue_wait_time { nanos: 1000000 } max_queue_wait_time { nanos: 1000000 } partition_quota_wait_time { } topic_quota_wait_time { } }
2025-12-12T12:00:24.921537Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] OnAck: seqNo=1, txId={ydb://session/3?node_id=1&id=ZjVkYmM2NGEtODI4ODJkZjAtZTVjZDYzMDMtYjhmNDBlNTY=, 01kc96y1t3257dde2n9rw3aybq}, WriteCount=1, AckCount=1
2025-12-12T12:00:24.921540Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: acknoledged message 1
2025-12-12T12:00:24.931607Z :INFO: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: close. Timeout 0.000000s
2025-12-12T12:00:24.931627Z :INFO: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session will now close
2025-12-12T12:00:24.931636Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: aborting
2025-12-12T12:00:24.931874Z :INFO: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: gracefully shut down, all writes complete
2025-12-12T12:00:24.931880Z :DEBUG: [local]  TraceId []  SessionId [f30167f3-3a3a79d7-98e599df-446325c3|1ab51e15-b68e8b40-7627d86f-928f7714_0]  PartitionId [0]  Generation [1] Write session: destroy
2025-12-12T12:00:24.931906Z :INFO: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: close. Timeout 0.000000s
2025-12-12T12:00:24.931909Z :INFO: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session will now close
2025-12-12T12:00:24.931913Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: aborting
2025-12-12T12:00:24.931972Z :INFO: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: gracefully shut down, all writes complete
2025-12-12T12:00:24.931976Z :DEBUG: [local]  TraceId []  SessionId [a625cdad-7d0185df-43699ca0-160ba3f7|1dee7793-d6cd261d-aaa34f54-46ced8fa_0]  PartitionId [0]  Generation [1] Write session: destroy
