2025-10-26 15:57:17,746 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:57:17,746 - INFO - ya.test - pytest_runtest_setup: test_create_drop_and_alter_database
2025-10-26 15:57:17,747 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:57:17,747 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 15:57:17,878 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd
2025-10-26 15:57:17,880 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3476
2025-10-26 15:57:17,883 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_canonical_records
2025-10-26 15:57:17,884 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-10-26 15:57:17,885 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/xrv6/001037/r3tmp/kikimr_cluster_an77iubo
2025-10-26 15:57:17,936 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd
2025-10-26 15:57:17,937 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29888
2025-10-26 15:57:17,938 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27031
2025-10-26 15:57:17,939 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17316
2025-10-26 15:57:17,939 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24395
2025-10-26 15:57:17,940 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:57:17,941 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/001037/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/xrv6/001037/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_l2andct3.log --grpc-port=29888 --mon-port=27031 --ic-port=3476 --module=1
2025-10-26 15:57:17,941 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:29888/1, disk_size 68719476736
2025-10-26 15:57:17,942 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:2:64 on node localhost:29888/1, disk_size 68719476736
2025-10-26 15:57:17,942 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:57:17,943 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/001037/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/xrv6/001037/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_l2andct3.log --grpc-port=29888 --mon-port=27031 --ic-port=3476 --module=1
2025-10-26 15:57:17,944 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/xrv6/001037/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/xrv6/001037/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_l2andct3.log', '--grpc-port=29888', '--mon-port=27031', '--ic-port=3476', '--module=1')' in '/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:57:17,949 - DEBUG - ya.test - execute: Command pid: 985747
2025-10-26 15:57:17,951 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:29888/1
2025-10-26 15:57:17,953 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 15:57:17,953 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 15:57:17,956 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:57:17,958 - DEBUG - ya.test - execute: Command pid: 985748
2025-10-26 15:57:18,996 - DEBUG - ya.test - _save_outputs: Command (pid 985748) rc: 0
2025-10-26 15:57:18,997 - DEBUG - ya.test - _save_outputs: Command (pid 985748) elapsed time (sec): 1.03751540184021
2025-10-26 15:57:18,997 - DEBUG - ya.test - _save_outputs: Command (pid 985748) idrss: 0
2025-10-26 15:57:18,998 - DEBUG - ya.test - _save_outputs: Command (pid 985748) inblock: 0
2025-10-26 15:57:18,998 - DEBUG - ya.test - _save_outputs: Command (pid 985748) isrss: 0
2025-10-26 15:57:18,999 - DEBUG - ya.test - _save_outputs: Command (pid 985748) ixrss: 0
2025-10-26 15:57:18,999 - DEBUG - ya.test - _save_outputs: Command (pid 985748) majflt: 0
2025-10-26 15:57:19,000 - DEBUG - ya.test - _save_outputs: Command (pid 985748) maxrss: 481956
2025-10-26 15:57:19,000 - DEBUG - ya.test - _save_outputs: Command (pid 985748) minflt: 45106
2025-10-26 15:57:19,001 - DEBUG - ya.test - _save_outputs: Command (pid 985748) msgrcv: 0
2025-10-26 15:57:19,001 - DEBUG - ya.test - _save_outputs: Command (pid 985748) msgsnd: 0
2025-10-26 15:57:19,001 - DEBUG - ya.test - _save_outputs: Command (pid 985748) nivcsw: 236
2025-10-26 15:57:19,002 - DEBUG - ya.test - _save_outputs: Command (pid 985748) nsignals: 0
2025-10-26 15:57:19,002 - DEBUG - ya.test - _save_outputs: Command (pid 985748) nswap: 0
2025-10-26 15:57:19,002 - DEBUG - ya.test - _save_outputs: Command (pid 985748) nvcsw: 13
2025-10-26 15:57:19,003 - DEBUG - ya.test - _save_outputs: Command (pid 985748) oublock: 8
2025-10-26 15:57:19,003 - DEBUG - ya.test - _save_outputs: Command (pid 985748) stime: 0.214088
2025-10-26 15:57:19,003 - DEBUG - ya.test - _save_outputs: Command (pid 985748) utime: 0.587299
2025-10-26 15:57:19,004 - DEBUG - ya.test - _save_outputs: Command (pid 985748) wtime: 1.04
2025-10-26 15:57:19,005 - DEBUG - ya.test - _save_outputs: Command (pid 985748) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 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-26 15:57:19,005 - DEBUG - ya.test - _save_outputs: Command (pid 985748) errors:

2025-10-26 15:57:19,006 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 15:57:24,442 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd
2025-10-26 15:57:24,443 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29888', '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: 3476\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 15:57:24,444 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 15:57:24,445 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 15:57:24,445 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29888', '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: 3476\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:57:24,447 - DEBUG - ya.test - execute: Command pid: 987620
2025-10-26 15:57:25,547 - DEBUG - ya.test - _save_outputs: Command (pid 987620) rc: 0
2025-10-26 15:57:25,548 - DEBUG - ya.test - _save_outputs: Command (pid 987620) elapsed time (sec): 1.0997858047485352
2025-10-26 15:57:25,548 - DEBUG - ya.test - _save_outputs: Command (pid 987620) idrss: 0
2025-10-26 15:57:25,548 - DEBUG - ya.test - _save_outputs: Command (pid 987620) inblock: 0
2025-10-26 15:57:25,549 - DEBUG - ya.test - _save_outputs: Command (pid 987620) isrss: 0
2025-10-26 15:57:25,549 - DEBUG - ya.test - _save_outputs: Command (pid 987620) ixrss: 0
2025-10-26 15:57:25,549 - DEBUG - ya.test - _save_outputs: Command (pid 987620) majflt: 0
2025-10-26 15:57:25,549 - DEBUG - ya.test - _save_outputs: Command (pid 987620) maxrss: 586252
2025-10-26 15:57:25,550 - DEBUG - ya.test - _save_outputs: Command (pid 987620) minflt: 51429
2025-10-26 15:57:25,550 - DEBUG - ya.test - _save_outputs: Command (pid 987620) msgrcv: 0
2025-10-26 15:57:25,550 - DEBUG - ya.test - _save_outputs: Command (pid 987620) msgsnd: 0
2025-10-26 15:57:25,550 - DEBUG - ya.test - _save_outputs: Command (pid 987620) nivcsw: 113
2025-10-26 15:57:25,551 - DEBUG - ya.test - _save_outputs: Command (pid 987620) nsignals: 0
2025-10-26 15:57:25,551 - DEBUG - ya.test - _save_outputs: Command (pid 987620) nswap: 0
2025-10-26 15:57:25,551 - DEBUG - ya.test - _save_outputs: Command (pid 987620) nvcsw: 585
2025-10-26 15:57:25,551 - DEBUG - ya.test - _save_outputs: Command (pid 987620) oublock: 8
2025-10-26 15:57:25,551 - DEBUG - ya.test - _save_outputs: Command (pid 987620) stime: 0.276682
2025-10-26 15:57:25,552 - DEBUG - ya.test - _save_outputs: Command (pid 987620) utime: 0.571674
2025-10-26 15:57:25,552 - DEBUG - ya.test - _save_outputs: Command (pid 987620) wtime: 1.102
2025-10-26 15:57:25,552 - DEBUG - ya.test - _save_outputs: Command (pid 987620) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 15:57:25,552 - DEBUG - ya.test - _save_outputs: Command (pid 987620) errors:

2025-10-26 15:57:25,554 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd
2025-10-26 15:57:25,555 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29888', '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:57:25,555 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-26 15:57:25,556 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-26 15:57:25,556 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29888', '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:57:25,558 - DEBUG - ya.test - execute: Command pid: 987961
2025-10-26 15:57:26,540 - DEBUG - ya.test - _save_outputs: Command (pid 987961) rc: 0
2025-10-26 15:57:26,540 - DEBUG - ya.test - _save_outputs: Command (pid 987961) elapsed time (sec): 0.9807112216949463
2025-10-26 15:57:26,541 - DEBUG - ya.test - _save_outputs: Command (pid 987961) idrss: 0
2025-10-26 15:57:26,541 - DEBUG - ya.test - _save_outputs: Command (pid 987961) inblock: 0
2025-10-26 15:57:26,541 - DEBUG - ya.test - _save_outputs: Command (pid 987961) isrss: 0
2025-10-26 15:57:26,542 - DEBUG - ya.test - _save_outputs: Command (pid 987961) ixrss: 0
2025-10-26 15:57:26,542 - DEBUG - ya.test - _save_outputs: Command (pid 987961) majflt: 0
2025-10-26 15:57:26,542 - DEBUG - ya.test - _save_outputs: Command (pid 987961) maxrss: 586848
2025-10-26 15:57:26,542 - DEBUG - ya.test - _save_outputs: Command (pid 987961) minflt: 51417
2025-10-26 15:57:26,543 - DEBUG - ya.test - _save_outputs: Command (pid 987961) msgrcv: 0
2025-10-26 15:57:26,543 - DEBUG - ya.test - _save_outputs: Command (pid 987961) msgsnd: 0
2025-10-26 15:57:26,543 - DEBUG - ya.test - _save_outputs: Command (pid 987961) nivcsw: 177
2025-10-26 15:57:26,543 - DEBUG - ya.test - _save_outputs: Command (pid 987961) nsignals: 0
2025-10-26 15:57:26,544 - DEBUG - ya.test - _save_outputs: Command (pid 987961) nswap: 0
2025-10-26 15:57:26,544 - DEBUG - ya.test - _save_outputs: Command (pid 987961) nvcsw: 715
2025-10-26 15:57:26,544 - DEBUG - ya.test - _save_outputs: Command (pid 987961) oublock: 8
2025-10-26 15:57:26,545 - DEBUG - ya.test - _save_outputs: Command (pid 987961) stime: 0.23845999999999998
2025-10-26 15:57:26,545 - DEBUG - ya.test - _save_outputs: Command (pid 987961) utime: 0.5756479999999999
2025-10-26 15:57:26,545 - DEBUG - ya.test - _save_outputs: Command (pid 987961) wtime: 0.983
2025-10-26 15:57:26,546 - DEBUG - ya.test - _save_outputs: Command (pid 987961) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 15:57:26,546 - DEBUG - ya.test - _save_outputs: Command (pid 987961) errors:

2025-10-26 15:57:26,547 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-26 15:57:26,628 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 15:57:26,657 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_canonical_records.py, test_name: test_create_drop_and_alter_database)
2025-10-26 15:58:27,363 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd
2025-10-26 15:58:27,364 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19438
2025-10-26 15:58:27,365 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18116
2025-10-26 15:58:27,365 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24941
2025-10-26 15:58:27,366 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12849
2025-10-26 15:58:27,367 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22588
2025-10-26 15:58:27,368 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:58:27,368 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:29888 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/xrv6/001037/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_fzruu08v.log --grpc-port=19438 --mon-port=18116 --ic-port=24941
2025-10-26 15:58:27,369 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:58:27,369 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:29888 --tenant=/Root/Database --log-file-name=/home/runner/.ya/build/build_root/xrv6/001037/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_fzruu08v.log --grpc-port=19438 --mon-port=18116 --ic-port=24941
2025-10-26 15:58:27,370 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/xrv6/001037/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:29888', '--tenant=/Root/Database', '--log-file-name=/home/runner/.ya/build/build_root/xrv6/001037/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_fzruu08v.log', '--grpc-port=19438', '--mon-port=18116', '--ic-port=24941')' in '/home/runner/.ya/build/build_root/xrv6/001037/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-26 15:58:27,372 - DEBUG - ya.test - execute: Command pid: 1001362
2025-10-26 15:58:27,372 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19438/1
2025-10-26 15:58:27,373 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-26 15:58:27,374 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-26 15:58:27,374 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:58:27,375 - DEBUG - ya.test - execute: Command pid: 1001363
2025-10-26 15:58:28,118 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) rc: 0
2025-10-26 15:58:28,119 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) elapsed time (sec): 0.7422084808349609
2025-10-26 15:58:28,119 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) idrss: 0
2025-10-26 15:58:28,120 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) inblock: 0
2025-10-26 15:58:28,120 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) isrss: 0
2025-10-26 15:58:28,120 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) ixrss: 0
2025-10-26 15:58:28,120 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) majflt: 0
2025-10-26 15:58:28,120 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) maxrss: 600500
2025-10-26 15:58:28,121 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) minflt: 45158
2025-10-26 15:58:28,121 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) msgrcv: 0
2025-10-26 15:58:28,121 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) msgsnd: 0
2025-10-26 15:58:28,122 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) nivcsw: 8
2025-10-26 15:58:28,122 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) nsignals: 0
2025-10-26 15:58:28,122 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) nswap: 0
2025-10-26 15:58:28,122 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) nvcsw: 16
2025-10-26 15:58:28,123 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) oublock: 8
2025-10-26 15:58:28,123 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) stime: 0.18959499999999999
2025-10-26 15:58:28,123 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) utime: 0.507443
2025-10-26 15:58:28,124 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) wtime: 0.743
2025-10-26 15:58:28,124 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 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-26 15:58:28,124 - DEBUG - ya.test - _save_outputs: Command (pid 1001363) errors:

2025-10-26 15:58:28,125 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 16:00:03,991 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-10-26 16:00:03,992 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-10-26 16:00:03,993 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:29888', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/xrv6/001037/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-26 16:00:03,997 - DEBUG - ya.test - execute: Command pid: 1031769
2025-10-26 16:00:05,553 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) rc: 0
2025-10-26 16:00:05,554 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) elapsed time (sec): 1.5553386211395264
2025-10-26 16:00:05,554 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) idrss: 0
2025-10-26 16:00:05,555 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) inblock: 0
2025-10-26 16:00:05,555 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) isrss: 0
2025-10-26 16:00:05,555 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) ixrss: 0
2025-10-26 16:00:05,556 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) majflt: 0
2025-10-26 16:00:05,556 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) maxrss: 601356
2025-10-26 16:00:05,556 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) minflt: 52657
2025-10-26 16:00:05,557 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) msgrcv: 0
2025-10-26 16:00:05,557 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) msgsnd: 0
2025-10-26 16:00:05,557 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) nivcsw: 357
2025-10-26 16:00:05,557 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) nsignals: 0
2025-10-26 16:00:05,558 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) nswap: 0
2025-10-26 16:00:05,558 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) nvcsw: 551
2025-10-26 16:00:05,559 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) oublock: 0
2025-10-26 16:00:05,559 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) stime: 0.323381
2025-10-26 16:00:05,559 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) utime: 0.656025
2025-10-26 16:00:05,560 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) wtime: 1.56
2025-10-26 16:00:05,560 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) output:

2025-10-26 16:00:05,560 - DEBUG - ya.test - _save_outputs: Command (pid 1031769) errors:

2025-10-26 16:00:05,564 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-10-26 16:00:05,565 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-10-26 16:00:05,566 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/001037/ydb/apps/ydbd/ydbd', '-s', 'grpc://localhost:29888', 'db', 'schema', 'exec', '/home/runner/.ya/build/build_root/xrv6/001037/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-26 16:00:05,572 - DEBUG - ya.test - execute: Command pid: 1032181
2025-10-26 16:00:06,977 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) rc: 0
2025-10-26 16:00:06,978 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) elapsed time (sec): 1.4043517112731934
2025-10-26 16:00:06,978 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) idrss: 0
2025-10-26 16:00:06,979 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) inblock: 0
2025-10-26 16:00:06,979 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) isrss: 0
2025-10-26 16:00:06,979 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) ixrss: 0
2025-10-26 16:00:06,980 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) majflt: 0
2025-10-26 16:00:06,980 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) maxrss: 601356
2025-10-26 16:00:06,980 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) minflt: 52495
2025-10-26 16:00:06,981 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) msgrcv: 0
2025-10-26 16:00:06,981 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) msgsnd: 0
2025-10-26 16:00:06,981 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) nivcsw: 296
2025-10-26 16:00:06,981 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) nsignals: 0
2025-10-26 16:00:06,982 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) nswap: 0
2025-10-26 16:00:06,982 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) nvcsw: 545
2025-10-26 16:00:06,982 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) oublock: 0
2025-10-26 16:00:06,983 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) stime: 0.30050499999999997
2025-10-26 16:00:06,983 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) utime: 0.6370279999999999
2025-10-26 16:00:06,983 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) wtime: 1.411
2025-10-26 16:00:06,984 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) output:

2025-10-26 16:00:06,984 - DEBUG - ya.test - _save_outputs: Command (pid 1032181) errors:

2025-10-26 16:01:37,701 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/Database
2025-10-26 16:01:37,702 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/Database: send console operation, token root@builtin
2025-10-26 16:01:37,717 - 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=1761494497712702&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-10-26 16:01:37,718 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: wait console operation done
2025-10-26 16:01:38,235 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/Database: console operation done
2025-10-26 16:01:38,236 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: wait tenant gone
2025-10-26 16:01:38,249 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/Database: tenant gone
2025-10-26 16:02:43,150 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19438/1
2025-10-26 16:02:43,157 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 16:02:43,157 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_canonical_records
2025-10-26 16:02:50,162 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:29888/1
2025-10-26 16:02:50,164 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22588
2025-10-26 16:02:50,165 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12849
2025-10-26 16:02:50,166 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24941
2025-10-26 16:02:50,167 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18116
2025-10-26 16:02:50,167 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19438
2025-10-26 16:02:50,168 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24395
2025-10-26 16:02:50,168 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17316
2025-10-26 16:02:50,169 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27031
2025-10-26 16:02:50,169 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29888
2025-10-26 16:02:50,169 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3476
2025-10-26 16:02:51,212 - DEBUG - ya.test - _verify_test: Verifying [test_canonical_records.test_create_drop_and_alter_database in ydb/tests/functional/audit] canonical results
2025-10-26 16:02:51,217 - DEBUG - ya.test - verify: Test test_canonical_records.test_create_drop_and_alter_database status: good
