2025-10-31 16:30:21,532 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 16:30:21,533 - INFO - ya.test - pytest_runtest_setup: test_create_drop_and_alter_database
2025-10-31 16:30:21,533 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 16:30:21,533 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 16:30:21,661 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd
2025-10-31 16:30:21,663 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22875
2025-10-31 16:30:21,667 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_canonical_records
2025-10-31 16:30:21,667 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-10-31 16:30:21,669 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/lr4u/001d27/r3tmp/kikimr_cluster_hyoe_t_r
2025-10-31 16:30:21,721 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd
2025-10-31 16:30:21,722 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26218
2025-10-31 16:30:21,723 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14103
2025-10-31 16:30:21,723 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62262
2025-10-31 16:30:21,724 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20424
2025-10-31 16:30:21,725 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs"
2025-10-31 16:30:21,726 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/node_1/logfile_bou0epaj.log --grpc-port=26218 --mon-port=14103 --ic-port=22875
2025-10-31 16:30:21,726 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:26218/1, disk_size 68719476736
2025-10-31 16:30:21,727 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:2:64 on node localhost:26218/1, disk_size 68719476736
2025-10-31 16:30:21,727 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs"
2025-10-31 16:30:21,728 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/node_1/logfile_bou0epaj.log --grpc-port=26218 --mon-port=14103 --ic-port=22875
2025-10-31 16:30:21,729 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/node_1/logfile_bou0epaj.log', '--grpc-port=26218', '--mon-port=14103', '--ic-port=22875')' in '/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/node_1' (no wait)
2025-10-31 16:30:21,733 - DEBUG - ya.test - execute: Command pid: 1096064
2025-10-31 16:30:21,735 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:26218/1
2025-10-31 16:30:21,737 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 16:30:21,737 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 16:30:21,738 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 16:30:21,750 - DEBUG - ya.test - execute: Command pid: 1096065
2025-10-31 16:30:22,741 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) rc: 0
2025-10-31 16:30:22,742 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) elapsed time (sec): 0.9844770431518555
2025-10-31 16:30:22,742 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) idrss: 0
2025-10-31 16:30:22,742 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) inblock: 0
2025-10-31 16:30:22,743 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) isrss: 0
2025-10-31 16:30:22,743 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) ixrss: 0
2025-10-31 16:30:22,743 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) majflt: 0
2025-10-31 16:30:22,743 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) maxrss: 484348
2025-10-31 16:30:22,743 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) minflt: 45374
2025-10-31 16:30:22,744 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) msgrcv: 0
2025-10-31 16:30:22,744 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) msgsnd: 0
2025-10-31 16:30:22,745 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) nivcsw: 244
2025-10-31 16:30:22,745 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) nsignals: 0
2025-10-31 16:30:22,745 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) nswap: 0
2025-10-31 16:30:22,746 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) nvcsw: 14
2025-10-31 16:30:22,746 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) oublock: 8
2025-10-31 16:30:22,746 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) stime: 0.28743399999999997
2025-10-31 16:30:22,747 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) utime: 0.589943
2025-10-31 16:30:22,747 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) wtime: 0.996
2025-10-31 16:30:22,747 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) output:
Git info:
    Commit: f77d4c0db8e29b711e291c6e811417b1705d98de
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 8194541ce3db03442342000f56fca16c047713d3 into 4af0266bcdc7df80879f060afb0976424f2118ed

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-pwt6hfepdq
    Host information: 
        Linux ghrun-pwt6hfepdq 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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 -DNDEBUG -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-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 -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -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-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-10-31 16:30:22,748 - DEBUG - ya.test - _save_outputs: Command (pid 1096065) errors:

2025-10-31 16:30:22,749 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: f77d4c0db8e29b711e291c6e811417b1705d98de
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 8194541ce3db03442342000f56fca16c047713d3 into 4af0266bcdc7df80879f060afb0976424f2118ed
2025-10-31 16:30:28,096 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd
2025-10-31 16:30:28,097 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:26218', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n    Drive {\n      Path: "SectorMap:2:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 22875\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 16:30:28,098 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 16:30:28,099 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 16:30:28,099 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:26218', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n    Drive {\n      Path: "SectorMap:2:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 22875\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 16:30:28,101 - DEBUG - ya.test - execute: Command pid: 1096494
2025-10-31 16:30:29,242 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) rc: 0
2025-10-31 16:30:29,243 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) elapsed time (sec): 1.1361634731292725
2025-10-31 16:30:29,243 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) idrss: 0
2025-10-31 16:30:29,244 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) inblock: 0
2025-10-31 16:30:29,244 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) isrss: 0
2025-10-31 16:30:29,244 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) ixrss: 0
2025-10-31 16:30:29,245 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) majflt: 0
2025-10-31 16:30:29,245 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) maxrss: 587424
2025-10-31 16:30:29,245 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) minflt: 51458
2025-10-31 16:30:29,298 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) msgrcv: 0
2025-10-31 16:30:29,299 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) msgsnd: 0
2025-10-31 16:30:29,299 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) nivcsw: 219
2025-10-31 16:30:29,299 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) nsignals: 0
2025-10-31 16:30:29,300 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) nswap: 0
2025-10-31 16:30:29,300 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) nvcsw: 410
2025-10-31 16:30:29,300 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) oublock: 8
2025-10-31 16:30:29,301 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) stime: 0.38450799999999996
2025-10-31 16:30:29,301 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) utime: 0.611568
2025-10-31 16:30:29,301 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) wtime: 1.138
2025-10-31 16:30:29,301 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 16:30:29,302 - DEBUG - ya.test - _save_outputs: Command (pid 1096494) errors:

2025-10-31 16:30:29,304 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd
2025-10-31 16:30:29,305 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:26218', '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-31 16:30:29,310 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 16:30:29,311 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 16:30:29,312 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:26218', '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-31 16:30:29,318 - DEBUG - ya.test - execute: Command pid: 1096736
2025-10-31 16:30:30,510 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) rc: 0
2025-10-31 16:30:30,511 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) elapsed time (sec): 1.1908903121948242
2025-10-31 16:30:30,511 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) idrss: 0
2025-10-31 16:30:30,512 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) inblock: 0
2025-10-31 16:30:30,512 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) isrss: 0
2025-10-31 16:30:30,512 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) ixrss: 0
2025-10-31 16:30:30,513 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) majflt: 0
2025-10-31 16:30:30,513 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) maxrss: 587424
2025-10-31 16:30:30,513 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) minflt: 51658
2025-10-31 16:30:30,514 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) msgrcv: 0
2025-10-31 16:30:30,514 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) msgsnd: 0
2025-10-31 16:30:30,515 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) nivcsw: 170
2025-10-31 16:30:30,515 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) nsignals: 0
2025-10-31 16:30:30,515 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) nswap: 0
2025-10-31 16:30:30,516 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) nvcsw: 838
2025-10-31 16:30:30,516 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) oublock: 8
2025-10-31 16:30:30,516 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) stime: 0.28257
2025-10-31 16:30:30,517 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) utime: 0.6537459999999999
2025-10-31 16:30:30,517 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) wtime: 1.197
2025-10-31 16:30:30,517 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-31 16:30:30,518 - DEBUG - ya.test - _save_outputs: Command (pid 1096736) errors:

2025-10-31 16:30:30,519 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 16:30:30,604 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 16:30:30,630 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_canonical_records.py, test_name: test_create_drop_and_alter_database)
2025-10-31 16:31:31,287 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd
2025-10-31 16:31:31,288 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22073
2025-10-31 16:31:31,289 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9391
2025-10-31 16:31:31,289 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27408
2025-10-31 16:31:31,290 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10904
2025-10-31 16:31:31,290 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7138
2025-10-31 16:31:31,292 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs"
2025-10-31 16:31:31,292 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26218 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/slot_1/logfile_asy0j4wc.log --grpc-port=22073 --mon-port=9391 --ic-port=27408
2025-10-31 16:31:31,293 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs"
2025-10-31 16:31:31,293 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26218 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/slot_1/logfile_asy0j4wc.log --grpc-port=22073 --mon-port=9391 --ic-port=27408
2025-10-31 16:31:31,295 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:26218', '--tenant=/Root/Database', '--log-file-name=/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/slot_1/logfile_asy0j4wc.log', '--grpc-port=22073', '--mon-port=9391', '--ic-port=27408')' in '/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/test_canonical_records.py.test_create_drop_and_alter_database/cluster/slot_1' (no wait)
2025-10-31 16:31:31,298 - DEBUG - ya.test - execute: Command pid: 1104931
2025-10-31 16:31:31,299 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:22073/1
2025-10-31 16:31:31,300 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-31 16:31:31,301 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-31 16:31:31,302 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 16:31:31,303 - DEBUG - ya.test - execute: Command pid: 1104933
2025-10-31 16:31:32,076 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) rc: 0
2025-10-31 16:31:32,077 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) elapsed time (sec): 0.771660327911377
2025-10-31 16:31:32,077 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) idrss: 0
2025-10-31 16:31:32,078 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) inblock: 0
2025-10-31 16:31:32,078 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) isrss: 0
2025-10-31 16:31:32,078 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) ixrss: 0
2025-10-31 16:31:32,079 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) majflt: 0
2025-10-31 16:31:32,079 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) maxrss: 587424
2025-10-31 16:31:32,079 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) minflt: 45358
2025-10-31 16:31:32,079 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) msgrcv: 0
2025-10-31 16:31:32,080 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) msgsnd: 0
2025-10-31 16:31:32,080 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) nivcsw: 1
2025-10-31 16:31:32,080 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) nsignals: 0
2025-10-31 16:31:32,081 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) nswap: 0
2025-10-31 16:31:32,081 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) nvcsw: 15
2025-10-31 16:31:32,081 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) oublock: 8
2025-10-31 16:31:32,081 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) stime: 0.231699
2025-10-31 16:31:32,082 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) utime: 0.495538
2025-10-31 16:31:32,082 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) wtime: 0.773
2025-10-31 16:31:32,082 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) output:
Git info:
    Commit: f77d4c0db8e29b711e291c6e811417b1705d98de
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 8194541ce3db03442342000f56fca16c047713d3 into 4af0266bcdc7df80879f060afb0976424f2118ed

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-pwt6hfepdq
    Host information: 
        Linux ghrun-pwt6hfepdq 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/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/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 -DNDEBUG -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-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 -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -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-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-10-31 16:31:32,083 - DEBUG - ya.test - _save_outputs: Command (pid 1104933) errors:

2025-10-31 16:31:32,083 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: f77d4c0db8e29b711e291c6e811417b1705d98de
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 8194541ce3db03442342000f56fca16c047713d3 into 4af0266bcdc7df80879f060afb0976424f2118ed
2025-10-31 16:33:08,656 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-10-31 16:33:08,658 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-10-31 16:33:08,659 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:26218', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/enable_scheme_shard_audit.pb.txt']' in 'None' (waiting)
2025-10-31 16:33:08,675 - DEBUG - ya.test - execute: Command pid: 1119713
2025-10-31 16:33:11,015 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) rc: 0
2025-10-31 16:33:11,016 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) elapsed time (sec): 2.3388662338256836
2025-10-31 16:33:11,016 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) idrss: 0
2025-10-31 16:33:11,017 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) inblock: 0
2025-10-31 16:33:11,017 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) isrss: 0
2025-10-31 16:33:11,017 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) ixrss: 0
2025-10-31 16:33:11,034 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) majflt: 0
2025-10-31 16:33:11,035 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) maxrss: 588460
2025-10-31 16:33:11,036 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) minflt: 52651
2025-10-31 16:33:11,036 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) msgrcv: 0
2025-10-31 16:33:11,036 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) msgsnd: 0
2025-10-31 16:33:11,037 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) nivcsw: 302
2025-10-31 16:33:11,037 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) nsignals: 0
2025-10-31 16:33:11,037 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) nswap: 0
2025-10-31 16:33:11,038 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) nvcsw: 602
2025-10-31 16:33:11,059 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) oublock: 0
2025-10-31 16:33:11,060 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) stime: 0.39533599999999997
2025-10-31 16:33:11,060 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) utime: 0.744379
2025-10-31 16:33:11,060 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) wtime: 2.355
2025-10-31 16:33:11,061 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) output:

2025-10-31 16:33:11,061 - DEBUG - ya.test - _save_outputs: Command (pid 1119713) errors:

2025-10-31 16:33:11,083 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-10-31 16:33:11,085 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-10-31 16:33:11,085 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/lr4u/001d27/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:26218', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/lr4u/001d27/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_canonical_records/chunk0/testing_out_stuff/disable_scheme_shard_audit.pb.txt']' in 'None' (waiting)
2025-10-31 16:33:11,107 - DEBUG - ya.test - execute: Command pid: 1120263
2025-10-31 16:33:13,855 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) rc: 0
2025-10-31 16:33:13,856 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) elapsed time (sec): 2.746829032897949
2025-10-31 16:33:13,856 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) idrss: 0
2025-10-31 16:33:13,857 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) inblock: 0
2025-10-31 16:33:13,857 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) isrss: 0
2025-10-31 16:33:13,857 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) ixrss: 0
2025-10-31 16:33:13,858 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) majflt: 0
2025-10-31 16:33:13,858 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) maxrss: 588916
2025-10-31 16:33:13,858 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) minflt: 52603
2025-10-31 16:33:13,858 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) msgrcv: 0
2025-10-31 16:33:13,859 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) msgsnd: 0
2025-10-31 16:33:13,859 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) nivcsw: 308
2025-10-31 16:33:13,860 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) nsignals: 0
2025-10-31 16:33:13,860 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) nswap: 0
2025-10-31 16:33:13,860 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) nvcsw: 592
2025-10-31 16:33:13,860 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) oublock: 0
2025-10-31 16:33:13,861 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) stime: 0.39117399999999997
2025-10-31 16:33:13,861 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) utime: 0.716422
2025-10-31 16:33:13,861 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) wtime: 2.756
2025-10-31 16:33:13,862 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) output:

2025-10-31 16:33:13,862 - DEBUG - ya.test - _save_outputs: Command (pid 1120263) errors:

2025-10-31 16:34:44,654 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/Database
2025-10-31 16:34:44,655 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/Database: send console operation, token root@builtin
2025-10-31 16:34:44,711 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/Database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/Database&cmstid=72057594037936131&txid=1761928484690835&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-10-31 16:34:44,712 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: wait console operation done
2025-10-31 16:34:45,259 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: console operation done
2025-10-31 16:34:45,260 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: wait tenant gone
2025-10-31 16:34:45,290 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: tenant gone
2025-10-31 16:35:54,345 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:22073/1
2025-10-31 16:35:54,363 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 16:35:54,364 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_canonical_records
2025-10-31 16:36:06,373 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:26218/1
2025-10-31 16:36:06,377 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7138
2025-10-31 16:36:06,378 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10904
2025-10-31 16:36:06,378 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27408
2025-10-31 16:36:06,379 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9391
2025-10-31 16:36:06,379 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22073
2025-10-31 16:36:06,380 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20424
2025-10-31 16:36:06,395 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62262
2025-10-31 16:36:06,396 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14103
2025-10-31 16:36:06,396 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26218
2025-10-31 16:36:06,396 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22875
2025-10-31 16:36:09,259 - DEBUG - ya.test - _verify_test: Verifying [test_canonical_records.test_create_drop_and_alter_database in ydb/tests/functional/audit] canonical results
2025-10-31 16:36:09,298 - DEBUG - ya.test - verify: Test test_canonical_records.test_create_drop_and_alter_database status: good
