2025-10-26 15:52:57,856 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:52:57,856 - INFO - ya.test - pytest_runtest_setup: test_sql_suite[results-select_distinct.test]
2025-10-26 15:52:57,856 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:52:57,856 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 15:52:57,933 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/11984
2025-10-26 15:52:57,934 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 15:52:57,934 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 15:52:57,935 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/muiu/00078a/r3tmp/kikimr__lounw86c
2025-10-26 15:52:57,964 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/10417
2025-10-26 15:52:57,965 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/1650
2025-10-26 15:52:57,965 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/64649
2025-10-26 15:52:57,966 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd
2025-10-26 15:52:57,966 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-select_distinct.test]/kikimr_configs"
2025-10-26 15:52:57,966 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-select_distinct.test]/node_1/logfile_d_v23s63.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=10417 --mon-port=1650 --ic-port=11984
2025-10-26 15:52:57,966 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:10417/1, disk_size 68719476736
2025-10-26 15:52:57,967 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-select_distinct.test]/node_1/logfile_d_v23s63.log', '--yaml-config=/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-select_distinct.test]/kikimr_configs/config.yaml', '--grpc-port=10417', '--mon-port=1650', '--ic-port=11984')' with input '/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/stdin' in '/home/runner/.ya/build/build_root/muiu/00078a/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk9/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-select_distinct.test]/node_1' (no wait)
2025-10-26 15:52:57,968 - DEBUG - ya.test - execute: Command pid: 1580389
2025-10-26 15:52:57,969 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:10417/1
2025-10-26 15:52:59,656 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd
2025-10-26 15:52:59,656 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:10417', '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: 11984\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 15:52:59,657 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 15:52:59,657 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 15:52:59,657 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:10417', '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: 11984\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:52:59,658 - DEBUG - ya.test - execute: Command pid: 1580873
2025-10-26 15:53:00,019 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) rc: 0
2025-10-26 15:53:00,020 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) elapsed time (sec): 0.3606984615325928
2025-10-26 15:53:00,020 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) idrss: 0
2025-10-26 15:53:00,020 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) inblock: 0
2025-10-26 15:53:00,020 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) isrss: 0
2025-10-26 15:53:00,020 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) ixrss: 0
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) majflt: 0
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) maxrss: 523204
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) minflt: 19025
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) msgrcv: 0
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) msgsnd: 0
2025-10-26 15:53:00,021 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) nivcsw: 2
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) nsignals: 0
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) nswap: 0
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) nvcsw: 140
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) oublock: 8
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) stime: 0.220263
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) utime: 0.099118
2025-10-26 15:53:00,022 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) wtime: 0.362
2025-10-26 15:53:00,023 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-26 15:53:00,023 - DEBUG - ya.test - _save_outputs: Command (pid 1580873) errors:

2025-10-26 15:53:00,024 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd
2025-10-26 15:53:00,024 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:10417', '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:53:00,024 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 15:53:00,025 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 15:53:00,025 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/00078a/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:10417', '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:53:00,026 - DEBUG - ya.test - execute: Command pid: 1580959
2025-10-26 15:53:00,383 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) rc: 0
2025-10-26 15:53:00,383 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) elapsed time (sec): 0.3560791015625
2025-10-26 15:53:00,383 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) idrss: 0
2025-10-26 15:53:00,383 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) inblock: 0
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) isrss: 0
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) ixrss: 0
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) majflt: 0
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) maxrss: 523084
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) minflt: 19892
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) msgrcv: 0
2025-10-26 15:53:00,384 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) msgsnd: 0
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) nivcsw: 0
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) nsignals: 0
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) nswap: 0
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) nvcsw: 132
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) oublock: 8
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) stime: 0.224332
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) utime: 0.089733
2025-10-26 15:53:00,385 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) wtime: 0.357
2025-10-26 15:53:00,386 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 15:53:00,386 - DEBUG - ya.test - _save_outputs: Command (pid 1580959) errors:

2025-10-26 15:53:00,400 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 15:53:00,427 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_postgres.py::TestPGSQL, test_name: test_sql_suite[results-select_distinct.test])
2025-10-26 15:53:00,524 - INFO - root - assert_statement: Executed statement at line 5, suite from postgres/select_distinct.test, in 0.095 seconds
2025-10-26 15:53:10,630 - INFO - root - assert_statement: Executed statement at line 26, suite from postgres/select_distinct.test, in 10.106 seconds
2025-10-26 15:53:10,669 - INFO - root - assert_statement: Executed statement at line 29, suite from postgres/select_distinct.test, in 0.038 seconds
2025-10-26 15:54:39,263 - INFO - root - assert_statement: Executed statement at line 50, suite from postgres/select_distinct.test, in 88.594 seconds
2025-10-26 15:54:39,349 - INFO - root - assert_statement: Executed statement at line 54, suite from postgres/select_distinct.test, in 0.086 seconds
2025-10-26 15:54:39,439 - INFO - root - assert_statement: Executed statement at line 57, suite from postgres/select_distinct.test, in 0.089 seconds
2025-10-26 15:54:39,533 - INFO - root - assert_statement: Executed statement at line 60, suite from postgres/select_distinct.test, in 0.093 seconds
2025-10-26 15:54:39,663 - INFO - root - assert_statement: Executed statement at line 63, suite from postgres/select_distinct.test, in 0.129 seconds
2025-10-26 15:54:39,825 - INFO - root - assert_statement: Executed statement at line 93, suite from postgres/select_distinct.test, in 0.162 seconds
2025-10-26 15:54:39,854 - INFO - root - assert_statement: Executed statement at line 97, suite from postgres/select_distinct.test, in 0.029 seconds
2025-10-26 15:54:39,880 - INFO - root - assert_statement: Executed statement at line 100, suite from postgres/select_distinct.test, in 0.026 seconds
2025-10-26 15:54:39,905 - INFO - root - assert_statement: Executed statement at line 103, suite from postgres/select_distinct.test, in 0.024 seconds
2025-10-26 15:54:39,927 - INFO - root - assert_statement: Executed statement at line 106, suite from postgres/select_distinct.test, in 0.021 seconds
2025-10-26 15:54:39,953 - INFO - root - assert_statement: Executed statement at line 109, suite from postgres/select_distinct.test, in 0.026 seconds
2025-10-26 15:54:39,953 - INFO - root - assert_statement: Executed statement at line 112, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,953 - INFO - root - assert_statement: Executed statement at line 122, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 131, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 140, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 150, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 156, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 162, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 168, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 174, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,954 - INFO - root - assert_statement: Executed statement at line 180, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,955 - INFO - root - assert_statement: Executed statement at line 186, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,955 - INFO - root - assert_statement: Executed statement at line 192, suite from postgres/select_distinct.test, in 0.000 seconds
2025-10-26 15:54:39,956 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 15:54:49,452 - DEBUG - ya.test - _verify_test: Verifying [test_postgres.TestPGSQL.test_sql_suite[results-select_distinct.test] in ydb/tests/functional/suite_tests] canonical results
2025-10-26 15:54:49,479 - DEBUG - ya.test - verify: Test test_postgres.TestPGSQL.test_sql_suite[results-select_distinct.test] status: good
