2025-12-12 12:27:06,507 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 12:27:06,507 - INFO - ya.test - pytest_runtest_setup: test_redistribute_partition_after_timeout
2025-12-12 12:27:06,508 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 12:27:06,508 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-12 12:27:06,509 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/32371
2025-12-12 12:27:06,511 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2786
2025-12-12 12:27:06,570 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:06,571 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26927
2025-12-12 12:27:06,632 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:06,633 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16927
2025-12-12 12:27:06,633 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27717
2025-12-12 12:27:06,634 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64479
2025-12-12 12:27:06,635 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26637
2025-12-12 12:27:06,635 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-12 12:27:06,640 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-12 12:27:06,640 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-12 12:27:06,649 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local
2025-12-12 12:27:06,650 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, b4cc184b-37ff-456c-a813-13d53b1610f5, localhost:8973): creating call state
2025-12-12 12:27:06,651 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, b4cc184b-37ff-456c-a813-13d53b1610f5, localhost:8973): request = { database: "local" }
2025-12-12 12:27:06,656 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, b4cc184b-37ff-456c-a813-13d53b1610f5, localhost:8973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-fhkyrtz6p4.auto.internal" port: 8973 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-12-12 12:27:06,657 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-fhkyrtz6p4.auto.internal:8973, location 1, ssl: False>]>
2025-12-12 12:27:06,657 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-12-12 12:27:06,666 - INFO - ydb.connection - close: Closing channel for endpoint localhost:8973
2025-12-12 12:27:06,667 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-12-12 12:27:06,668 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fa7a0842f40 state=pending>
2025-12-12 12:27:06,668 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-12-12 12:27:06,669 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,669 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,670 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ef4797d1-2170-4fe7-9fc0-fb0d7faf4a5a, ghrun-fhkyrtz6p4.auto.internal:8973): creating call state
2025-12-12 12:27:06,670 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ef4797d1-2170-4fe7-9fc0-fb0d7faf4a5a, ghrun-fhkyrtz6p4.auto.internal:8973): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-12-12 12:27:06,677 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, ef4797d1-2170-4fe7-9fc0-fb0d7faf4a5a, ghrun-fhkyrtz6p4.auto.internal:8973): on response callback started
2025-12-12 12:27:06,678 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ef4797d1-2170-4fe7-9fc0-fb0d7faf4a5a, ghrun-fhkyrtz6p4.auto.internal:8973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=OTU5YjAwMGUtYjhiMTRmMGMtM2QzYjc5OGMtNTAwZjE4MDc=" } } } }
2025-12-12 12:27:06,678 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,679 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,679 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, ef4797d1-2170-4fe7-9fc0-fb0d7faf4a5a, ghrun-fhkyrtz6p4.auto.internal:8973): on response callback success
2025-12-12 12:27:06,680 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, b0d4a1fb-f5ea-402f-901a-4b1419e65309, ghrun-fhkyrtz6p4.auto.internal:8973): creating call state
2025-12-12 12:27:06,681 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, b0d4a1fb-f5ea-402f-901a-4b1419e65309, ghrun-fhkyrtz6p4.auto.internal:8973): request = { session_id: "ydb://session/3?node_id=1&id=OTU5YjAwMGUtYjhiMTRmMGMtM2QzYjc5OGMtNTAwZjE4MDc=" path: "local/DbPoolStorage_6542be6b-ada7-47c8-bf58-c45032d025fa/tenants" columns { name: "tenant" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "common" type { optional_type { item { type_id: BOOL } } } } columns { name: "state" type { optional_type { item { type_id: UINT32 } } } } columns { name: "state_time" type { optional_type { item { type_id: TIMESTAMP } } } } primary_key: "tenant" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 12:27:06,726 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, b0d4a1fb-f5ea-402f-901a-4b1419e65309, ghrun-fhkyrtz6p4.auto.internal:8973): response = { operation { ready: true status: SUCCESS } }
2025-12-12 12:27:06,726 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,727 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, bc736e47-0db6-4e36-8cec-ea95cb98657d, ghrun-fhkyrtz6p4.auto.internal:8973): creating call state
2025-12-12 12:27:06,728 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, bc736e47-0db6-4e36-8cec-ea95cb98657d, ghrun-fhkyrtz6p4.auto.internal:8973): request = { session_id: "ydb://session/3?node_id=1&id=OTU5YjAwMGUtYjhiMTRmMGMtM2QzYjc5OGMtNTAwZjE4MDc=" path: "local/DbPoolStorage_6542be6b-ada7-47c8-bf58-c45032d025fa/mappings" columns { name: "subject_type" type { optional_type { item { type_id: STRING } } } } columns { name: "subject_id" type { optional_type { item { type_id: STRING } } } } columns { name: "vtenant" type { optional_type { item { type_id: STRING } } } } columns { name: "node" type { optional_type { item { type_id: STRING } } } } primary_key: "subject_type" primary_key: "subject_id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 12:27:06,744 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, bc736e47-0db6-4e36-8cec-ea95cb98657d, ghrun-fhkyrtz6p4.auto.internal:8973): response = { operation { ready: true status: SUCCESS } }
2025-12-12 12:27:06,745 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,746 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 5e9d72e1-eaf3-4f1d-8d73-61484ac06dc6, ghrun-fhkyrtz6p4.auto.internal:8973): creating call state
2025-12-12 12:27:06,746 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 5e9d72e1-eaf3-4f1d-8d73-61484ac06dc6, ghrun-fhkyrtz6p4.auto.internal:8973): request = { session_id: "ydb://session/3?node_id=1&id=OTU5YjAwMGUtYjhiMTRmMGMtM2QzYjc5OGMtNTAwZjE4MDc=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\n            PRAGMA TablePathPrefix(\"local/DbPoolStorage_6542be6b-ada7-47c8-bf58-c45032d025fa\");\n            UPSERT INTO tenants (tenant, vtenant, common, state, state_time) values(\"/compute\", \"/compute\", true, 0, CurrentUtcTimestamp());\n                " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-12-12 12:27:06,836 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 5e9d72e1-eaf3-4f1d-8d73-61484ac06dc6, ghrun-fhkyrtz6p4.auto.internal:8973): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-12-12 12:27:06,836 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fa7a0841b90>
2025-12-12 12:27:06,900 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:06,902 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12873
2025-12-12 12:27:06,902 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4257
2025-12-12 12:27:06,902 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4257
2025-12-12 12:27:06,903 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4258
2025-12-12 12:27:06,904 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16607
2025-12-12 12:27:06,905 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/kikimr_configs"
2025-12-12 12:27:06,905 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/cp --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/node_1/logfile_qdtp0j6u.log --grpc-port=26637 --mon-port=12873 --ic-port=26927
2025-12-12 12:27:06,906 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/kikimr_configs"
2025-12-12 12:27:06,906 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/cp --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/node_1/logfile_qdtp0j6u.log --grpc-port=26637 --mon-port=12873 --ic-port=26927
2025-12-12 12:27:06,907 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/kikimr_configs/config.yaml', '--node=1', '--tenant=/cp', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/node_1/logfile_qdtp0j6u.log', '--grpc-port=26637', '--mon-port=12873', '--ic-port=26927')' in '/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/cp/node_1' (no wait)
2025-12-12 12:27:06,909 - DEBUG - ya.test - execute: Command pid: 1196529
2025-12-12 12:27:06,911 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:26637/1
2025-12-12 12:27:06,913 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-12 12:27:06,914 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-12 12:27:06,914 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-12 12:27:06,915 - DEBUG - ya.test - execute: Command pid: 1196530
2025-12-12 12:27:07,475 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) rc: 0
2025-12-12 12:27:07,476 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) elapsed time (sec): 0.5592644214630127
2025-12-12 12:27:07,477 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) idrss: 0
2025-12-12 12:27:07,477 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) inblock: 0
2025-12-12 12:27:07,477 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) isrss: 0
2025-12-12 12:27:07,477 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) ixrss: 0
2025-12-12 12:27:07,478 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) majflt: 0
2025-12-12 12:27:07,479 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) maxrss: 544132
2025-12-12 12:27:07,479 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) minflt: 16225
2025-12-12 12:27:07,481 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) msgrcv: 0
2025-12-12 12:27:07,483 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) msgsnd: 0
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) nivcsw: 88
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) nsignals: 0
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) nswap: 0
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) nvcsw: 15
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) oublock: 8
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) stime: 0.294182
2025-12-12 12:27:07,484 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) utime: 0.11307199999999999
2025-12-12 12:27:07,485 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) wtime: 0.561
2025-12-12 12:27:07,485 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) output:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fhkyrtz6p4
    Host information: 
        Linux ghrun-fhkyrtz6p4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-12 12:27:07,485 - DEBUG - ya.test - _save_outputs: Command (pid 1196530) errors:

2025-12-12 12:27:07,486 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd
2025-12-12 12:27:07,486 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-12 12:27:07,542 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:07,543 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8637
2025-12-12 12:27:07,543 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64423
2025-12-12 12:27:07,544 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2597
2025-12-12 12:27:07,545 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19304
2025-12-12 12:27:07,545 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:07,546 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_1/logfile_ekzi155c.log --grpc-port=8637 --mon-port=64423 --ic-port=16927
2025-12-12 12:27:07,546 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:07,547 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11545
2025-12-12 12:27:07,547 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27335
2025-12-12 12:27:07,548 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21052
2025-12-12 12:27:07,548 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5332
2025-12-12 12:27:07,549 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:07,551 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=2 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_2/logfile_nn2p_rau.log --grpc-port=11545 --mon-port=27335 --ic-port=27717
2025-12-12 12:27:07,551 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd
2025-12-12 12:27:07,552 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5594
2025-12-12 12:27:07,552 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64080
2025-12-12 12:27:07,552 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30755
2025-12-12 12:27:07,553 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18725
2025-12-12 12:27:07,554 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:07,555 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=3 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_3/logfile_u241byk2.log --grpc-port=5594 --mon-port=64080 --ic-port=64479
2025-12-12 12:27:07,555 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:07,555 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_1/logfile_ekzi155c.log --grpc-port=8637 --mon-port=64423 --ic-port=16927
2025-12-12 12:27:07,556 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs/config.yaml', '--node=1', '--tenant=/compute', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_1/logfile_ekzi155c.log', '--grpc-port=8637', '--mon-port=64423', '--ic-port=16927')' in '/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_1' (no wait)
2025-12-12 12:27:07,567 - DEBUG - ya.test - execute: Command pid: 1196937
2025-12-12 12:27:07,568 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:8637/1
2025-12-12 12:27:07,570 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-12 12:27:07,570 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-12 12:27:07,571 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-12 12:27:07,574 - DEBUG - ya.test - execute: Command pid: 1196938
2025-12-12 12:27:08,019 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) rc: 0
2025-12-12 12:27:08,019 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) elapsed time (sec): 0.4440159797668457
2025-12-12 12:27:08,020 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) idrss: 0
2025-12-12 12:27:08,020 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) inblock: 0
2025-12-12 12:27:08,023 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) isrss: 0
2025-12-12 12:27:08,023 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) ixrss: 0
2025-12-12 12:27:08,024 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) majflt: 0
2025-12-12 12:27:08,024 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) maxrss: 544132
2025-12-12 12:27:08,024 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) minflt: 18314
2025-12-12 12:27:08,025 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) msgrcv: 0
2025-12-12 12:27:08,025 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) msgsnd: 0
2025-12-12 12:27:08,025 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) nivcsw: 41
2025-12-12 12:27:08,025 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) nsignals: 0
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) nswap: 0
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) nvcsw: 29
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) oublock: 8
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) stime: 0.27699999999999997
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) utime: 0.11405799999999999
2025-12-12 12:27:08,026 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) wtime: 0.448
2025-12-12 12:27:08,027 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) output:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fhkyrtz6p4
    Host information: 
        Linux ghrun-fhkyrtz6p4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-12 12:27:08,027 - DEBUG - ya.test - _save_outputs: Command (pid 1196938) errors:

2025-12-12 12:27:08,027 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd
2025-12-12 12:27:08,028 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:08,028 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=2 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_2/logfile_nn2p_rau.log --grpc-port=11545 --mon-port=27335 --ic-port=27717
2025-12-12 12:27:08,029 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs/config.yaml', '--node=2', '--tenant=/compute', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_2/logfile_nn2p_rau.log', '--grpc-port=11545', '--mon-port=27335', '--ic-port=27717')' in '/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_2' (no wait)
2025-12-12 12:27:08,031 - DEBUG - ya.test - execute: Command pid: 1197274
2025-12-12 12:27:08,032 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11545/2
2025-12-12 12:27:08,034 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-12 12:27:08,035 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-12 12:27:08,036 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-12 12:27:08,040 - DEBUG - ya.test - execute: Command pid: 1197275
2025-12-12 12:27:08,524 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) rc: 0
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) elapsed time (sec): 0.4828970432281494
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) idrss: 0
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) inblock: 0
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) isrss: 0
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) ixrss: 0
2025-12-12 12:27:08,525 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) majflt: 1
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) maxrss: 544132
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) minflt: 16811
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) msgrcv: 0
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) msgsnd: 0
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) nivcsw: 58
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) nsignals: 0
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) nswap: 0
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) nvcsw: 22
2025-12-12 12:27:08,526 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) oublock: 8
2025-12-12 12:27:08,527 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) stime: 0.29839699999999997
2025-12-12 12:27:08,527 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) utime: 0.12232699999999999
2025-12-12 12:27:08,527 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) wtime: 0.485
2025-12-12 12:27:08,527 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) output:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fhkyrtz6p4
    Host information: 
        Linux ghrun-fhkyrtz6p4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-12 12:27:08,527 - DEBUG - ya.test - _save_outputs: Command (pid 1197275) errors:

2025-12-12 12:27:08,528 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 2 version:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd
2025-12-12 12:27:08,528 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs"
2025-12-12 12:27:08,528 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=3 --tenant=/compute --node-kind=yq --log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_3/logfile_u241byk2.log --grpc-port=5594 --mon-port=64080 --ic-port=64479
2025-12-12 12:27:08,535 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/kikimr_configs/config.yaml', '--node=3', '--tenant=/compute', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_3/logfile_u241byk2.log', '--grpc-port=5594', '--mon-port=64080', '--ic-port=64479')' in '/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk25/testing_out_stuff/test_row_dispatcher.py.TestPqRowDispatcher.test_redistribute_partition_after_timeout/compute/node_3' (no wait)
2025-12-12 12:27:08,537 - DEBUG - ya.test - execute: Command pid: 1197660
2025-12-12 12:27:08,538 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:5594/3
2025-12-12 12:27:08,539 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-12 12:27:08,539 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-12 12:27:08,539 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-12 12:27:08,540 - DEBUG - ya.test - execute: Command pid: 1197662
2025-12-12 12:27:09,070 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) rc: 0
2025-12-12 12:27:09,070 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) elapsed time (sec): 0.528343677520752
2025-12-12 12:27:09,070 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) idrss: 0
2025-12-12 12:27:09,070 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) inblock: 0
2025-12-12 12:27:09,070 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) isrss: 0
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) ixrss: 0
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) majflt: 0
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) maxrss: 544132
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) minflt: 20096
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) msgrcv: 0
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) msgsnd: 0
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) nivcsw: 49
2025-12-12 12:27:09,071 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) nsignals: 0
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) nswap: 0
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) nvcsw: 20
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) oublock: 8
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) stime: 0.369666
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) utime: 0.100643
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) wtime: 0.529
2025-12-12 12:27:09,072 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) output:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-fhkyrtz6p4
    Host information: 
        Linux ghrun-fhkyrtz6p4 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-12-12 12:27:09,073 - DEBUG - ya.test - _save_outputs: Command (pid 1197662) errors:

2025-12-12 12:27:09,073 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 3 version:
Git info:
    Commit: 88a034dc314301cb1522a933e690a4c49a7591e8
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge d62cc36f2a67bf2623cab6896138afad639d0fda into fb388c48b29255ca141e58bbb8dfa4a39842f4bd
2025-12-12 12:27:09,073 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-12 12:27:09,079 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_row_dispatcher.py::TestPqRowDispatcher, test_name: test_redistribute_partition_after_timeout)
2025-12-12 12:27:09,514 - DEBUG - root - create_stream: Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/redistribute_input"
shard_count: 3
write_quota_kb_per_sec: 1024
retention_period_hours: 1

2025-12-12 12:27:09,556 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-12 12:27:09,556 - DEBUG - root - _get_and_check_result: Result: 
2025-12-12 12:27:09,558 - DEBUG - root - create_stream: Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/redistribute_output"
shard_count: 3
write_quota_kb_per_sec: 1024
retention_period_hours: 1

2025-12-12 12:27:09,588 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-12 12:27:09,589 - DEBUG - root - _get_and_check_result: Result: 
2025-12-12 12:27:09,607 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-12 12:27:09,607 - DEBUG - root - _get_and_check_result: Result: 
2025-12-12 12:27:15,738 - DEBUG - root - create_query_impl: Request: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            PRAGMA dq.Scheduler=@@{\"type\": \"single_node\"}@@;\n            INSERT INTO yds.`redistribute_output`\n            SELECT data FROM yds.`redistribute_input`\n                WITH (format=json_each_row, SCHEMA (time Int32 NOT NULL, data String NOT NULL));"
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "b2ad3eac-e268-43cb-9688-76dfaf24a963"

2025-12-12 12:27:15,978 - DEBUG - root - create_query_impl: Result: query_id: "ptqudq7uf4g3a86uj0fu"

2025-12-12 12:27:16,050 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7uf4g3a86uj0fu"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765542435
        nanos: 746421000
      }
      modified_at {
        seconds: 1765542435
        nanos: 746421000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudq7uf4g39kndm5a5-ptqudq7uf4g3a86uj0fu"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765542435
      nanos: 746421000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            PRAGMA dq.Scheduler=@@{\"type\": \"single_node\"}@@;\n            INSERT INTO yds.`redistribute_output`\n            SELECT data FROM yds.`redistribute_input`\n                WITH (format=json_each_row, SCHEMA (time Int32 NOT NULL, data String NOT NULL));"
    syntax: YQL_V1
  }
}

2025-12-12 12:27:16,587 - DEBUG - root - describe_query: Result: ... (repeated, see above) ...
2025-12-12 12:27:17,107 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudq7uf4g3a86uj0fu"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765542435
        nanos: 746421000
      }
      modified_at {
        seconds: 1765542435
        nanos: 746421000
      }
      revision: 1
    }
    started_at {
      seconds: 1765542436
      nanos: 483000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudq7uf4g39kndm5a5-ptqudq7uf4g3a86uj0fu"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765542435
      nanos: 746421000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            PRAGMA dq.Scheduler=@@{\"type\": \"single_node\"}@@;\n            INSERT INTO yds.`redistribute_output`\n            SELECT data FROM yds.`redistribute_input`\n                WITH (format=json_each_row, SCHEMA (time Int32 NOT NULL, data String NOT NULL));"
    syntax: YQL_V1
  }
  plan {
    json: "{\"Detailed\":{\"Operations\":[{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"}]}},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":1}},\"Basic\":{\"nodes\":[{\"id\":3,\"level\":1,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":2,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":3,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}"
  }
  ast {
    data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (Configure! $1 (DataSource \'\"dq\" \'\"$all\") \'\"Attr\" \'\"scheduler\" \'\"{\\\"type\\\": \\\"single_node\\\"}\"))\n(let $3 (DataSource \'\"pq\" \'\"yds\"))\n(let $4 \'(\'(\'\"PartitionsCount\" \'\"3\")))\n(let $5 (DataType \'String))\n(let $6 (StructType \'(\'\"data\" $5)))\n(let $7 (PqTopic \'\"yds\" \'\"local\" \'\"redistribute_input\" $4 \'() $6))\n(let $8 \'(\'\"Endpoint\" \'\"localhost:8973\"))\n(let $9 \'(\'\"SharedReading\" \'\"1\"))\n(let $10 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $11 \'($8 $9 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudq7ufaojt865b70f\") $10))\n(let $12 (SecureParam \'\"cluster:default_yds\"))\n(let $13 (DqPqTopicSource $2 $7 \'(\'\"data\") $11 $12 \'\"\" $6 \'\"\"))\n(let $14 (DataSink \'\"pq\" \'\"yds\"))\n(let $15 (PqTopic \'\"yds\" \'\"local\" \'\"redistribute_output\" $4 \'() (StructType \'(\'\"Data\" $5))))\n(let $16 (DqPqTopicSink $15 \'($8 $10) $12))\n(return (Commit! (DqQuery! $2 \'((DqStage \'((DqSource $3 $13)) (lambda \'($17) (block \'(\n  (let $18 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($9))))\n  (let $19 (DqSourceWideWrap $17 $3 $6 $18))\n  (return (NarrowMap $19 (lambda \'($20) (AsStruct \'(\'\"data\" $20)))))\n))) \'(\'(\'\"_logical_id\" \'200247)) \'((DqSink \'\"0\" $14 $16))))) $14))\n)\n"
  }
}

2025-12-12 12:27:20,441 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0010*\014shard-000002"
  }
}

2025-12-12 12:27:20,442 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,447 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0011*\014shard-000002"
  }
}

2025-12-12 12:27:20,448 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,453 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0012*\014shard-000002"
  }
}

2025-12-12 12:27:20,454 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,459 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0013*\014shard-000002"
  }
}

2025-12-12 12:27:20,460 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,466 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0010*\014shard-000001"
  }
}

2025-12-12 12:27:20,466 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,472 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0014*\014shard-000002"
  }
}

2025-12-12 12:27:20,472 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,478 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0010*\014shard-000000"
  }
}

2025-12-12 12:27:20,478 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,483 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0011*\014shard-000001"
  }
}

2025-12-12 12:27:20,483 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,488 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0015*\014shard-000002"
  }
}

2025-12-12 12:27:20,489 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,493 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0011*\014shard-000000"
  }
}

2025-12-12 12:27:20,494 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 100, "data": "hello"}']
2025-12-12 12:27:20,494 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/tools/pq_read/pq_read
2025-12-12 12:27:20,495 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to pq_read.err
2025-12-12 12:27:20,496 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/tools/pq_read/pq_read', '--endpoint', 'localhost:8973', '--database', 'local', '--topic-path', 'redistribute_output', '--consumer-name', 'redistribute_consumer', '--disable-cluster-discovery', '--messages-count', '10', '--timeout', '30000ms', '--commit-after-processing']' in 'None' (waiting)
2025-12-12 12:27:20,496 - DEBUG - ya.test - execute: Command pid: 1204996
2025-12-12 12:27:22,201 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-12 12:27:22,202 - DEBUG - ya.test - _save_outputs: Command (pid 1204996) rc: 0
2025-12-12 12:27:22,202 - DEBUG - ya.test - _save_outputs: Command (pid 1204996) elapsed time (sec): 1.7046189308166504
2025-12-12 12:27:22,202 - DEBUG - ya.test - _save_outputs: Command (pid 1204996) wtime: 1.706
2025-12-12 12:27:22,202 - DEBUG - ya.test - _save_outputs: Command (pid 1204996) output:
None
2025-12-12 12:27:22,202 - DEBUG - ya.test - _save_outputs: Command (pid 1204996) errors:
2025-12-12T12:27:20.517017Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Starting read session
2025-12-12T12:27:20.517064Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Starting session to cluster null (localhost:8973)
2025-12-12T12:27:20.517578Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] In Reconnect, ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:20.517592Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] New values: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:20.517598Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Reconnecting session to cluster null in 0.000000s
2025-12-12T12:27:20.530793Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Successfully connected. Initializing session
2025-12-12T12:27:20.532014Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Server session id: redistribute_consumer_1_1_12086973470592465342_v1
2025-12-12T12:27:20.532261Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:20.533767Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Confirm partition stream create. Partition stream id: 1. Cluster: "". Topic: "redistribute_output". Partition: 1. Read offset: (NULL)
2025-12-12T12:27:20.533973Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Confirm partition stream create. Partition stream id: 2. Cluster: "". Topic: "redistribute_output". Partition: 2. Read offset: (NULL)
2025-12-12T12:27:20.534026Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Confirm partition stream create. Partition stream id: 3. Cluster: "". Topic: "redistribute_output". Partition: 0. Read offset: (NULL)
2025-12-12T12:27:21.518322Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:0:0 null:redistribute_output:2:2:0:0 null:redistribute_output:1:1:0:0
2025-12-12T12:27:21.518360Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1001 BytesRead: 0 MessagesRead: 0 BytesReadCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:27:22.117682Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.117774Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 2 (0-0)
2025-12-12T12:27:22.117833Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 0} (0-0)
2025-12-12T12:27:22.117966Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [0, 1). Partition stream id: 2
2025-12-12T12:27:22.118077Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 1, size 5 bytes
2025-12-12T12:27:22.122265Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 1 partition_cookie: 1 }
2025-12-12T12:27:22.122513Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.122584Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 2 (1-5)
2025-12-12T12:27:22.122635Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 0} (1-1)
2025-12-12T12:27:22.122645Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 1} (2-2)
2025-12-12T12:27:22.122653Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 2} (3-3)
2025-12-12T12:27:22.122658Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 3} (4-4)
2025-12-12T12:27:22.122667Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 4} (5-5)
2025-12-12T12:27:22.122769Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [1, 6). Partition stream id: 2
2025-12-12T12:27:22.122907Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 5, size 25 bytes
2025-12-12T12:27:22.124294Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 1 partition_cookie: 2 }
2025-12-12T12:27:22.127781Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.127867Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (0-0)
2025-12-12T12:27:22.127902Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (0-0)
2025-12-12T12:27:22.127981Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [0, 1). Partition stream id: 3
2025-12-12T12:27:22.128118Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 1, size 5 bytes
2025-12-12T12:27:22.129763Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.129811Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (1-1)
2025-12-12T12:27:22.129836Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (1-1)
2025-12-12T12:27:22.129896Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [1, 2). Partition stream id: 3
2025-12-12T12:27:22.130012Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 1, size 5 bytes
2025-12-12T12:27:22.130273Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 3 partition_cookie: 1 }
2025-12-12T12:27:22.131257Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 3 partition_cookie: 2 }
2025-12-12T12:27:22.166523Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.166612Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (2-2)
2025-12-12T12:27:22.166648Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (2-2)
2025-12-12T12:27:22.166763Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [2, 3). Partition stream id: 3
2025-12-12T12:27:22.166942Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 1, size 5 bytes
2025-12-12T12:27:22.168595Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 3 partition_cookie: 3 }
2025-12-12T12:27:22.169580Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:22.169638Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (3-3)
2025-12-12T12:27:22.169684Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (3-3)
2025-12-12T12:27:22.169746Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Commit offsets [3, 4). Partition stream id: 3
2025-12-12T12:27:22.169894Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] The application data is transferred to the client. Number of messages 1, size 5 bytes
2025-12-12T12:27:22.171198Z :DEBUG: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] [null] Committed response: cookies { assign_id: 3 partition_cookie: 4 }
Closing session. Got 10 messages
2025-12-12T12:27:22.171326Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Closing read session. Close timeout: 5.000000s
2025-12-12T12:27:22.171362Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:3:4 null:redistribute_output:2:2:5:6 null:redistribute_output:1:1:0:0
2025-12-12T12:27:22.171387Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1654 BytesRead: 50 MessagesRead: 10 BytesReadCompressed: 50 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
Session closed
2025-12-12T12:27:22.171630Z :NOTICE: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }
Stopping driver...
Driver stopped. Exit
Session closed event: SessionClosed { Status: SUCCESS Issues: "<main>: Error: Session was gracefully closed " }
2025-12-12T12:27:22.171741Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Closing read session. Close timeout: 0.000000s
2025-12-12T12:27:22.171752Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:3:4 null:redistribute_output:2:2:5:6 null:redistribute_output:1:1:0:0
2025-12-12T12:27:22.171760Z :INFO: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1654 BytesRead: 50 MessagesRead: 10 BytesReadCompressed: 50 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:27:22.171769Z :NOTICE: [local] [local] [bf6a4d9c-3b2a8c3c-195fbd1-f885a4cd] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }

2025-12-12 12:27:22,203 - INFO - root - read_stream: Data was read from redistribute_output: ['hello', 'hello', 'hello', 'hello', 'hello', 'hello', 'hello', 'hello', 'hello', 'hello']
2025-12-12 12:27:24,330 - DEBUG - root - test_redistribute_partition_after_timeout: Stopping node: 3
2025-12-12 12:27:25,331 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:5594/3
2025-12-12 12:27:25,348 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0016*\014shard-000002"
  }
}

2025-12-12 12:27:25,348 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,354 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0017*\014shard-000002"
  }
}

2025-12-12 12:27:25,354 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,360 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0018*\014shard-000002"
  }
}

2025-12-12 12:27:25,360 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,366 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0019*\014shard-000002"
  }
}

2025-12-12 12:27:25,366 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,372 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0012*\014shard-000001"
  }
}

2025-12-12 12:27:25,373 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,379 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\022\"\00210*\014shard-000002"
  }
}

2025-12-12 12:27:25,380 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,386 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0012*\014shard-000000"
  }
}

2025-12-12 12:27:25,387 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,393 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0013*\014shard-000001"
  }
}

2025-12-12 12:27:25,393 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,399 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\022\"\00211*\014shard-000002"
  }
}

2025-12-12 12:27:25,399 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,404 - DEBUG - root - write_stream: Write topic redistribute_input. Response: operation {
  ready: true
  status: SUCCESS
  result {
    type_url: "type.googleapis.com/Ydb.DataStreams.V1.PutRecordsResult"
    value: "\010\001\032\021\"\0013*\014shard-000000"
  }
}

2025-12-12 12:27:25,405 - INFO - root - write_stream: Data was written to redistribute_input: ['{"time": 101, "data": "Relativitätstheorie"}']
2025-12-12 12:27:25,406 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/tools/pq_read/pq_read
2025-12-12 12:27:25,407 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to pq_read.err.0
2025-12-12 12:27:25,407 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/jy0o/001847/ydb/tests/tools/pq_read/pq_read', '--endpoint', 'localhost:8973', '--database', 'local', '--topic-path', 'redistribute_output', '--consumer-name', 'redistribute_consumer', '--disable-cluster-discovery', '--messages-count', '10', '--timeout', '30000ms', '--commit-after-processing']' in 'None' (waiting)
2025-12-12 12:27:25,408 - DEBUG - ya.test - execute: Command pid: 1208876
2025-12-12 12:27:49,302 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-12 12:27:49,303 - DEBUG - ya.test - _save_outputs: Command (pid 1208876) rc: 0
2025-12-12 12:27:49,303 - DEBUG - ya.test - _save_outputs: Command (pid 1208876) elapsed time (sec): 23.894290685653687
2025-12-12 12:27:49,304 - DEBUG - ya.test - _save_outputs: Command (pid 1208876) wtime: 23.896
2025-12-12 12:27:49,304 - DEBUG - ya.test - _save_outputs: Command (pid 1208876) output:
None
2025-12-12 12:27:49,304 - DEBUG - ya.test - _save_outputs: Command (pid 1208876) errors:
2025-12-12T12:27:25.431643Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Starting read session
2025-12-12T12:27:25.431696Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Starting session to cluster null (localhost:8973)
2025-12-12T12:27:25.432184Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] In Reconnect, ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:25.433561Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] New values: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:25.433574Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Reconnecting session to cluster null in 0.000000s
2025-12-12T12:27:25.440131Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Successfully connected. Initializing session
2025-12-12T12:27:25.442193Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Server session id: redistribute_consumer_1_5_12685025795671791762_v1
2025-12-12T12:27:25.443183Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:25.444131Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Confirm partition stream create. Partition stream id: 1. Cluster: "". Topic: "redistribute_output". Partition: 1. Read offset: (NULL)
2025-12-12T12:27:25.444333Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Confirm partition stream create. Partition stream id: 2. Cluster: "". Topic: "redistribute_output". Partition: 2. Read offset: (NULL)
2025-12-12T12:27:25.444415Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Confirm partition stream create. Partition stream id: 3. Cluster: "". Topic: "redistribute_output". Partition: 0. Read offset: (NULL)
2025-12-12T12:27:26.432316Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:0:4 null:redistribute_output:2:2:0:6 null:redistribute_output:1:1:0:0
2025-12-12T12:27:26.432360Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1000 BytesRead: 0 MessagesRead: 0 BytesReadCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:27:49.161757Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:49.161900Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (4-4)
2025-12-12T12:27:49.161958Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (4-4)
2025-12-12T12:27:49.162121Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [4, 5). Partition stream id: 3
2025-12-12T12:27:49.162286Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.162632Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:49.163043Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (5-5)
2025-12-12T12:27:49.163097Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (5-5)
2025-12-12T12:27:49.163641Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [5, 6). Partition stream id: 3
2025-12-12T12:27:49.163771Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.170192Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 3 partition_cookie: 1 }
2025-12-12T12:27:49.171213Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 3 partition_cookie: 2 }
2025-12-12T12:27:49.171692Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:49.171771Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 2 (6-6)
2025-12-12T12:27:49.171825Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 0} (6-6)
2025-12-12T12:27:49.171904Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [6, 7). Partition stream id: 2
2025-12-12T12:27:49.171991Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.175868Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:49.175981Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (6-6)
2025-12-12T12:27:49.176038Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (6-6)
2025-12-12T12:27:49.176066Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 2 (7-7)
2025-12-12T12:27:49.176088Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [6, 7). Partition stream id: 3
2025-12-12T12:27:49.176097Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 0} (7-7)
2025-12-12T12:27:49.176263Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.176314Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [7, 8). Partition stream id: 2
2025-12-12T12:27:49.176322Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.183447Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-12T12:27:49.183641Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 1 partition_cookie: 1 }
2025-12-12T12:27:49.183660Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 2 (8-11)
2025-12-12T12:27:49.184230Z :DEBUG: [local] Take Data. Partition 2. Read: {0, 0} (8-8)
2025-12-12T12:27:49.183663Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (7-7)
2025-12-12T12:27:49.184243Z :DEBUG: [local] Take Data. Partition 2. Read: {1, 0} (9-9)
2025-12-12T12:27:49.184287Z :DEBUG: [local] Take Data. Partition 2. Read: {1, 1} (10-10)
2025-12-12T12:27:49.184292Z :DEBUG: [local] Take Data. Partition 2. Read: {1, 2} (11-11)
2025-12-12T12:27:49.184340Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (7-7)
2025-12-12T12:27:49.184407Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [8, 12). Partition stream id: 2
2025-12-12T12:27:49.184504Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 4, size 80 bytes
2025-12-12T12:27:49.184546Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Commit offsets [7, 8). Partition stream id: 3
2025-12-12T12:27:49.184600Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] The application data is transferred to the client. Number of messages 1, size 20 bytes
2025-12-12T12:27:49.185681Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 1 partition_cookie: 2 }
2025-12-12T12:27:49.185797Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 3 partition_cookie: 3 }
2025-12-12T12:27:49.186615Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 1 partition_cookie: 3 }
2025-12-12T12:27:49.186768Z :DEBUG: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] [null] Committed response: cookies { assign_id: 3 partition_cookie: 4 }
Closing session. Got 10 messages
2025-12-12T12:27:49.186844Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Closing read session. Close timeout: 5.000000s
2025-12-12T12:27:49.186883Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:7:8 null:redistribute_output:2:2:11:12 null:redistribute_output:1:1:0:0
2025-12-12T12:27:49.186896Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Counters: { Errors: 0 CurrentSessionLifetimeMs: 23755 BytesRead: 200 MessagesRead: 10 BytesReadCompressed: 200 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
Session closed
2025-12-12T12:27:49.187374Z :NOTICE: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }
Stopping driver...
Driver stopped. Exit
Session closed event: SessionClosed { Status: SUCCESS Issues: "<main>: Error: Session was gracefully closed " }
2025-12-12T12:27:49.188808Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Closing read session. Close timeout: 0.000000s
2025-12-12T12:27:49.188826Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:redistribute_output:0:3:7:8 null:redistribute_output:2:2:11:12 null:redistribute_output:1:1:0:0
2025-12-12T12:27:49.188837Z :INFO: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Counters: { Errors: 0 CurrentSessionLifetimeMs: 23757 BytesRead: 200 MessagesRead: 10 BytesReadCompressed: 200 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-12T12:27:49.188850Z :NOTICE: [local] [local] [963d23ff-ac3b6c86-bff30fbb-5b7921ed] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }

2025-12-12 12:27:49,305 - INFO - root - read_stream: Data was read from redistribute_output: ['Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie', 'Relativitätstheorie']
2025-12-12 12:27:49,307 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-12-12 12:27:52,315 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:26637/1
2025-12-12 12:27:52,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16607
2025-12-12 12:27:52,316 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4258
2025-12-12 12:27:52,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12873
2025-12-12 12:27:52,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26637
2025-12-12 12:27:52,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26927
2025-12-12 12:27:52,317 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2786
2025-12-12 12:27:52,324 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:5594/3
2025-12-12 12:27:53,324 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:11545/2
2025-12-12 12:27:53,336 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:8637/1
2025-12-12 12:27:53,337 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18725
2025-12-12 12:27:53,337 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30755
2025-12-12 12:27:53,337 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64080
2025-12-12 12:27:53,337 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5594
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5332
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21052
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27335
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11545
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19304
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2597
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64423
2025-12-12 12:27:53,338 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8637
2025-12-12 12:27:53,339 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/64479
2025-12-12 12:27:53,339 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27717
2025-12-12 12:27:53,339 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16927
