2025-10-26 15:48:42,514 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:48:42,514 - INFO - ya.test - pytest_runtest_setup: test_sql_suite[plan-window.test]
2025-10-26 15:48:42,514 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:48:42,515 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 15:48:42,557 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/24645
2025-10-26 15:48:42,557 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 15:48:42,557 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 15:48:42,558 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/muiu/000787/r3tmp/kikimr__hw67a355
2025-10-26 15:48:42,582 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/8293
2025-10-26 15:48:42,583 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/19885
2025-10-26 15:48:42,583 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/19130
2025-10-26 15:48:42,584 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd
2025-10-26 15:48:42,584 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/testing_out_stuff/test_stream_query.py__TestStreamQuery__test_sql_suite[plan-window.test]/kikimr_configs"
2025-10-26 15:48:42,584 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/testing_out_stuff/test_stream_query.py__TestStreamQuery__test_sql_suite[plan-window.test]/node_1/logfile_a52xzme6.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=8293 --mon-port=19885 --ic-port=24645
2025-10-26 15:48:42,584 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:8293/1, disk_size 68719476736
2025-10-26 15:48:42,585 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/testing_out_stuff/test_stream_query.py__TestStreamQuery__test_sql_suite[plan-window.test]/node_1/logfile_a52xzme6.log', '--yaml-config=/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/testing_out_stuff/test_stream_query.py__TestStreamQuery__test_sql_suite[plan-window.test]/kikimr_configs/config.yaml', '--grpc-port=8293', '--mon-port=19885', '--ic-port=24645')' with input '/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/stdin' in '/home/runner/.ya/build/build_root/muiu/000787/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_stream_query/chunk0/testing_out_stuff/test_stream_query.py__TestStreamQuery__test_sql_suite[plan-window.test]/node_1' (no wait)
2025-10-26 15:48:42,586 - DEBUG - ya.test - execute: Command pid: 1543582
2025-10-26 15:48:42,586 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:8293/1
2025-10-26 15:48:44,223 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd
2025-10-26 15:48:44,223 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:8293', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 24645\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 15:48:44,224 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 15:48:44,224 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 15:48:44,224 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:8293', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 24645\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:48:44,225 - DEBUG - ya.test - execute: Command pid: 1543747
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) rc: 0
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) elapsed time (sec): 0.3232607841491699
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) idrss: 0
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) inblock: 0
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) isrss: 0
2025-10-26 15:48:44,549 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) ixrss: 0
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) majflt: 0
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) maxrss: 523204
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) minflt: 19023
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) msgrcv: 0
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) msgsnd: 0
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) nivcsw: 0
2025-10-26 15:48:44,550 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) nsignals: 0
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) nswap: 0
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) nvcsw: 133
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) oublock: 8
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) stime: 0.202761
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) utime: 0.07704899999999999
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) wtime: 0.324
2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 15:48:44,551 - DEBUG - ya.test - _save_outputs: Command (pid 1543747) errors:

2025-10-26 15:48:44,552 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd
2025-10-26 15:48:44,552 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:8293', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-10-26 15:48:44,553 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 15:48:44,553 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 15:48:44,554 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/000787/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:8293', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:48:44,554 - DEBUG - ya.test - execute: Command pid: 1543790
2025-10-26 15:48:44,868 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) rc: 0
2025-10-26 15:48:44,868 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) elapsed time (sec): 0.31250977516174316
2025-10-26 15:48:44,868 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) idrss: 0
2025-10-26 15:48:44,868 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) inblock: 0
2025-10-26 15:48:44,868 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) isrss: 0
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) ixrss: 0
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) majflt: 0
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) maxrss: 523200
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) minflt: 19025
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) msgrcv: 0
2025-10-26 15:48:44,869 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) msgsnd: 0
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) nivcsw: 0
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) nsignals: 0
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) nswap: 0
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) nvcsw: 124
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) oublock: 8
2025-10-26 15:48:44,870 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) stime: 0.17818799999999999
2025-10-26 15:48:44,871 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) utime: 0.091074
2025-10-26 15:48:44,871 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) wtime: 0.313
2025-10-26 15:48:44,871 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 15:48:44,871 - DEBUG - ya.test - _save_outputs: Command (pid 1543790) errors:

2025-10-26 15:48:44,884 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 15:48:44,908 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_stream_query.py::TestStreamQuery, test_name: test_sql_suite[plan-window.test])
2025-10-26 15:48:45,042 - INFO - root - assert_statement: Executed statement at line 0, suite from stream_query/window.test, in 0.133 seconds
2025-10-26 15:48:45,081 - INFO - root - assert_statement: Executed statement at line 9, suite from stream_query/window.test, in 0.038 seconds
2025-10-26 15:48:45,114 - INFO - root - assert_statement: Executed statement at line 22, suite from stream_query/window.test, in 0.032 seconds
2025-10-26 15:48:45,154 - INFO - root - assert_statement: Executed statement at line 43, suite from stream_query/window.test, in 0.039 seconds
2025-10-26 15:48:45,175 - INFO - root - assert_statement: Executed statement at line 46, suite from stream_query/window.test, in 0.021 seconds
2025-10-26 15:50:11,117 - INFO - root - assert_statement: Executed statement at line 49, suite from stream_query/window.test, in 85.941 seconds
2025-10-26 15:50:11,118 - INFO - root - assert_statement: Executed statement at line 52, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,118 - INFO - root - assert_statement: Executed statement at line 55, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,119 - INFO - root - assert_statement: Executed statement at line 59, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,119 - INFO - root - assert_statement: Executed statement at line 63, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,119 - INFO - root - assert_statement: Executed statement at line 66, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,120 - INFO - root - assert_statement: Executed statement at line 70, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,120 - INFO - root - assert_statement: Executed statement at line 74, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,121 - INFO - root - assert_statement: Executed statement at line 78, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,121 - INFO - root - assert_statement: Executed statement at line 81, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,121 - INFO - root - assert_statement: Executed statement at line 84, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,122 - INFO - root - assert_statement: Executed statement at line 87, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,122 - INFO - root - assert_statement: Executed statement at line 90, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,123 - INFO - root - assert_statement: Executed statement at line 93, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,123 - INFO - root - assert_statement: Executed statement at line 96, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,123 - INFO - root - assert_statement: Executed statement at line 99, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,123 - INFO - root - assert_statement: Executed statement at line 102, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,123 - INFO - root - assert_statement: Executed statement at line 105, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 108, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 111, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 114, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 117, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 120, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,124 - INFO - root - assert_statement: Executed statement at line 125, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 128, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 134, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 140, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 145, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 149, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,125 - INFO - root - assert_statement: Executed statement at line 156, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 168, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 171, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 177, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 186, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 192, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 199, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,126 - INFO - root - assert_statement: Executed statement at line 203, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 208, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 224, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 228, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 238, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 246, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,127 - INFO - root - assert_statement: Executed statement at line 254, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 262, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 270, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 278, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 285, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 292, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,128 - INFO - root - assert_statement: Executed statement at line 299, suite from stream_query/window.test, in 0.000 seconds
2025-10-26 15:50:11,130 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 15:50:11,141 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-26 15:50:18,143 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:8293/1
2025-10-26 15:50:18,144 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/19130
2025-10-26 15:50:18,144 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/19885
2025-10-26 15:50:18,144 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/8293
2025-10-26 15:50:18,144 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/24645
2025-10-26 15:50:18,378 - DEBUG - ya.test - _verify_test: Verifying [test_stream_query.TestStreamQuery.test_sql_suite[plan-window.test] in ydb/tests/functional/suite_tests] canonical results
2025-10-26 15:50:18,402 - DEBUG - ya.test - verify: Test test_stream_query.TestStreamQuery.test_sql_suite[plan-window.test] status: good
