2025-12-09 03:43:00,356 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-09 03:43:00,357 - INFO - ya.test - pytest_runtest_setup: test_idle_watermarks[2-no_shared]
2025-12-09 03:43:00,357 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-09 03:43:00,357 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-09 03:43:00,358 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19353
2025-12-09 03:43:00,359 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20348
2025-12-09 03:43:00,429 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd
2025-12-09 03:43:00,430 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28598
2025-12-09 03:43:00,431 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/8983
2025-12-09 03:43:00,495 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd
2025-12-09 03:43:00,495 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16974
2025-12-09 03:43:00,496 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11087
2025-12-09 03:43:00,497 - 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-09 03:43:00,498 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-09 03:43:00,499 - 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-09 03:43:00,503 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local
2025-12-09 03:43:00,504 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 15ab1c91-5141-45bf-bb4c-e81ee6d32384, localhost:4927): creating call state
2025-12-09 03:43:00,504 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 15ab1c91-5141-45bf-bb4c-e81ee6d32384, localhost:4927): request = { database: "local" }
2025-12-09 03:43:00,507 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 15ab1c91-5141-45bf-bb4c-e81ee6d32384, localhost:4927): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-syjwtgwtdu.auto.internal" port: 4927 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-09 03:43:00,507 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-syjwtgwtdu.auto.internal:4927, location 1, ssl: False>]>
2025-12-09 03:43:00,508 - 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-09 03:43:00,514 - INFO - ydb.connection - close: Closing channel for endpoint localhost:4927
2025-12-09 03:43:00,515 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-12-09 03:43:00,515 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f1a4c954240 state=pending>
2025-12-09 03:43:00,516 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-12-09 03:43:00,516 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,516 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,516 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, f99d5f53-7a8a-4260-a152-3af9bd30c758, ghrun-syjwtgwtdu.auto.internal:4927): creating call state
2025-12-09 03:43:00,517 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, f99d5f53-7a8a-4260-a152-3af9bd30c758, ghrun-syjwtgwtdu.auto.internal:4927): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-12-09 03:43:00,519 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, f99d5f53-7a8a-4260-a152-3af9bd30c758, ghrun-syjwtgwtdu.auto.internal:4927): on response callback started
2025-12-09 03:43:00,520 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, f99d5f53-7a8a-4260-a152-3af9bd30c758, ghrun-syjwtgwtdu.auto.internal:4927): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NTEyMTcwYmQtYzc4ZWJkYWQtOWU1NjcwZTItOGZjNjQ4YmY=" } } } }
2025-12-09 03:43:00,520 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,520 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,521 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 423385c0-ee5d-41c4-966b-5d1bc3d6ea5b, ghrun-syjwtgwtdu.auto.internal:4927): creating call state
2025-12-09 03:43:00,521 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, f99d5f53-7a8a-4260-a152-3af9bd30c758, ghrun-syjwtgwtdu.auto.internal:4927): on response callback success
2025-12-09 03:43:00,522 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 423385c0-ee5d-41c4-966b-5d1bc3d6ea5b, ghrun-syjwtgwtdu.auto.internal:4927): request = { session_id: "ydb://session/3?node_id=1&id=NTEyMTcwYmQtYzc4ZWJkYWQtOWU1NjcwZTItOGZjNjQ4YmY=" path: "local/DbPoolStorage_d6d1f2bb-085f-418c-bd35-8f76c8aff14f/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-09 03:43:00,537 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 423385c0-ee5d-41c4-966b-5d1bc3d6ea5b, ghrun-syjwtgwtdu.auto.internal:4927): response = { operation { ready: true status: SUCCESS } }
2025-12-09 03:43:00,538 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,539 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5029183c-7dd0-4948-90dd-1a2c1350045e, ghrun-syjwtgwtdu.auto.internal:4927): creating call state
2025-12-09 03:43:00,540 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5029183c-7dd0-4948-90dd-1a2c1350045e, ghrun-syjwtgwtdu.auto.internal:4927): request = { session_id: "ydb://session/3?node_id=1&id=NTEyMTcwYmQtYzc4ZWJkYWQtOWU1NjcwZTItOGZjNjQ4YmY=" path: "local/DbPoolStorage_d6d1f2bb-085f-418c-bd35-8f76c8aff14f/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-09 03:43:00,554 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5029183c-7dd0-4948-90dd-1a2c1350045e, ghrun-syjwtgwtdu.auto.internal:4927): response = { operation { ready: true status: SUCCESS } }
2025-12-09 03:43:00,554 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,555 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 0408b4c3-67bd-4879-8879-dc59ad9df8b5, ghrun-syjwtgwtdu.auto.internal:4927): creating call state
2025-12-09 03:43:00,556 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 0408b4c3-67bd-4879-8879-dc59ad9df8b5, ghrun-syjwtgwtdu.auto.internal:4927): request = { session_id: "ydb://session/3?node_id=1&id=NTEyMTcwYmQtYzc4ZWJkYWQtOWU1NjcwZTItOGZjNjQ4YmY=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\n            PRAGMA TablePathPrefix(\"local/DbPoolStorage_d6d1f2bb-085f-418c-bd35-8f76c8aff14f\");\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-09 03:43:00,574 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 0408b4c3-67bd-4879-8879-dc59ad9df8b5, ghrun-syjwtgwtdu.auto.internal:4927): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-12-09 03:43:00,575 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f1a4c956310>
2025-12-09 03:43:00,632 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd
2025-12-09 03:43:00,633 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23723
2025-12-09 03:43:00,634 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23070
2025-12-09 03:43:00,634 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16853
2025-12-09 03:43:00,635 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/kikimr_configs"
2025-12-09 03:43:00,635 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/av6y/0029f2/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/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/node_1/logfile_elqd4i9q.log --grpc-port=11087 --mon-port=23723 --ic-port=28598
2025-12-09 03:43:00,636 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/kikimr_configs"
2025-12-09 03:43:00,636 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/av6y/0029f2/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/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/node_1/logfile_elqd4i9q.log --grpc-port=11087 --mon-port=23723 --ic-port=28598
2025-12-09 03:43:00,637 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/kikimr_configs/config.yaml', '--node=1', '--tenant=/cp', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/node_1/logfile_elqd4i9q.log', '--grpc-port=11087', '--mon-port=23723', '--ic-port=28598')' in '/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/cp/node_1' (no wait)
2025-12-09 03:43:00,639 - DEBUG - ya.test - execute: Command pid: 1630463
2025-12-09 03:43:00,640 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:11087/1
2025-12-09 03:43:00,641 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-09 03:43:00,641 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-09 03:43:00,641 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-09 03:43:00,642 - DEBUG - ya.test - execute: Command pid: 1630464
2025-12-09 03:43:01,009 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) rc: 0
2025-12-09 03:43:01,009 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) elapsed time (sec): 0.36610937118530273
2025-12-09 03:43:01,009 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) idrss: 0
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) inblock: 0
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) isrss: 0
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) ixrss: 0
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) majflt: 0
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) maxrss: 543848
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) minflt: 18240
2025-12-09 03:43:01,010 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) msgrcv: 0
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) msgsnd: 0
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) nivcsw: 4
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) nsignals: 0
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) nswap: 0
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) nvcsw: 16
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) oublock: 8
2025-12-09 03:43:01,011 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) stime: 0.221269
2025-12-09 03:43:01,012 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) utime: 0.096553
2025-12-09 03:43:01,012 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) wtime: 0.367
2025-12-09 03:43:01,012 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) output:
Git info:
    Commit: 2ad8a0198ac871ab3cd73b3e9d43a8d7c87aa707
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge 59f28a396f698b38a7f7341b2c06d7104ff2cbd4 into 0ab8ad45a21edd60c6548fe63ce9b19ce58e1cd6

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-syjwtgwtdu
    Host information: 
        Linux ghrun-syjwtgwtdu 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-09 03:43:01,012 - DEBUG - ya.test - _save_outputs: Command (pid 1630464) errors:

2025-12-09 03:43:01,013 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 2ad8a0198ac871ab3cd73b3e9d43a8d7c87aa707
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge 59f28a396f698b38a7f7341b2c06d7104ff2cbd4 into 0ab8ad45a21edd60c6548fe63ce9b19ce58e1cd6
2025-12-09 03:43:01,013 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-09 03:43:01,061 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd
2025-12-09 03:43:01,062 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6626
2025-12-09 03:43:01,063 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27736
2025-12-09 03:43:01,063 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20235
2025-12-09 03:43:01,063 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16708
2025-12-09 03:43:01,064 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/kikimr_configs"
2025-12-09 03:43:01,065 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/av6y/0029f2/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/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/node_1/logfile_vy98_8n1.log --grpc-port=6626 --mon-port=27736 --ic-port=16974
2025-12-09 03:43:01,065 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/kikimr_configs"
2025-12-09 03:43:01,065 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/av6y/0029f2/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/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/node_1/logfile_vy98_8n1.log --grpc-port=6626 --mon-port=27736 --ic-port=16974
2025-12-09 03:43:01,066 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/kikimr_configs/config.yaml', '--node=1', '--tenant=/compute', '--node-kind=yq', '--log-file-name=/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/node_1/logfile_vy98_8n1.log', '--grpc-port=6626', '--mon-port=27736', '--ic-port=16974')' in '/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/fq/yds/test-results/py3test/testing_out_stuff/chunk41/testing_out_stuff/test_watermarks.py.TestWatermarks.test_idle_watermarks.2-no_shared/compute/node_1' (no wait)
2025-12-09 03:43:01,068 - DEBUG - ya.test - execute: Command pid: 1630590
2025-12-09 03:43:01,068 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:6626/1
2025-12-09 03:43:01,070 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-09 03:43:01,070 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-09 03:43:01,070 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/av6y/0029f2/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-09 03:43:01,071 - DEBUG - ya.test - execute: Command pid: 1630591
2025-12-09 03:43:01,671 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) rc: 0
2025-12-09 03:43:01,672 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) elapsed time (sec): 0.599022626876831
2025-12-09 03:43:01,672 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) idrss: 0
2025-12-09 03:43:01,672 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) inblock: 0
2025-12-09 03:43:01,672 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) isrss: 0
2025-12-09 03:43:01,673 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) ixrss: 0
2025-12-09 03:43:01,673 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) majflt: 0
2025-12-09 03:43:01,673 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) maxrss: 543848
2025-12-09 03:43:01,673 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) minflt: 16233
2025-12-09 03:43:01,673 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) msgrcv: 0
2025-12-09 03:43:01,674 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) msgsnd: 0
2025-12-09 03:43:01,674 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) nivcsw: 7
2025-12-09 03:43:01,674 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) nsignals: 0
2025-12-09 03:43:01,674 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) nswap: 0
2025-12-09 03:43:01,674 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) nvcsw: 13
2025-12-09 03:43:01,675 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) oublock: 8
2025-12-09 03:43:01,675 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) stime: 0.45109099999999996
2025-12-09 03:43:01,675 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) utime: 0.099799
2025-12-09 03:43:01,675 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) wtime: 0.6
2025-12-09 03:43:01,675 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) output:
Git info:
    Commit: 2ad8a0198ac871ab3cd73b3e9d43a8d7c87aa707
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge 59f28a396f698b38a7f7341b2c06d7104ff2cbd4 into 0ab8ad45a21edd60c6548fe63ce9b19ce58e1cd6

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-syjwtgwtdu
    Host information: 
        Linux ghrun-syjwtgwtdu 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-09 03:43:01,676 - DEBUG - ya.test - _save_outputs: Command (pid 1630591) errors:

2025-12-09 03:43:01,676 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 2ad8a0198ac871ab3cd73b3e9d43a8d7c87aa707
    Branch: 
    Author: Alexey Efimov <xeno@prnwatch.com>
    Summary: Merge 59f28a396f698b38a7f7341b2c06d7104ff2cbd4 into 0ab8ad45a21edd60c6548fe63ce9b19ce58e1cd6
2025-12-09 03:43:01,676 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-09 03:43:01,683 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_watermarks.py::TestWatermarks, test_name: test_idle_watermarks[2-no_shared])
2025-12-09 03:43:02,066 - DEBUG - root - create_stream: Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/test_idle_watermarks_no_shared_input"
shard_count: 2
write_quota_kb_per_sec: 1024
retention_period_hours: 1

2025-12-09 03:43:02,086 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-09 03:43:02,086 - DEBUG - root - _get_and_check_result: Result: 
2025-12-09 03:43:02,088 - DEBUG - root - create_stream: Requesting CreateStream.
Database: "local".
Request:
stream_name: "/local/test_idle_watermarks_no_shared_output"
shard_count: 2
write_quota_kb_per_sec: 1024
retention_period_hours: 1

2025-12-09 03:43:02,107 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-09 03:43:02,107 - DEBUG - root - _get_and_check_result: Result: 
2025-12-09 03:43:02,126 - DEBUG - root - _get_and_check_result: Response: operation {
  ready: true
  status: SUCCESS
}

2025-12-09 03:43:02,126 - DEBUG - root - _get_and_check_result: Result: 
2025-12-09 03:43:02,127 - DEBUG - root - create_query_impl: Request: content {
  type: STREAMING
  name: "simple"
  acl {
    visibility: PRIVATE
  }
  limits {
    execution_timeout {
    }
  }
  text: "\n            USE yds;\n            -- Cannot guarantee writing to a specific partition\n            PRAGMA dq.MaxTasksPerStage=\"2\";\n            PRAGMA dq.WatermarksMode=\"default\";\n            PRAGMA dq.WatermarksGranularityMs=\"500\";\n            PRAGMA dq.WatermarksLateArrivalDelayMs=\"100\";\n            PRAGMA dq.WatermarksIdleTimeoutMs=\"200\";\n            PRAGMA dq.WatermarksEnableIdlePartitions=\"true\";\n\n            $input =\n                SELECT\n                    test_idle_watermarks_no_shared_input.*,\n                    SystemMetadata(\"write_time\") as write_time\n                FROM test_idle_watermarks_no_shared_input\n                WITH(\n                    FORMAT=json_each_row,\n                    SCHEMA(\n                        ts String NOT NULL,\n                        pass Uint64\n                    )\n                    \n                );\n\n            $output =\n                SELECT\n                    AGGREGATE_LIST(ts) AS result\n                FROM $input\n                WHERE pass > 0\n                GROUP BY HoppingWindow(CAST(write_time AS Timestamp), \"PT0.5S\", \"PT1S\");\n\n            INSERT INTO test_idle_watermarks_no_shared_output\n            SELECT ToBytes(Unwrap(Yson::SerializeJson(Yson::From(TableRow()))))\n            FROM $output;\n        "
  syntax: YQL_V1
}
execute_mode: RUN
idempotency_key: "6eb8d816-cc7f-499d-84c8-fdbfff186a0d"

2025-12-09 03:43:02,318 - DEBUG - root - create_query_impl: Result: query_id: "ptqudqgd59ce0mgiqgt9"

2025-12-09 03:43:02,384 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudqgd59ce0mgiqgt9"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765251782
        nanos: 133651000
      }
      modified_at {
        seconds: 1765251782
        nanos: 133651000
      }
      revision: 1
    }
    execute_mode: RUN
    status: STARTING
    last_job_query_revision: 1
    last_job_id: "ptjudqgd59cdvvoh4m41-ptqudqgd59ce0mgiqgt9"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765251782
      nanos: 133651000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            USE yds;\n            -- Cannot guarantee writing to a specific partition\n            PRAGMA dq.MaxTasksPerStage=\"2\";\n            PRAGMA dq.WatermarksMode=\"default\";\n            PRAGMA dq.WatermarksGranularityMs=\"500\";\n            PRAGMA dq.WatermarksLateArrivalDelayMs=\"100\";\n            PRAGMA dq.WatermarksIdleTimeoutMs=\"200\";\n            PRAGMA dq.WatermarksEnableIdlePartitions=\"true\";\n\n            $input =\n                SELECT\n                    test_idle_watermarks_no_shared_input.*,\n                    SystemMetadata(\"write_time\") as write_time\n                FROM test_idle_watermarks_no_shared_input\n                WITH(\n                    FORMAT=json_each_row,\n                    SCHEMA(\n                        ts String NOT NULL,\n                        pass Uint64\n                    )\n                    \n                );\n\n            $output =\n                SELECT\n                    AGGREGATE_LIST(ts) AS result\n                FROM $input\n                WHERE pass > 0\n                GROUP BY HoppingWindow(CAST(write_time AS Timestamp), \"PT0.5S\", \"PT1S\");\n\n            INSERT INTO test_idle_watermarks_no_shared_output\n            SELECT ToBytes(Unwrap(Yson::SerializeJson(Yson::From(TableRow()))))\n            FROM $output;\n        "
    syntax: YQL_V1
  }
}

2025-12-09 03:43:02,895 - DEBUG - root - describe_query: Result: ... (repeated, see above) ...
2025-12-09 03:43:03,405 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudqgd59ce0mgiqgt9"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765251782
        nanos: 133651000
      }
      modified_at {
        seconds: 1765251782
        nanos: 133651000
      }
      revision: 1
    }
    started_at {
      seconds: 1765251782
      nanos: 984000000
    }
    execute_mode: RUN
    status: RUNNING
    last_job_query_revision: 1
    last_job_id: "ptjudqgd59cdvvoh4m41-ptqudqgd59ce0mgiqgt9"
    started_by: "root@builtin"
    submitted_at {
      seconds: 1765251782
      nanos: 133651000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            USE yds;\n            -- Cannot guarantee writing to a specific partition\n            PRAGMA dq.MaxTasksPerStage=\"2\";\n            PRAGMA dq.WatermarksMode=\"default\";\n            PRAGMA dq.WatermarksGranularityMs=\"500\";\n            PRAGMA dq.WatermarksLateArrivalDelayMs=\"100\";\n            PRAGMA dq.WatermarksIdleTimeoutMs=\"200\";\n            PRAGMA dq.WatermarksEnableIdlePartitions=\"true\";\n\n            $input =\n                SELECT\n                    test_idle_watermarks_no_shared_input.*,\n                    SystemMetadata(\"write_time\") as write_time\n                FROM test_idle_watermarks_no_shared_input\n                WITH(\n                    FORMAT=json_each_row,\n                    SCHEMA(\n                        ts String NOT NULL,\n                        pass Uint64\n                    )\n                    \n                );\n\n            $output =\n                SELECT\n                    AGGREGATE_LIST(ts) AS result\n                FROM $input\n                WHERE pass > 0\n                GROUP BY HoppingWindow(CAST(write_time AS Timestamp), \"PT0.5S\", \"PT1S\");\n\n            INSERT INTO test_idle_watermarks_no_shared_output\n            SELECT ToBytes(Unwrap(Yson::SerializeJson(Yson::From(TableRow()))))\n            FROM $output;\n        "
    syntax: YQL_V1
  }
  plan {
    json: "{\"Detailed\":{\"Operations\":[{\"Id\":5,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"FromFlow\"},{\"Name\":\"MultiHoppingCore\"},{\"Name\":\"ExtractMembers\"},{\"Name\":\"FlatMap\"}]},\"DependsOn\":[5]},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":2}},\"Basic\":{\"nodes\":[{\"id\":5,\"level\":1,\"name\":\"DqStage #5\",\"type\":\"op\"},{\"id\":3,\"level\":2,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":3,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":4,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":5,\"target\":3},{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}"
  }
  ast {
    data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"dq\" \'\"$all\"))\n(let $3 (Configure! $1 $2 \'\"Attr\" \'\"maxtasksperstage\" \'\"2\"))\n(let $4 (Configure! $3 $2 \'\"Attr\" \'\"watermarksmode\" \'\"default\"))\n(let $5 (Configure! $4 $2 \'\"Attr\" \'\"watermarksgranularityms\" \'\"500\"))\n(let $6 (Configure! $5 $2 \'\"Attr\" \'\"watermarkslatearrivaldelayms\" \'\"100\"))\n(let $7 (Configure! $6 $2 \'\"Attr\" \'\"watermarksidletimeoutms\" \'\"200\"))\n(let $8 (Configure! $7 $2 \'\"Attr\" \'\"watermarksenableidlepartitions\" \'true))\n(let $9 (DataSource \'\"pq\" \'\"yds\"))\n(let $10 \'(\'(\'\"PartitionsCount\" \'\"2\")))\n(let $11 \'(\'\"pass\" (OptionalType (DataType \'Uint64))))\n(let $12 (DataType \'String))\n(let $13 \'(\'\"ts\" $12))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_input\" $10 \'(\'(\'\"system\" \'_yql_sys_tsp_write_time)) (StructType $11 $13)))\n(let $15 \'(\'\"Endpoint\" \'\"localhost:4927\"))\n(let $16 \'(\'\"SharedReading\" \'0))\n(let $17 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $18 \'($15 $16 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudqgd59n45nq17mca\") $17 \'(\'\"WatermarksEnable\" \'\"1\") \'(\'\"WatermarksGranularityUs\" \'\"500000\") \'(\'\"WatermarksLateArrivalDelayUs\" \'\"100000\") \'(\'\"WatermarksIdlePartitions\" \'\"1\") \'(\'\"WatermarksIdleTimeoutUs\" \'\"200000\")))\n(let $19 (SecureParam \'\"cluster:default_yds\"))\n(let $20 (DataType \'Timestamp))\n(let $21 (StructType \'(\'_yql_sys_tsp_write_time $20) $11 $13))\n(let $22 (DqPqTopicSource $8 $14 \'(\'\"pass\" \'\"ts\") $18 $19 \'\"B\\x19\\b\\x06\\x12\\x06\\x12\\x04pass\\x1A\\r\\n\\v\\n\\x02\\b\\x01\\x12\\x05\\x15\\x00\\x00\\x00\\x00\" $21 \'\"\"))\n(let $23 (Bool \'false))\n(let $24 (DqStage \'((DqSource $9 $22)) (lambda \'($28) (block \'(\n  (let $29 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"metadataColumns\" \'(\'_yql_sys_tsp_write_time)) \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($16))))\n  (let $30 (DqSourceWideWrap $28 $9 $21 $29))\n  (return (FlatMap (NarrowMap $30 (lambda \'($31 $32 $33) (AsStruct \'(\'_yql_sys_tsp_write_time $31) \'(\'\"pass\" $32) \'(\'\"ts\" $33)))) (lambda \'($34) (OptionalIf (Coalesce (> (Member $34 \'\"pass\") (Int32 \'0)) $23) (AsStruct \'(\'\"ts\" (Member $34 \'\"ts\")) \'(\'\"write_time\" (Member $34 \'_yql_sys_tsp_write_time)))))))\n))) \'(\'(\'\"_logical_id\" \'202256))))\n(let $25 (DataSink \'\"pq\" \'\"yds\"))\n(let $26 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_output\" $10 \'() (StructType \'(\'\"Data\" $12))))\n(let $27 (DqPqTopicSink $26 \'($15 $17) $19))\n(return (Commit! (DqQuery! $8 \'((DqStage \'((DqCnUnionAll (TDqOutput $24 \'0))) (lambda \'($35) (block \'(\n  (let $36 (Interval \'\"500000\"))\n  (let $37 (lambda \'($44) $44))\n  (let $38 (MultiHoppingCore (FromFlow $35) (lambda \'($39) (Uint32 \'0)) (lambda \'($40) (Member (SafeCast $40 (StructType \'(\'\"write_time\" $20))) \'\"write_time\")) $36 (Interval \'\"1000000\") $36 \'true (lambda \'($41) (AsStruct \'(\'AggregateList0 (AsList (Member $41 \'\"ts\"))))) (lambda \'($42 $43) (AsStruct \'(\'AggregateList0 (Insert (Member $43 \'AggregateList0) (Member $42 \'\"ts\"))))) $37 $37 (lambda \'($45 $46) (AsStruct \'(\'AggregateList0 (Extend (Member $45 \'AggregateList0) (Member $46 \'AggregateList0))))) (lambda \'($47 $48 $49) (AsStruct \'(\'AggregateList0 (Member $48 \'AggregateList0)) \'(\'\"group0\" $49))) \'\"1\"))\n  (return (FlatMap (ExtractMembers $38 \'(\'AggregateList0)) (lambda \'($50) (block \'(\n    (let $51 (ResourceType \'\"Yson2.Node\"))\n    (let $52 \'($51 \'\"\" \'\"1\"))\n    (let $53 (ResourceType \'\"Yson2.Options\"))\n    (let $54 (OptionalType (DataType \'Bool)))\n    (let $55 (CallableType \'(\'\"4\") \'((OptionalType (DataType \'Json))) $52 \'((OptionalType $53)) \'($54 \'\"SkipMapEntity\") \'($54 \'\"EncodeUtf8\") \'($54 \'\"WriteNanAsString\")))\n    (let $56 (Udf \'\"Yson2.SerializeJson\" (Void) (VoidType) \'\"\" $55 (VoidType) \'\"\" \'()))\n    (let $57 (StructType \'(\'\"result\" (ListType $12))))\n    (let $58 (TupleType (TupleType $57) (StructType) (TupleType)))\n    (let $59 (CallableType \'() \'($51) \'($57)))\n    (let $60 \'(\'(\'\"strict\")))\n    (let $61 (Udf \'\"Yson2.From\" (Void) $58 \'\"\" $59 (VoidType) \'\"\" $60))\n    (let $62 (CallableType \'(\'\"2\") \'($53) \'($54 \'\"AutoConvert\") \'($54 \'\"Strict\")))\n    (let $63 (Udf \'\"Yson2.Options\" (Void) (VoidType) \'\"\" $62 (VoidType) \'\"\" $60))\n    (return (Just (AsStruct \'(\'\"column0\" (ToBytes (Unwrap (Apply $56 (Apply $61 (AsStruct \'(\'\"result\" (Member $50 \'AggregateList0)))) (Just (NamedApply $63 \'() (AsStruct \'(\'\"AutoConvert\" (Just $23)) \'(\'\"Strict\" (Just (Bool \'true)))))))))))))\n  )))))\n))) \'(\'(\'\"_logical_id\" \'202553)) \'((DqSink \'0 $25 $27))))) $25))\n)\n"
  }
}

2025-12-09 03:43:03,929 - DEBUG - root - write_stream: Write topic test_idle_watermarks_no_shared_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\032\021\"\0011*\014shard-000001"
  }
}

2025-12-09 03:43:03,930 - INFO - root - write_stream: Data was written to test_idle_watermarks_no_shared_input: ['{"ts": "1970-01-01T00:00:42Z", "pass": 1}', '{"ts": "1970-01-01T00:00:42Z", "pass": 0}']
2025-12-09 03:43:03,931 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/tools/pq_read/pq_read
2025-12-09 03:43:03,932 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to pq_read.err.1
2025-12-09 03:43:03,932 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/tools/pq_read/pq_read', '--endpoint', 'localhost:4927', '--database', 'local', '--topic-path', 'test_idle_watermarks_no_shared_output', '--consumer-name', 'test_idle_watermarks_no_shared_consumer', '--disable-cluster-discovery', '--messages-count', '1', '--timeout', '30000ms', '--commit-after-processing']' in 'None' (waiting)
2025-12-09 03:43:03,934 - DEBUG - ya.test - execute: Command pid: 1631325
2025-12-09 03:43:34,004 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-09 03:43:34,005 - DEBUG - ya.test - _save_outputs: Command (pid 1631325) rc: 0
2025-12-09 03:43:34,005 - DEBUG - ya.test - _save_outputs: Command (pid 1631325) elapsed time (sec): 30.069846153259277
2025-12-09 03:43:34,005 - DEBUG - ya.test - _save_outputs: Command (pid 1631325) wtime: 30.072
2025-12-09 03:43:34,006 - DEBUG - ya.test - _save_outputs: Command (pid 1631325) output:
None
2025-12-09 03:43:34,006 - DEBUG - ya.test - _save_outputs: Command (pid 1631325) errors:
2025-12-09T03:43:03.956370Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Starting read session
2025-12-09T03:43:03.956431Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Starting session to cluster null (localhost:4927)
2025-12-09T03:43:03.957095Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] In Reconnect, ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:03.957553Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] New values: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:03.957566Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] Reconnecting session to cluster null in 0.000000s
2025-12-09T03:43:03.963841Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] Successfully connected. Initializing session
2025-12-09T03:43:03.965868Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] Server session id: test_idle_watermarks_no_shared_consumer_1_7_7868850577842000231_v1
2025-12-09T03:43:03.965957Z :DEBUG: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:03.982417Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] Confirm partition stream create. Partition stream id: 1. Cluster: "". Topic: "test_idle_watermarks_no_shared_output". Partition: 1. Read offset: (NULL)
2025-12-09T03:43:03.982626Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] [null] Confirm partition stream create. Partition stream id: 2. Cluster: "". Topic: "test_idle_watermarks_no_shared_output". Partition: 0. Read offset: (NULL)
2025-12-09T03:43:04.957291Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:test_idle_watermarks_no_shared_output:0:2:0:0 null:test_idle_watermarks_no_shared_output:1:1:0:0
2025-12-09T03:43:04.957343Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 1000 BytesRead: 0 MessagesRead: 0 BytesReadCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
Closing session. No data during 30.000000s
2025-12-09T03:43:33.960201Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Closing read session. Close timeout: 5.000000s
2025-12-09T03:43:33.960239Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:test_idle_watermarks_no_shared_output:0:2:0:0 null:test_idle_watermarks_no_shared_output:1:1:0:0
2025-12-09T03:43:33.960253Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 30003 BytesRead: 0 MessagesRead: 0 BytesReadCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
Session closed
2025-12-09T03:43:33.960652Z :NOTICE: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] 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-09T03:43:33.960826Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Closing read session. Close timeout: 0.000000s
2025-12-09T03:43:33.960838Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:test_idle_watermarks_no_shared_output:0:2:0:0 null:test_idle_watermarks_no_shared_output:1:1:0:0
2025-12-09T03:43:33.960846Z :INFO: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Counters: { Errors: 0 CurrentSessionLifetimeMs: 30004 BytesRead: 0 MessagesRead: 0 BytesReadCompressed: 0 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-09T03:43:33.960857Z :NOTICE: [local] [local] [4fad6447-b07b098d-92e7f9d6-78986bdd] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }

2025-12-09 03:43:34,007 - INFO - root - read_stream: Data was read from test_idle_watermarks_no_shared_output: []
2025-12-09 03:43:35,838 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-09 03:43:35,839 - 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-09 03:43:35,844 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local
2025-12-09 03:43:35,845 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, c1d465aa-2847-4aed-bbd6-93a4526cfcd7, localhost:4927): creating call state
2025-12-09 03:43:35,846 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, c1d465aa-2847-4aed-bbd6-93a4526cfcd7, localhost:4927): request = { database: "local" }
2025-12-09 03:43:35,848 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, c1d465aa-2847-4aed-bbd6-93a4526cfcd7, localhost:4927): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-syjwtgwtdu.auto.internal" port: 4927 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-09 03:43:35,849 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-syjwtgwtdu.auto.internal:4927, location 1, ssl: False>]>
2025-12-09 03:43:35,849 - INFO - ydb.connection - close: Closing channel for endpoint localhost:4927
2025-12-09 03:43:36,012 - DEBUG - root - write_stream: Write topic test_idle_watermarks_no_shared_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-09 03:43:36,013 - INFO - root - write_stream: Data was written to test_idle_watermarks_no_shared_input: ['{"ts": "1970-01-01T00:00:44Z", "pass": 0}']
2025-12-09 03:43:36,014 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/tools/pq_read/pq_read
2025-12-09 03:43:36,015 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to pq_read.err.2
2025-12-09 03:43:36,015 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/av6y/0029f2/ydb/tests/tools/pq_read/pq_read', '--endpoint', 'localhost:4927', '--database', 'local', '--topic-path', 'test_idle_watermarks_no_shared_output', '--consumer-name', 'test_idle_watermarks_no_shared_consumer', '--disable-cluster-discovery', '--messages-count', '2', '--timeout', '30000ms', '--commit-after-processing']' in 'None' (waiting)
2025-12-09 03:43:36,016 - DEBUG - ya.test - execute: Command pid: 1645922
2025-12-09 03:43:36,116 - DEBUG - ya.test - _wait: Process resource usage is not available as process finished before wait4 was called
2025-12-09 03:43:36,117 - DEBUG - ya.test - _save_outputs: Command (pid 1645922) rc: 0
2025-12-09 03:43:36,117 - DEBUG - ya.test - _save_outputs: Command (pid 1645922) elapsed time (sec): 0.10075950622558594
2025-12-09 03:43:36,117 - DEBUG - ya.test - _save_outputs: Command (pid 1645922) wtime: 0.102
2025-12-09 03:43:36,118 - DEBUG - ya.test - _save_outputs: Command (pid 1645922) output:
None
2025-12-09 03:43:36,118 - DEBUG - ya.test - _save_outputs: Command (pid 1645922) errors:
2025-12-09T03:43:36.033114Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Starting read session
2025-12-09T03:43:36.033149Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Starting session to cluster null (localhost:4927)
2025-12-09T03:43:36.033562Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] In Reconnect, ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:36.033576Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] New values: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:36.033582Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Reconnecting session to cluster null in 0.000000s
2025-12-09T03:43:36.039028Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Successfully connected. Initializing session
2025-12-09T03:43:36.039975Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Server session id: test_idle_watermarks_no_shared_consumer_1_8_5915690853591497747_v1
2025-12-09T03:43:36.040074Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:36.041098Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Confirm partition stream create. Partition stream id: 1. Cluster: "". Topic: "test_idle_watermarks_no_shared_output". Partition: 0. Read offset: (NULL)
2025-12-09T03:43:36.041241Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Confirm partition stream create. Partition stream id: 2. Cluster: "". Topic: "test_idle_watermarks_no_shared_output". Partition: 1. Read offset: (NULL)
2025-12-09T03:43:36.041859Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] After sending read request: ReadSizeBudget = 52428800, ReadSizeServerDelta = 0
2025-12-09T03:43:36.041910Z :DEBUG: [local] Decompression task done. Partition/PartitionSessionId: 0 (0-1)
2025-12-09T03:43:36.041949Z :DEBUG: [local] Take Data. Partition 0. Read: {0, 0} (0-0)
2025-12-09T03:43:36.041962Z :DEBUG: [local] Take Data. Partition 0. Read: {1, 0} (1-1)
2025-12-09T03:43:36.042089Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Commit offsets [0, 2). Partition stream id: 1
2025-12-09T03:43:36.042190Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] The application data is transferred to the client. Number of messages 2, size 70 bytes
2025-12-09T03:43:36.044645Z :DEBUG: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] [null] Committed response: cookies { assign_id: 2 partition_cookie: 1 }
Closing session. Got 2 messages
2025-12-09T03:43:36.044792Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Closing read session. Close timeout: 5.000000s
2025-12-09T03:43:36.044825Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:test_idle_watermarks_no_shared_output:1:2:0:0 null:test_idle_watermarks_no_shared_output:0:1:1:2
2025-12-09T03:43:36.044832Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Counters: { Errors: 0 CurrentSessionLifetimeMs: 11 BytesRead: 70 MessagesRead: 2 BytesReadCompressed: 70 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
Session closed
2025-12-09T03:43:36.045027Z :NOTICE: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] 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-09T03:43:36.045135Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Closing read session. Close timeout: 0.000000s
2025-12-09T03:43:36.045144Z :INFO: [local] Read/commit by partition streams (cluster:topic:partition:stream-id:read-offset:committed-offset): null:test_idle_watermarks_no_shared_output:1:2:0:0 null:test_idle_watermarks_no_shared_output:0:1:1:2
2025-12-09T03:43:36.045153Z :INFO: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Counters: { Errors: 0 CurrentSessionLifetimeMs: 12 BytesRead: 70 MessagesRead: 2 BytesReadCompressed: 70 BytesInflightUncompressed: 0 BytesInflightCompressed: 0 BytesInflightTotal: 0 MessagesInflight: 0 }
2025-12-09T03:43:36.045168Z :NOTICE: [local] [local] [96b2f6e-3bf9cdcf-9f34ee84-c159c892] Aborting read session. Description: SessionClosed { Status: ABORTED Issues: "<main>: Error: Aborted " }

2025-12-09 03:43:36,119 - INFO - root - read_stream: Data was read from test_idle_watermarks_no_shared_output: ['{"result":["1970-01-01T00:00:42Z"]}', '{"result":["1970-01-01T00:00:42Z"]}']
2025-12-09 03:43:36,259 - DEBUG - root - control_query: Result: 
2025-12-09 03:43:36,265 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudqgd59ce0mgiqgt9"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765251782
        nanos: 133651000
      }
      modified_at {
        seconds: 1765251816
        nanos: 205412000
      }
      revision: 2
    }
    started_at {
      seconds: 1765251782
      nanos: 984000000
    }
    execute_mode: RUN
    status: ABORTING_BY_USER
    last_job_query_revision: 1
    last_job_id: "ptjudqgd59cdvvoh4m41-ptqudqgd59ce0mgiqgt9"
    started_by: "root@builtin"
    aborted_by: "root@builtin"
    has_saved_checkpoints: true
    submitted_at {
      seconds: 1765251782
      nanos: 133651000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            USE yds;\n            -- Cannot guarantee writing to a specific partition\n            PRAGMA dq.MaxTasksPerStage=\"2\";\n            PRAGMA dq.WatermarksMode=\"default\";\n            PRAGMA dq.WatermarksGranularityMs=\"500\";\n            PRAGMA dq.WatermarksLateArrivalDelayMs=\"100\";\n            PRAGMA dq.WatermarksIdleTimeoutMs=\"200\";\n            PRAGMA dq.WatermarksEnableIdlePartitions=\"true\";\n\n            $input =\n                SELECT\n                    test_idle_watermarks_no_shared_input.*,\n                    SystemMetadata(\"write_time\") as write_time\n                FROM test_idle_watermarks_no_shared_input\n                WITH(\n                    FORMAT=json_each_row,\n                    SCHEMA(\n                        ts String NOT NULL,\n                        pass Uint64\n                    )\n                    \n                );\n\n            $output =\n                SELECT\n                    AGGREGATE_LIST(ts) AS result\n                FROM $input\n                WHERE pass > 0\n                GROUP BY HoppingWindow(CAST(write_time AS Timestamp), \"PT0.5S\", \"PT1S\");\n\n            INSERT INTO test_idle_watermarks_no_shared_output\n            SELECT ToBytes(Unwrap(Yson::SerializeJson(Yson::From(TableRow()))))\n            FROM $output;\n        "
    syntax: YQL_V1
  }
  plan {
    json: "{\"Detailed\":{\"Operations\":[{\"Id\":5,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"FromFlow\"},{\"Name\":\"MultiHoppingCore\"},{\"Name\":\"ExtractMembers\"},{\"Name\":\"FlatMap\"}]},\"DependsOn\":[5]},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":2}},\"Basic\":{\"nodes\":[{\"id\":5,\"level\":1,\"name\":\"DqStage #5\",\"type\":\"op\"},{\"id\":3,\"level\":2,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":3,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":4,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":5,\"target\":3},{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}"
  }
  statistics {
    json: "{\"Graph=0\":{\"Tasks\":{\"sum\":3,\"count\":2,\"avg\":1,\"max\":2,\"min\":1},\"CpuTimeUs\":{\"sum\":\"0.23s\",\"count\":3,\"avg\":\"77ms\",\"max\":\"85ms\",\"min\":\"71ms\"},\"IngressBytes\":{\"sum\":82,\"count\":1,\"avg\":82,\"max\":82,\"min\":82},\"IngressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"InputBytes\":{\"sum\":35,\"count\":1,\"avg\":35,\"max\":35,\"min\":35},\"InputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"OutputBytes\":{\"sum\":35,\"count\":1,\"avg\":35,\"max\":35,\"min\":35},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"EgressRows\":{\"sum\":31,\"count\":1,\"avg\":31,\"max\":31,\"min\":31},\"MaxMemoryUsage\":{\"sum\":524288,\"count\":3,\"avg\":174762,\"max\":196608,\"min\":131072},\"IngressQueuedBytes\":{\"sum\":0,\"count\":3,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":3,\"avg\":0,\"max\":0,\"min\":0}}}"
  }
  ast {
    data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"dq\" \'\"$all\"))\n(let $3 (Configure! $1 $2 \'\"Attr\" \'\"maxtasksperstage\" \'\"2\"))\n(let $4 (Configure! $3 $2 \'\"Attr\" \'\"watermarksmode\" \'\"default\"))\n(let $5 (Configure! $4 $2 \'\"Attr\" \'\"watermarksgranularityms\" \'\"500\"))\n(let $6 (Configure! $5 $2 \'\"Attr\" \'\"watermarkslatearrivaldelayms\" \'\"100\"))\n(let $7 (Configure! $6 $2 \'\"Attr\" \'\"watermarksidletimeoutms\" \'\"200\"))\n(let $8 (Configure! $7 $2 \'\"Attr\" \'\"watermarksenableidlepartitions\" \'true))\n(let $9 (DataSource \'\"pq\" \'\"yds\"))\n(let $10 \'(\'(\'\"PartitionsCount\" \'\"2\")))\n(let $11 \'(\'\"pass\" (OptionalType (DataType \'Uint64))))\n(let $12 (DataType \'String))\n(let $13 \'(\'\"ts\" $12))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_input\" $10 \'(\'(\'\"system\" \'_yql_sys_tsp_write_time)) (StructType $11 $13)))\n(let $15 \'(\'\"Endpoint\" \'\"localhost:4927\"))\n(let $16 \'(\'\"SharedReading\" \'0))\n(let $17 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $18 \'($15 $16 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudqgd59n45nq17mca\") $17 \'(\'\"WatermarksEnable\" \'\"1\") \'(\'\"WatermarksGranularityUs\" \'\"500000\") \'(\'\"WatermarksLateArrivalDelayUs\" \'\"100000\") \'(\'\"WatermarksIdlePartitions\" \'\"1\") \'(\'\"WatermarksIdleTimeoutUs\" \'\"200000\")))\n(let $19 (SecureParam \'\"cluster:default_yds\"))\n(let $20 (DataType \'Timestamp))\n(let $21 (StructType \'(\'_yql_sys_tsp_write_time $20) $11 $13))\n(let $22 (DqPqTopicSource $8 $14 \'(\'\"pass\" \'\"ts\") $18 $19 \'\"B\\x19\\b\\x06\\x12\\x06\\x12\\x04pass\\x1A\\r\\n\\v\\n\\x02\\b\\x01\\x12\\x05\\x15\\x00\\x00\\x00\\x00\" $21 \'\"\"))\n(let $23 (Bool \'false))\n(let $24 (DqStage \'((DqSource $9 $22)) (lambda \'($28) (block \'(\n  (let $29 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"metadataColumns\" \'(\'_yql_sys_tsp_write_time)) \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($16))))\n  (let $30 (DqSourceWideWrap $28 $9 $21 $29))\n  (return (FlatMap (NarrowMap $30 (lambda \'($31 $32 $33) (AsStruct \'(\'_yql_sys_tsp_write_time $31) \'(\'\"pass\" $32) \'(\'\"ts\" $33)))) (lambda \'($34) (OptionalIf (Coalesce (> (Member $34 \'\"pass\") (Int32 \'0)) $23) (AsStruct \'(\'\"ts\" (Member $34 \'\"ts\")) \'(\'\"write_time\" (Member $34 \'_yql_sys_tsp_write_time)))))))\n))) \'(\'(\'\"_logical_id\" \'202256))))\n(let $25 (DataSink \'\"pq\" \'\"yds\"))\n(let $26 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_output\" $10 \'() (StructType \'(\'\"Data\" $12))))\n(let $27 (DqPqTopicSink $26 \'($15 $17) $19))\n(return (Commit! (DqQuery! $8 \'((DqStage \'((DqCnUnionAll (TDqOutput $24 \'0))) (lambda \'($35) (block \'(\n  (let $36 (Interval \'\"500000\"))\n  (let $37 (lambda \'($44) $44))\n  (let $38 (MultiHoppingCore (FromFlow $35) (lambda \'($39) (Uint32 \'0)) (lambda \'($40) (Member (SafeCast $40 (StructType \'(\'\"write_time\" $20))) \'\"write_time\")) $36 (Interval \'\"1000000\") $36 \'true (lambda \'($41) (AsStruct \'(\'AggregateList0 (AsList (Member $41 \'\"ts\"))))) (lambda \'($42 $43) (AsStruct \'(\'AggregateList0 (Insert (Member $43 \'AggregateList0) (Member $42 \'\"ts\"))))) $37 $37 (lambda \'($45 $46) (AsStruct \'(\'AggregateList0 (Extend (Member $45 \'AggregateList0) (Member $46 \'AggregateList0))))) (lambda \'($47 $48 $49) (AsStruct \'(\'AggregateList0 (Member $48 \'AggregateList0)) \'(\'\"group0\" $49))) \'\"1\"))\n  (return (FlatMap (ExtractMembers $38 \'(\'AggregateList0)) (lambda \'($50) (block \'(\n    (let $51 (ResourceType \'\"Yson2.Node\"))\n    (let $52 \'($51 \'\"\" \'\"1\"))\n    (let $53 (ResourceType \'\"Yson2.Options\"))\n    (let $54 (OptionalType (DataType \'Bool)))\n    (let $55 (CallableType \'(\'\"4\") \'((OptionalType (DataType \'Json))) $52 \'((OptionalType $53)) \'($54 \'\"SkipMapEntity\") \'($54 \'\"EncodeUtf8\") \'($54 \'\"WriteNanAsString\")))\n    (let $56 (Udf \'\"Yson2.SerializeJson\" (Void) (VoidType) \'\"\" $55 (VoidType) \'\"\" \'()))\n    (let $57 (StructType \'(\'\"result\" (ListType $12))))\n    (let $58 (TupleType (TupleType $57) (StructType) (TupleType)))\n    (let $59 (CallableType \'() \'($51) \'($57)))\n    (let $60 \'(\'(\'\"strict\")))\n    (let $61 (Udf \'\"Yson2.From\" (Void) $58 \'\"\" $59 (VoidType) \'\"\" $60))\n    (let $62 (CallableType \'(\'\"2\") \'($53) \'($54 \'\"AutoConvert\") \'($54 \'\"Strict\")))\n    (let $63 (Udf \'\"Yson2.Options\" (Void) (VoidType) \'\"\" $62 (VoidType) \'\"\" $60))\n    (return (Just (AsStruct \'(\'\"column0\" (ToBytes (Unwrap (Apply $56 (Apply $61 (AsStruct \'(\'\"result\" (Member $50 \'AggregateList0)))) (Just (NamedApply $63 \'() (AsStruct \'(\'\"AutoConvert\" (Just $23)) \'(\'\"Strict\" (Just (Bool \'true)))))))))))))\n  )))))\n))) \'(\'(\'\"_logical_id\" \'202553)) \'((DqSink \'0 $25 $27))))) $25))\n)\n"
  }
}

2025-12-09 03:43:36,772 - DEBUG - root - describe_query: Result: query {
  meta {
    common {
      id: "ptqudqgd59ce0mgiqgt9"
      created_by: "root@builtin"
      modified_by: "root@builtin"
      created_at {
        seconds: 1765251782
        nanos: 133651000
      }
      modified_at {
        seconds: 1765251816
        nanos: 205412000
      }
      revision: 2
    }
    started_at {
      seconds: 1765251782
      nanos: 984000000
    }
    finished_at {
      seconds: 1765251816
      nanos: 386000000
    }
    execute_mode: RUN
    status: ABORTED_BY_USER
    last_job_query_revision: 1
    last_job_id: "ptjudqgd59cdvvoh4m41-ptqudqgd59ce0mgiqgt9"
    started_by: "root@builtin"
    aborted_by: "root@builtin"
    has_saved_checkpoints: true
    submitted_at {
      seconds: 1765251782
      nanos: 133651000
    }
  }
  content {
    type: STREAMING
    name: "simple"
    acl {
      visibility: PRIVATE
    }
    limits {
      execution_timeout {
      }
    }
    text: "\n            USE yds;\n            -- Cannot guarantee writing to a specific partition\n            PRAGMA dq.MaxTasksPerStage=\"2\";\n            PRAGMA dq.WatermarksMode=\"default\";\n            PRAGMA dq.WatermarksGranularityMs=\"500\";\n            PRAGMA dq.WatermarksLateArrivalDelayMs=\"100\";\n            PRAGMA dq.WatermarksIdleTimeoutMs=\"200\";\n            PRAGMA dq.WatermarksEnableIdlePartitions=\"true\";\n\n            $input =\n                SELECT\n                    test_idle_watermarks_no_shared_input.*,\n                    SystemMetadata(\"write_time\") as write_time\n                FROM test_idle_watermarks_no_shared_input\n                WITH(\n                    FORMAT=json_each_row,\n                    SCHEMA(\n                        ts String NOT NULL,\n                        pass Uint64\n                    )\n                    \n                );\n\n            $output =\n                SELECT\n                    AGGREGATE_LIST(ts) AS result\n                FROM $input\n                WHERE pass > 0\n                GROUP BY HoppingWindow(CAST(write_time AS Timestamp), \"PT0.5S\", \"PT1S\");\n\n            INSERT INTO test_idle_watermarks_no_shared_output\n            SELECT ToBytes(Unwrap(Yson::SerializeJson(Yson::From(TableRow()))))\n            FROM $output;\n        "
    syntax: YQL_V1
  }
  plan {
    json: "{\"Detailed\":{\"Operations\":[{\"Id\":5,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"DqSourceWideWrap\"},{\"Name\":\"NarrowMap\"},{\"Name\":\"FlatMap\"}]}},{\"Id\":3,\"Name\":\"DqStage\",\"Streams\":{\"Program\":[{\"Name\":\"FromFlow\"},{\"Name\":\"MultiHoppingCore\"},{\"Name\":\"ExtractMembers\"},{\"Name\":\"FlatMap\"}]},\"DependsOn\":[5]},{\"Id\":2,\"Name\":\"DqQuery!\",\"DependsOn\":[3]},{\"Id\":1,\"Name\":\"Commit!\",\"DependsOn\":[2]}],\"OperationRoot\":1,\"Providers\":[],\"OperationStats\":{\"Commit!\":1,\"DqQuery!\":1,\"DqStage\":2}},\"Basic\":{\"nodes\":[{\"id\":5,\"level\":1,\"name\":\"DqStage #5\",\"type\":\"op\"},{\"id\":3,\"level\":2,\"name\":\"DqStage #3\",\"type\":\"op\"},{\"id\":2,\"level\":3,\"name\":\"DqQuery!\",\"type\":\"op\"},{\"id\":1,\"level\":4,\"name\":\"Commit!\",\"type\":\"op\"}],\"links\":[{\"source\":5,\"target\":3},{\"source\":3,\"target\":2},{\"source\":2,\"target\":1}]}}"
  }
  issue {
    message: "ABORTED_BY_USER"
    severity: 1
  }
  statistics {
    json: "{\"Graph=0\":{\"Tasks\":{\"sum\":3,\"count\":2,\"avg\":1,\"max\":2,\"min\":1},\"CpuTimeUs\":{\"sum\":\"0.23s\",\"count\":3,\"avg\":\"77ms\",\"max\":\"85ms\",\"min\":\"71ms\"},\"IngressBytes\":{\"sum\":82,\"count\":1,\"avg\":82,\"max\":82,\"min\":82},\"IngressRows\":{\"sum\":2,\"count\":1,\"avg\":2,\"max\":2,\"min\":2},\"InputBytes\":{\"sum\":35,\"count\":1,\"avg\":35,\"max\":35,\"min\":35},\"InputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"OutputBytes\":{\"sum\":35,\"count\":1,\"avg\":35,\"max\":35,\"min\":35},\"OutputRows\":{\"sum\":1,\"count\":1,\"avg\":1,\"max\":1,\"min\":1},\"EgressRows\":{\"sum\":31,\"count\":1,\"avg\":31,\"max\":31,\"min\":31},\"MaxMemoryUsage\":{\"sum\":524288,\"count\":3,\"avg\":174762,\"max\":196608,\"min\":131072},\"IngressQueuedBytes\":{\"sum\":0,\"count\":3,\"avg\":0,\"max\":0,\"min\":0},\"IngressQueuedRows\":{\"sum\":0,\"count\":3,\"avg\":0,\"max\":0,\"min\":0}}}"
  }
  ast {
    data: "(\n(let $1 (Configure! world (DataSource \'\"config\") \'\"DqEngine\" \'\"force\"))\n(let $2 (DataSource \'\"dq\" \'\"$all\"))\n(let $3 (Configure! $1 $2 \'\"Attr\" \'\"maxtasksperstage\" \'\"2\"))\n(let $4 (Configure! $3 $2 \'\"Attr\" \'\"watermarksmode\" \'\"default\"))\n(let $5 (Configure! $4 $2 \'\"Attr\" \'\"watermarksgranularityms\" \'\"500\"))\n(let $6 (Configure! $5 $2 \'\"Attr\" \'\"watermarkslatearrivaldelayms\" \'\"100\"))\n(let $7 (Configure! $6 $2 \'\"Attr\" \'\"watermarksidletimeoutms\" \'\"200\"))\n(let $8 (Configure! $7 $2 \'\"Attr\" \'\"watermarksenableidlepartitions\" \'true))\n(let $9 (DataSource \'\"pq\" \'\"yds\"))\n(let $10 \'(\'(\'\"PartitionsCount\" \'\"2\")))\n(let $11 \'(\'\"pass\" (OptionalType (DataType \'Uint64))))\n(let $12 (DataType \'String))\n(let $13 \'(\'\"ts\" $12))\n(let $14 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_input\" $10 \'(\'(\'\"system\" \'_yql_sys_tsp_write_time)) (StructType $11 $13)))\n(let $15 \'(\'\"Endpoint\" \'\"localhost:4927\"))\n(let $16 \'(\'\"SharedReading\" \'0))\n(let $17 \'(\'\"AddBearerToToken\" \'\"1\"))\n(let $18 \'($15 $16 \'(\'\"ReconnectPeriod\" \'\"\") \'(\'\"Format\" \'\"json_each_row\") \'(\'\"ReadGroup\" \'\"ptcudqgd59n45nq17mca\") $17 \'(\'\"WatermarksEnable\" \'\"1\") \'(\'\"WatermarksGranularityUs\" \'\"500000\") \'(\'\"WatermarksLateArrivalDelayUs\" \'\"100000\") \'(\'\"WatermarksIdlePartitions\" \'\"1\") \'(\'\"WatermarksIdleTimeoutUs\" \'\"200000\")))\n(let $19 (SecureParam \'\"cluster:default_yds\"))\n(let $20 (DataType \'Timestamp))\n(let $21 (StructType \'(\'_yql_sys_tsp_write_time $20) $11 $13))\n(let $22 (DqPqTopicSource $8 $14 \'(\'\"pass\" \'\"ts\") $18 $19 \'\"B\\x19\\b\\x06\\x12\\x06\\x12\\x04pass\\x1A\\r\\n\\v\\n\\x02\\b\\x01\\x12\\x05\\x15\\x00\\x00\\x00\\x00\" $21 \'\"\"))\n(let $23 (Bool \'false))\n(let $24 (DqStage \'((DqSource $9 $22)) (lambda \'($28) (block \'(\n  (let $29 \'(\'(\'\"format\" \'\"json_each_row\") \'(\'\"metadataColumns\" \'(\'_yql_sys_tsp_write_time)) \'(\'\"formatSettings\" \'(\'(\'\"data.datetime.formatname\" \'\"POSIX\") \'(\'\"data.timestamp.formatname\" \'\"POSIX\"))) \'(\'\"settings\" \'($16))))\n  (let $30 (DqSourceWideWrap $28 $9 $21 $29))\n  (return (FlatMap (NarrowMap $30 (lambda \'($31 $32 $33) (AsStruct \'(\'_yql_sys_tsp_write_time $31) \'(\'\"pass\" $32) \'(\'\"ts\" $33)))) (lambda \'($34) (OptionalIf (Coalesce (> (Member $34 \'\"pass\") (Int32 \'0)) $23) (AsStruct \'(\'\"ts\" (Member $34 \'\"ts\")) \'(\'\"write_time\" (Member $34 \'_yql_sys_tsp_write_time)))))))\n))) \'(\'(\'\"_logical_id\" \'202256))))\n(let $25 (DataSink \'\"pq\" \'\"yds\"))\n(let $26 (PqTopic \'\"yds\" \'\"local\" \'\"test_idle_watermarks_no_shared_output\" $10 \'() (StructType \'(\'\"Data\" $12))))\n(let $27 (DqPqTopicSink $26 \'($15 $17) $19))\n(return (Commit! (DqQuery! $8 \'((DqStage \'((DqCnUnionAll (TDqOutput $24 \'0))) (lambda \'($35) (block \'(\n  (let $36 (Interval \'\"500000\"))\n  (let $37 (lambda \'($44) $44))\n  (let $38 (MultiHoppingCore (FromFlow $35) (lambda \'($39) (Uint32 \'0)) (lambda \'($40) (Member (SafeCast $40 (StructType \'(\'\"write_time\" $20))) \'\"write_time\")) $36 (Interval \'\"1000000\") $36 \'true (lambda \'($41) (AsStruct \'(\'AggregateList0 (AsList (Member $41 \'\"ts\"))))) (lambda \'($42 $43) (AsStruct \'(\'AggregateList0 (Insert (Member $43 \'AggregateList0) (Member $42 \'\"ts\"))))) $37 $37 (lambda \'($45 $46) (AsStruct \'(\'AggregateList0 (Extend (Member $45 \'AggregateList0) (Member $46 \'AggregateList0))))) (lambda \'($47 $48 $49) (AsStruct \'(\'AggregateList0 (Member $48 \'AggregateList0)) \'(\'\"group0\" $49))) \'\"1\"))\n  (return (FlatMap (ExtractMembers $38 \'(\'AggregateList0)) (lambda \'($50) (block \'(\n    (let $51 (ResourceType \'\"Yson2.Node\"))\n    (let $52 \'($51 \'\"\" \'\"1\"))\n    (let $53 (ResourceType \'\"Yson2.Options\"))\n    (let $54 (OptionalType (DataType \'Bool)))\n    (let $55 (CallableType \'(\'\"4\") \'((OptionalType (DataType \'Json))) $52 \'((OptionalType $53)) \'($54 \'\"SkipMapEntity\") \'($54 \'\"EncodeUtf8\") \'($54 \'\"WriteNanAsString\")))\n    (let $56 (Udf \'\"Yson2.SerializeJson\" (Void) (VoidType) \'\"\" $55 (VoidType) \'\"\" \'()))\n    (let $57 (StructType \'(\'\"result\" (ListType $12))))\n    (let $58 (TupleType (TupleType $57) (StructType) (TupleType)))\n    (let $59 (CallableType \'() \'($51) \'($57)))\n    (let $60 \'(\'(\'\"strict\")))\n    (let $61 (Udf \'\"Yson2.From\" (Void) $58 \'\"\" $59 (VoidType) \'\"\" $60))\n    (let $62 (CallableType \'(\'\"2\") \'($53) \'($54 \'\"AutoConvert\") \'($54 \'\"Strict\")))\n    (let $63 (Udf \'\"Yson2.Options\" (Void) (VoidType) \'\"\" $62 (VoidType) \'\"\" $60))\n    (return (Just (AsStruct \'(\'\"column0\" (ToBytes (Unwrap (Apply $56 (Apply $61 (AsStruct \'(\'\"result\" (Member $50 \'AggregateList0)))) (Just (NamedApply $63 \'() (AsStruct \'(\'\"AutoConvert\" (Just $23)) \'(\'\"Strict\" (Just (Bool \'true)))))))))))))\n  )))))\n))) \'(\'(\'\"_logical_id\" \'202553)) \'((DqSink \'0 $25 $27))))) $25))\n)\n"
  }
}

2025-12-09 03:43:36,774 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-12-09 03:43:39,776 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:11087/1
2025-12-09 03:43:39,777 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16853
2025-12-09 03:43:39,777 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23070
2025-12-09 03:43:39,778 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23723
2025-12-09 03:43:39,778 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11087
2025-12-09 03:43:39,778 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28598
2025-12-09 03:43:39,778 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20348
2025-12-09 03:43:40,779 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:6626/1
2025-12-09 03:43:40,780 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16708
2025-12-09 03:43:40,780 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20235
2025-12-09 03:43:40,781 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27736
2025-12-09 03:43:40,781 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6626
2025-12-09 03:43:40,781 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16974
2025-12-09 03:43:40,781 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8983
