2025-12-05 13:44:16,270 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-05 13:44:16,271 - INFO - ya.test - pytest_runtest_setup: test_create_drop_and_alter_database
2025-12-05 13:44:16,271 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-05 13:44:16,271 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-05 13:44:16,381 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd
2025-12-05 13:44:16,383 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22712
2025-12-05 13:44:16,386 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_canonical_records
2025-12-05 13:44:16,386 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-12-05 13:44:16,387 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/kvke/001157/r3tmp/kikimr_cluster_0ub35iap
2025-12-05 13:44:16,432 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd
2025-12-05 13:44:16,433 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27088
2025-12-05 13:44:16,433 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63021
2025-12-05 13:44:16,434 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1453
2025-12-05 13:44:16,434 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3647
2025-12-05 13:44:16,435 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:44:16,436 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/kvke/001157/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/kvke/001157/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_vdskmhu3.log --grpc-port=27088 --mon-port=63021 --ic-port=22712
2025-12-05 13:44:16,436 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:27088/1, disk_size 68719476736
2025-12-05 13:44:16,437 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:2:64 on node localhost:27088/1, disk_size 68719476736
2025-12-05 13:44:16,437 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:44:16,437 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/kvke/001157/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/kvke/001157/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_vdskmhu3.log --grpc-port=27088 --mon-port=63021 --ic-port=22712
2025-12-05 13:44:16,439 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/kvke/001157/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/kvke/001157/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_vdskmhu3.log', '--grpc-port=27088', '--mon-port=63021', '--ic-port=22712')' in '/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:44:16,442 - DEBUG - ya.test - execute: Command pid: 547654
2025-12-05 13:44:16,443 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:27088/1
2025-12-05 13:44:16,444 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-12-05 13:44:16,445 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-12-05 13:44:16,445 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-05 13:44:16,447 - DEBUG - ya.test - execute: Command pid: 547678
2025-12-05 13:44:17,264 - DEBUG - ya.test - _save_outputs: Command (pid 547678) rc: 0
2025-12-05 13:44:17,265 - DEBUG - ya.test - _save_outputs: Command (pid 547678) elapsed time (sec): 0.8168008327484131
2025-12-05 13:44:17,266 - DEBUG - ya.test - _save_outputs: Command (pid 547678) idrss: 0
2025-12-05 13:44:17,266 - DEBUG - ya.test - _save_outputs: Command (pid 547678) inblock: 0
2025-12-05 13:44:17,266 - DEBUG - ya.test - _save_outputs: Command (pid 547678) isrss: 0
2025-12-05 13:44:17,266 - DEBUG - ya.test - _save_outputs: Command (pid 547678) ixrss: 0
2025-12-05 13:44:17,267 - DEBUG - ya.test - _save_outputs: Command (pid 547678) majflt: 0
2025-12-05 13:44:17,267 - DEBUG - ya.test - _save_outputs: Command (pid 547678) maxrss: 479340
2025-12-05 13:44:17,267 - DEBUG - ya.test - _save_outputs: Command (pid 547678) minflt: 45406
2025-12-05 13:44:17,267 - DEBUG - ya.test - _save_outputs: Command (pid 547678) msgrcv: 0
2025-12-05 13:44:17,268 - DEBUG - ya.test - _save_outputs: Command (pid 547678) msgsnd: 0
2025-12-05 13:44:17,268 - DEBUG - ya.test - _save_outputs: Command (pid 547678) nivcsw: 203
2025-12-05 13:44:17,268 - DEBUG - ya.test - _save_outputs: Command (pid 547678) nsignals: 0
2025-12-05 13:44:17,269 - DEBUG - ya.test - _save_outputs: Command (pid 547678) nswap: 0
2025-12-05 13:44:17,269 - DEBUG - ya.test - _save_outputs: Command (pid 547678) nvcsw: 14
2025-12-05 13:44:17,269 - DEBUG - ya.test - _save_outputs: Command (pid 547678) oublock: 8
2025-12-05 13:44:17,269 - DEBUG - ya.test - _save_outputs: Command (pid 547678) stime: 0.211029
2025-12-05 13:44:17,270 - DEBUG - ya.test - _save_outputs: Command (pid 547678) utime: 0.486326
2025-12-05 13:44:17,270 - DEBUG - ya.test - _save_outputs: Command (pid 547678) wtime: 0.819
2025-12-05 13:44:17,270 - DEBUG - ya.test - _save_outputs: Command (pid 547678) output:
Git info:
    Commit: 9a02a3b9d304ae3db299329ab9f1e2779d1ed4ff
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge 110da6e58e84d1d47f793feefdb3f536909c7fc7 into 585820908c1313b1f0acebdafacf03477ac71cd2

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mj3z7qugmi
    Host information: 
        Linux ghrun-mj3z7qugmi 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 -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-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 -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-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-05 13:44:17,271 - DEBUG - ya.test - _save_outputs: Command (pid 547678) errors:

2025-12-05 13:44:17,271 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 9a02a3b9d304ae3db299329ab9f1e2779d1ed4ff
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge 110da6e58e84d1d47f793feefdb3f536909c7fc7 into 585820908c1313b1f0acebdafacf03477ac71cd2
2025-12-05 13:44:22,481 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd
2025-12-05 13:44:22,483 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27088', '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: 22712\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-05 13:44:22,484 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-12-05 13:44:22,485 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-12-05 13:44:22,485 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27088', '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: 22712\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-05 13:44:22,488 - DEBUG - ya.test - execute: Command pid: 549883
2025-12-05 13:44:23,773 - DEBUG - ya.test - _save_outputs: Command (pid 549883) rc: 0
2025-12-05 13:44:23,774 - DEBUG - ya.test - _save_outputs: Command (pid 549883) elapsed time (sec): 1.284820795059204
2025-12-05 13:44:23,774 - DEBUG - ya.test - _save_outputs: Command (pid 549883) idrss: 0
2025-12-05 13:44:23,775 - DEBUG - ya.test - _save_outputs: Command (pid 549883) inblock: 0
2025-12-05 13:44:23,775 - DEBUG - ya.test - _save_outputs: Command (pid 549883) isrss: 0
2025-12-05 13:44:23,775 - DEBUG - ya.test - _save_outputs: Command (pid 549883) ixrss: 0
2025-12-05 13:44:23,775 - DEBUG - ya.test - _save_outputs: Command (pid 549883) majflt: 0
2025-12-05 13:44:23,776 - DEBUG - ya.test - _save_outputs: Command (pid 549883) maxrss: 583504
2025-12-05 13:44:23,776 - DEBUG - ya.test - _save_outputs: Command (pid 549883) minflt: 51844
2025-12-05 13:44:23,776 - DEBUG - ya.test - _save_outputs: Command (pid 549883) msgrcv: 0
2025-12-05 13:44:23,777 - DEBUG - ya.test - _save_outputs: Command (pid 549883) msgsnd: 0
2025-12-05 13:44:23,777 - DEBUG - ya.test - _save_outputs: Command (pid 549883) nivcsw: 212
2025-12-05 13:44:23,777 - DEBUG - ya.test - _save_outputs: Command (pid 549883) nsignals: 0
2025-12-05 13:44:23,777 - DEBUG - ya.test - _save_outputs: Command (pid 549883) nswap: 0
2025-12-05 13:44:23,777 - DEBUG - ya.test - _save_outputs: Command (pid 549883) nvcsw: 675
2025-12-05 13:44:23,778 - DEBUG - ya.test - _save_outputs: Command (pid 549883) oublock: 8
2025-12-05 13:44:23,778 - DEBUG - ya.test - _save_outputs: Command (pid 549883) stime: 0.42477299999999996
2025-12-05 13:44:23,778 - DEBUG - ya.test - _save_outputs: Command (pid 549883) utime: 0.6205499999999999
2025-12-05 13:44:23,779 - DEBUG - ya.test - _save_outputs: Command (pid 549883) wtime: 1.287
2025-12-05 13:44:23,779 - DEBUG - ya.test - _save_outputs: Command (pid 549883) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-05 13:44:23,779 - DEBUG - ya.test - _save_outputs: Command (pid 549883) errors:

2025-12-05 13:44:23,781 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd
2025-12-05 13:44:23,782 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27088', '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-12-05 13:44:23,783 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-12-05 13:44:23,784 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-12-05 13:44:23,785 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27088', '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-12-05 13:44:23,786 - DEBUG - ya.test - execute: Command pid: 550323
2025-12-05 13:44:24,921 - DEBUG - ya.test - _save_outputs: Command (pid 550323) rc: 0
2025-12-05 13:44:24,921 - DEBUG - ya.test - _save_outputs: Command (pid 550323) elapsed time (sec): 1.1330726146697998
2025-12-05 13:44:24,922 - DEBUG - ya.test - _save_outputs: Command (pid 550323) idrss: 0
2025-12-05 13:44:24,922 - DEBUG - ya.test - _save_outputs: Command (pid 550323) inblock: 0
2025-12-05 13:44:24,922 - DEBUG - ya.test - _save_outputs: Command (pid 550323) isrss: 0
2025-12-05 13:44:24,922 - DEBUG - ya.test - _save_outputs: Command (pid 550323) ixrss: 0
2025-12-05 13:44:24,923 - DEBUG - ya.test - _save_outputs: Command (pid 550323) majflt: 0
2025-12-05 13:44:24,923 - DEBUG - ya.test - _save_outputs: Command (pid 550323) maxrss: 584092
2025-12-05 13:44:24,923 - DEBUG - ya.test - _save_outputs: Command (pid 550323) minflt: 51935
2025-12-05 13:44:24,923 - DEBUG - ya.test - _save_outputs: Command (pid 550323) msgrcv: 0
2025-12-05 13:44:24,924 - DEBUG - ya.test - _save_outputs: Command (pid 550323) msgsnd: 0
2025-12-05 13:44:24,929 - DEBUG - ya.test - _save_outputs: Command (pid 550323) nivcsw: 181
2025-12-05 13:44:24,929 - DEBUG - ya.test - _save_outputs: Command (pid 550323) nsignals: 0
2025-12-05 13:44:24,929 - DEBUG - ya.test - _save_outputs: Command (pid 550323) nswap: 0
2025-12-05 13:44:24,930 - DEBUG - ya.test - _save_outputs: Command (pid 550323) nvcsw: 879
2025-12-05 13:44:24,930 - DEBUG - ya.test - _save_outputs: Command (pid 550323) oublock: 8
2025-12-05 13:44:24,930 - DEBUG - ya.test - _save_outputs: Command (pid 550323) stime: 0.25193
2025-12-05 13:44:24,931 - DEBUG - ya.test - _save_outputs: Command (pid 550323) utime: 0.630662
2025-12-05 13:44:24,931 - DEBUG - ya.test - _save_outputs: Command (pid 550323) wtime: 1.135
2025-12-05 13:44:24,931 - DEBUG - ya.test - _save_outputs: Command (pid 550323) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-12-05 13:44:24,931 - DEBUG - ya.test - _save_outputs: Command (pid 550323) errors:

2025-12-05 13:44:24,936 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-12-05 13:44:25,176 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-05 13:44:25,219 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_canonical_records.py, test_name: test_create_drop_and_alter_database)
2025-12-05 13:45:25,877 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd
2025-12-05 13:45:25,878 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22140
2025-12-05 13:45:25,879 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6253
2025-12-05 13:45:25,879 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25661
2025-12-05 13:45:25,880 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14576
2025-12-05 13:45:25,881 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7119
2025-12-05 13:45:25,882 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:45:25,882 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:27088 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/kvke/001157/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_xgen9ynt.log --grpc-port=22140 --mon-port=6253 --ic-port=25661
2025-12-05 13:45:25,883 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:45:25,883 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:27088 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/kvke/001157/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_xgen9ynt.log --grpc-port=22140 --mon-port=6253 --ic-port=25661
2025-12-05 13:45:25,884 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/kvke/001157/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:27088', '--tenant=/Root/Database', '--log-file-name=/home/runner/.ya/build/build_root/kvke/001157/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_xgen9ynt.log', '--grpc-port=22140', '--mon-port=6253', '--ic-port=25661')' in '/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:45:25,887 - DEBUG - ya.test - execute: Command pid: 558590
2025-12-05 13:45:25,888 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:22140/1
2025-12-05 13:45:25,889 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-12-05 13:45:25,890 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-12-05 13:45:25,890 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-12-05 13:45:25,892 - DEBUG - ya.test - execute: Command pid: 558592
2025-12-05 13:45:26,678 - DEBUG - ya.test - _save_outputs: Command (pid 558592) rc: 0
2025-12-05 13:45:26,679 - DEBUG - ya.test - _save_outputs: Command (pid 558592) elapsed time (sec): 0.7851293087005615
2025-12-05 13:45:26,679 - DEBUG - ya.test - _save_outputs: Command (pid 558592) idrss: 0
2025-12-05 13:45:26,679 - DEBUG - ya.test - _save_outputs: Command (pid 558592) inblock: 0
2025-12-05 13:45:26,680 - DEBUG - ya.test - _save_outputs: Command (pid 558592) isrss: 0
2025-12-05 13:45:26,680 - DEBUG - ya.test - _save_outputs: Command (pid 558592) ixrss: 0
2025-12-05 13:45:26,680 - DEBUG - ya.test - _save_outputs: Command (pid 558592) majflt: 0
2025-12-05 13:45:26,681 - DEBUG - ya.test - _save_outputs: Command (pid 558592) maxrss: 596960
2025-12-05 13:45:26,681 - DEBUG - ya.test - _save_outputs: Command (pid 558592) minflt: 45332
2025-12-05 13:45:26,681 - DEBUG - ya.test - _save_outputs: Command (pid 558592) msgrcv: 0
2025-12-05 13:45:26,681 - DEBUG - ya.test - _save_outputs: Command (pid 558592) msgsnd: 0
2025-12-05 13:45:26,682 - DEBUG - ya.test - _save_outputs: Command (pid 558592) nivcsw: 28
2025-12-05 13:45:26,682 - DEBUG - ya.test - _save_outputs: Command (pid 558592) nsignals: 0
2025-12-05 13:45:26,682 - DEBUG - ya.test - _save_outputs: Command (pid 558592) nswap: 0
2025-12-05 13:45:26,683 - DEBUG - ya.test - _save_outputs: Command (pid 558592) nvcsw: 15
2025-12-05 13:45:26,683 - DEBUG - ya.test - _save_outputs: Command (pid 558592) oublock: 8
2025-12-05 13:45:26,683 - DEBUG - ya.test - _save_outputs: Command (pid 558592) stime: 0.252675
2025-12-05 13:45:26,684 - DEBUG - ya.test - _save_outputs: Command (pid 558592) utime: 0.48429799999999995
2025-12-05 13:45:26,684 - DEBUG - ya.test - _save_outputs: Command (pid 558592) wtime: 0.787
2025-12-05 13:45:26,684 - DEBUG - ya.test - _save_outputs: Command (pid 558592) output:
Git info:
    Commit: 9a02a3b9d304ae3db299329ab9f1e2779d1ed4ff
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge 110da6e58e84d1d47f793feefdb3f536909c7fc7 into 585820908c1313b1f0acebdafacf03477ac71cd2

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mj3z7qugmi
    Host information: 
        Linux ghrun-mj3z7qugmi 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 -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-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 -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-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-05 13:45:26,685 - DEBUG - ya.test - _save_outputs: Command (pid 558592) errors:

2025-12-05 13:45:26,714 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 9a02a3b9d304ae3db299329ab9f1e2779d1ed4ff
    Branch: 
    Author: Denis Khalikov <dennis.khalikov@gmail.com>
    Summary: Merge 110da6e58e84d1d47f793feefdb3f536909c7fc7 into 585820908c1313b1f0acebdafacf03477ac71cd2
2025-12-05 13:46:59,840 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-12-05 13:46:59,842 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-12-05 13:46:59,842 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:27088', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:46:59,845 - DEBUG - ya.test - execute: Command pid: 588064
2025-12-05 13:47:00,954 - DEBUG - ya.test - _save_outputs: Command (pid 588064) rc: 0
2025-12-05 13:47:00,955 - DEBUG - ya.test - _save_outputs: Command (pid 588064) elapsed time (sec): 1.1082165241241455
2025-12-05 13:47:00,955 - DEBUG - ya.test - _save_outputs: Command (pid 588064) idrss: 0
2025-12-05 13:47:00,955 - DEBUG - ya.test - _save_outputs: Command (pid 588064) inblock: 0
2025-12-05 13:47:00,956 - DEBUG - ya.test - _save_outputs: Command (pid 588064) isrss: 0
2025-12-05 13:47:00,956 - DEBUG - ya.test - _save_outputs: Command (pid 588064) ixrss: 0
2025-12-05 13:47:00,956 - DEBUG - ya.test - _save_outputs: Command (pid 588064) majflt: 0
2025-12-05 13:47:00,956 - DEBUG - ya.test - _save_outputs: Command (pid 588064) maxrss: 597416
2025-12-05 13:47:00,956 - DEBUG - ya.test - _save_outputs: Command (pid 588064) minflt: 52492
2025-12-05 13:47:00,957 - DEBUG - ya.test - _save_outputs: Command (pid 588064) msgrcv: 0
2025-12-05 13:47:00,957 - DEBUG - ya.test - _save_outputs: Command (pid 588064) msgsnd: 0
2025-12-05 13:47:00,957 - DEBUG - ya.test - _save_outputs: Command (pid 588064) nivcsw: 197
2025-12-05 13:47:00,957 - DEBUG - ya.test - _save_outputs: Command (pid 588064) nsignals: 0
2025-12-05 13:47:00,957 - DEBUG - ya.test - _save_outputs: Command (pid 588064) nswap: 0
2025-12-05 13:47:00,958 - DEBUG - ya.test - _save_outputs: Command (pid 588064) nvcsw: 887
2025-12-05 13:47:00,958 - DEBUG - ya.test - _save_outputs: Command (pid 588064) oublock: 0
2025-12-05 13:47:00,958 - DEBUG - ya.test - _save_outputs: Command (pid 588064) stime: 0.293443
2025-12-05 13:47:00,958 - DEBUG - ya.test - _save_outputs: Command (pid 588064) utime: 0.61169
2025-12-05 13:47:00,958 - DEBUG - ya.test - _save_outputs: Command (pid 588064) wtime: 1.111
2025-12-05 13:47:00,959 - DEBUG - ya.test - _save_outputs: Command (pid 588064) output:

2025-12-05 13:47:00,959 - DEBUG - ya.test - _save_outputs: Command (pid 588064) errors:

2025-12-05 13:47:00,961 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-12-05 13:47:00,962 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-12-05 13:47:00,962 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/kvke/001157/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:27088', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/kvke/001157/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-12-05 13:47:00,964 - DEBUG - ya.test - execute: Command pid: 589741
2025-12-05 13:47:02,077 - DEBUG - ya.test - _save_outputs: Command (pid 589741) rc: 0
2025-12-05 13:47:02,077 - DEBUG - ya.test - _save_outputs: Command (pid 589741) elapsed time (sec): 1.1119537353515625
2025-12-05 13:47:02,078 - DEBUG - ya.test - _save_outputs: Command (pid 589741) idrss: 0
2025-12-05 13:47:02,078 - DEBUG - ya.test - _save_outputs: Command (pid 589741) inblock: 0
2025-12-05 13:47:02,078 - DEBUG - ya.test - _save_outputs: Command (pid 589741) isrss: 0
2025-12-05 13:47:02,079 - DEBUG - ya.test - _save_outputs: Command (pid 589741) ixrss: 0
2025-12-05 13:47:02,079 - DEBUG - ya.test - _save_outputs: Command (pid 589741) majflt: 0
2025-12-05 13:47:02,079 - DEBUG - ya.test - _save_outputs: Command (pid 589741) maxrss: 597416
2025-12-05 13:47:02,080 - DEBUG - ya.test - _save_outputs: Command (pid 589741) minflt: 52594
2025-12-05 13:47:02,080 - DEBUG - ya.test - _save_outputs: Command (pid 589741) msgrcv: 0
2025-12-05 13:47:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 589741) msgsnd: 0
2025-12-05 13:47:02,081 - DEBUG - ya.test - _save_outputs: Command (pid 589741) nivcsw: 198
2025-12-05 13:47:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 589741) nsignals: 0
2025-12-05 13:47:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 589741) nswap: 0
2025-12-05 13:47:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 589741) nvcsw: 550
2025-12-05 13:47:02,082 - DEBUG - ya.test - _save_outputs: Command (pid 589741) oublock: 0
2025-12-05 13:47:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 589741) stime: 0.32017399999999996
2025-12-05 13:47:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 589741) utime: 0.634208
2025-12-05 13:47:02,083 - DEBUG - ya.test - _save_outputs: Command (pid 589741) wtime: 1.113
2025-12-05 13:47:02,084 - DEBUG - ya.test - _save_outputs: Command (pid 589741) output:

2025-12-05 13:47:02,084 - DEBUG - ya.test - _save_outputs: Command (pid 589741) errors:

2025-12-05 13:48:32,804 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/Database
2025-12-05 13:48:32,805 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/Database: send console operation, token root@builtin
2025-12-05 13:48:32,825 - 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=1764942512815352&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-12-05 13:48:32,826 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: wait console operation done
2025-12-05 13:48:33,343 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: console operation done
2025-12-05 13:48:33,343 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: wait tenant gone
2025-12-05 13:48:33,368 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: tenant gone
2025-12-05 13:49:42,438 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:22140/1
2025-12-05 13:49:42,455 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-12-05 13:49:42,484 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_canonical_records
2025-12-05 13:49:54,500 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:27088/1
2025-12-05 13:49:54,504 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7119
2025-12-05 13:49:54,505 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14576
2025-12-05 13:49:54,505 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/25661
2025-12-05 13:49:54,506 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6253
2025-12-05 13:49:54,506 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22140
2025-12-05 13:49:54,506 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3647
2025-12-05 13:49:54,507 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1453
2025-12-05 13:49:54,507 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/63021
2025-12-05 13:49:54,507 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27088
2025-12-05 13:49:54,507 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22712
2025-12-05 13:49:56,074 - DEBUG - ya.test - _verify_test: Verifying [test_canonical_records.test_create_drop_and_alter_database in ydb/tests/functional/audit] canonical results
2025-12-05 13:49:56,100 - DEBUG - ya.test - verify: Test test_canonical_records.test_create_drop_and_alter_database status: good
