2025-10-26 15:55:00,421 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:55:00,421 - INFO - ya.test - pytest_runtest_setup: test_sql_suite[results-create_table.test]
2025-10-26 15:55:00,422 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:55:00,422 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 15:55:00,503 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/29834
2025-10-26 15:55:00,504 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 15:55:00,504 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 15:55:00,505 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/muiu/000770/r3tmp/kikimr__0ioyczf0
2025-10-26 15:55:00,549 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/2644
2025-10-26 15:55:00,549 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/17609
2025-10-26 15:55:00,550 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/11328
2025-10-26 15:55:00,550 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd
2025-10-26 15:55:00,551 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-create_table.test]/kikimr_configs"
2025-10-26 15:55:00,551 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-create_table.test]/node_1/logfile_c2mzeery.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=2644 --mon-port=17609 --ic-port=29834
2025-10-26 15:55:00,551 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:2644/1, disk_size 68719476736
2025-10-26 15:55:00,552 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-create_table.test]/node_1/logfile_c2mzeery.log', '--yaml-config=/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-create_table.test]/kikimr_configs/config.yaml', '--grpc-port=2644', '--mon-port=17609', '--ic-port=29834')' with input '/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/stdin' in '/home/runner/.ya/build/build_root/muiu/000770/ydb/tests/functional/suite_tests/test-results/py3test/testing_out_stuff/test_postgres/chunk6/testing_out_stuff/test_postgres.py__TestPGSQL__test_sql_suite[results-create_table.test]/node_1' (no wait)
2025-10-26 15:55:00,554 - DEBUG - ya.test - execute: Command pid: 1599022
2025-10-26 15:55:00,554 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2644/1
2025-10-26 15:55:02,196 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd
2025-10-26 15:55:02,196 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:2644', '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: 29834\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 15:55:02,197 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 15:55:02,197 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 15:55:02,197 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:2644', '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: 29834\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:55:02,198 - DEBUG - ya.test - execute: Command pid: 1599294
2025-10-26 15:55:02,509 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) rc: 0
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) elapsed time (sec): 0.31072211265563965
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) idrss: 0
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) inblock: 0
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) isrss: 0
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) ixrss: 0
2025-10-26 15:55:02,510 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) majflt: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) maxrss: 523192
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) minflt: 19024
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) msgrcv: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) msgsnd: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) nivcsw: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) nsignals: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) nswap: 0
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) nvcsw: 139
2025-10-26 15:55:02,511 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) oublock: 8
2025-10-26 15:55:02,512 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) stime: 0.20513699999999999
2025-10-26 15:55:02,512 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) utime: 0.063119
2025-10-26 15:55:02,512 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) wtime: 0.312
2025-10-26 15:55:02,512 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 15:55:02,512 - DEBUG - ya.test - _save_outputs: Command (pid 1599294) errors:

2025-10-26 15:55:02,513 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd
2025-10-26 15:55:02,513 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:2644', '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:55:02,514 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 15:55:02,514 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 15:55:02,514 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/muiu/000770/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:2644', '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:55:02,515 - DEBUG - ya.test - execute: Command pid: 1599409
2025-10-26 15:55:02,822 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) rc: 0
2025-10-26 15:55:02,822 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) elapsed time (sec): 0.306016206741333
2025-10-26 15:55:02,822 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) idrss: 0
2025-10-26 15:55:02,822 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) inblock: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) isrss: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) ixrss: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) majflt: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) maxrss: 523208
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) minflt: 19021
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) msgrcv: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) msgsnd: 0
2025-10-26 15:55:02,823 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) nivcsw: 1
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) nsignals: 0
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) nswap: 0
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) nvcsw: 135
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) oublock: 8
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) stime: 0.17393699999999998
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) utime: 0.088991
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) wtime: 0.307
2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 15:55:02,824 - DEBUG - ya.test - _save_outputs: Command (pid 1599409) errors:

2025-10-26 15:55:02,841 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 15:55:02,864 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_postgres.py::TestPGSQL, test_name: test_sql_suite[results-create_table.test])
2025-10-26 15:55:02,964 - INFO - root - assert_statement: Executed statement at line 4, suite from postgres/create_table.test, in 0.099 seconds
2025-10-26 15:55:03,003 - INFO - root - assert_statement: Executed statement at line 11, suite from postgres/create_table.test, in 0.039 seconds
2025-10-26 15:55:03,043 - INFO - root - assert_statement: Executed statement at line 18, suite from postgres/create_table.test, in 0.040 seconds
2025-10-26 15:55:03,084 - INFO - root - assert_statement: Executed statement at line 39, suite from postgres/create_table.test, in 0.040 seconds
2025-10-26 15:55:03,123 - INFO - root - assert_statement: Executed statement at line 60, suite from postgres/create_table.test, in 0.039 seconds
2025-10-26 15:55:03,163 - INFO - root - assert_statement: Executed statement at line 81, suite from postgres/create_table.test, in 0.040 seconds
2025-10-26 15:55:03,164 - INFO - root - assert_statement: Executed statement at line 90, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,164 - INFO - root - assert_statement: Executed statement at line 96, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,203 - INFO - root - assert_statement: Executed statement at line 102, suite from postgres/create_table.test, in 0.039 seconds
2025-10-26 15:55:03,243 - INFO - root - assert_statement: Executed statement at line 113, suite from postgres/create_table.test, in 0.040 seconds
2025-10-26 15:55:03,283 - INFO - root - assert_statement: Executed statement at line 123, suite from postgres/create_table.test, in 0.040 seconds
2025-10-26 15:55:03,284 - INFO - root - assert_statement: Executed statement at line 136, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,323 - INFO - root - assert_statement: Executed statement at line 144, suite from postgres/create_table.test, in 0.039 seconds
2025-10-26 15:55:03,324 - INFO - root - assert_statement: Executed statement at line 157, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,324 - INFO - root - assert_statement: Executed statement at line 162, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,324 - INFO - root - assert_statement: Executed statement at line 168, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,324 - INFO - root - assert_statement: Executed statement at line 171, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,324 - INFO - root - assert_statement: Executed statement at line 176, suite from postgres/create_table.test, in 0.000 seconds
2025-10-26 15:55:03,326 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 15:55:09,049 - DEBUG - ya.test - _verify_test: Verifying [test_postgres.TestPGSQL.test_sql_suite[results-create_table.test] in ydb/tests/functional/suite_tests] canonical results
2025-10-26 15:55:09,072 - DEBUG - ya.test - verify: Test test_postgres.TestPGSQL.test_sql_suite[results-create_table.test] status: good
