2025-11-01 16:49:06,726 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:49:06,727 - INFO - ya.test - pytest_runtest_setup: test_single_table_with_data_backup_restore
2025-11-01 16:49:06,727 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 16:49:06,727 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 16:49:06,790 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd
2025-11-01 16:49:06,791 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10820
2025-11-01 16:49:06,793 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/q6a6/001afc/r3tmp/kikimr_cluster_k51bur2x
2025-11-01 16:49:06,830 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd
2025-11-01 16:49:06,831 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2754
2025-11-01 16:49:06,832 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24165
2025-11-01 16:49:06,834 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29260
2025-11-01 16:49:06,834 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30858
2025-11-01 16:49:06,835 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/kikimr_configs"
2025-11-01 16:49:06,835 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/001afc/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/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/node_1/logfile_vb5a_y_w.log --grpc-port=2754 --mon-port=24165 --ic-port=10820
2025-11-01 16:49:06,836 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:2754/1, disk_size 68719476736
2025-11-01 16:49:06,836 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/kikimr_configs"
2025-11-01 16:49:06,836 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/q6a6/001afc/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/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/node_1/logfile_vb5a_y_w.log --grpc-port=2754 --mon-port=24165 --ic-port=10820
2025-11-01 16:49:06,837 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/node_1/logfile_vb5a_y_w.log', '--grpc-port=2754', '--mon-port=24165', '--ic-port=10820')' in '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/node_1' (no wait)
2025-11-01 16:49:06,838 - DEBUG - ya.test - execute: Command pid: 3163134
2025-11-01 16:49:06,839 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2754/1
2025-11-01 16:49:06,840 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 16:49:06,840 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 16:49:06,841 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 16:49:06,842 - DEBUG - ya.test - execute: Command pid: 3163135
2025-11-01 16:49:07,272 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) rc: 0
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) elapsed time (sec): 0.4300863742828369
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) idrss: 0
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) inblock: 0
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) isrss: 0
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) ixrss: 0
2025-11-01 16:49:07,273 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) majflt: 0
2025-11-01 16:49:07,274 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) maxrss: 538512
2025-11-01 16:49:07,274 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) minflt: 16129
2025-11-01 16:49:07,274 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) msgrcv: 0
2025-11-01 16:49:07,275 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) msgsnd: 0
2025-11-01 16:49:07,275 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) nivcsw: 102
2025-11-01 16:49:07,275 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) nsignals: 0
2025-11-01 16:49:07,276 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) nswap: 0
2025-11-01 16:49:07,276 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) nvcsw: 13
2025-11-01 16:49:07,277 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) oublock: 8
2025-11-01 16:49:07,277 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) stime: 0.245272
2025-11-01 16:49:07,278 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) utime: 0.11745699999999999
2025-11-01 16:49:07,278 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) wtime: 0.431
2025-11-01 16:49:07,279 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-tvlw7frnpa
    Host information: 
        Linux ghrun-tvlw7frnpa 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 -UNDEBUG -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 -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -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-11-01 16:49:07,279 - DEBUG - ya.test - _save_outputs: Command (pid 3163135) errors:

2025-11-01 16:49:07,280 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 16:49:09,282 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd
2025-11-01 16:49:09,282 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2754', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 10820\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 16:49:09,284 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 16:49:09,285 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 16:49:09,288 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2754', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 10820\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 16:49:09,289 - DEBUG - ya.test - execute: Command pid: 3165220
2025-11-01 16:49:09,740 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) rc: 0
2025-11-01 16:49:09,740 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) elapsed time (sec): 0.43531012535095215
2025-11-01 16:49:09,741 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) idrss: 0
2025-11-01 16:49:09,743 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) inblock: 0
2025-11-01 16:49:09,743 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) isrss: 0
2025-11-01 16:49:09,744 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) ixrss: 0
2025-11-01 16:49:09,745 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) majflt: 0
2025-11-01 16:49:09,745 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) maxrss: 546968
2025-11-01 16:49:09,747 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) minflt: 18273
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) msgrcv: 0
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) msgsnd: 0
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) nivcsw: 35
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) nsignals: 0
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) nswap: 0
2025-11-01 16:49:09,748 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) nvcsw: 149
2025-11-01 16:49:09,749 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) oublock: 8
2025-11-01 16:49:09,750 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) stime: 0.269487
2025-11-01 16:49:09,751 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) utime: 0.11757
2025-11-01 16:49:09,755 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) wtime: 0.437
2025-11-01 16:49:09,756 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 16:49:09,756 - DEBUG - ya.test - _save_outputs: Command (pid 3165220) errors:

2025-11-01 16:49:09,757 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd
2025-11-01 16:49:09,758 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2754', '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-11-01 16:49:09,759 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 16:49:09,761 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 16:49:09,762 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:2754', '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-11-01 16:49:09,764 - DEBUG - ya.test - execute: Command pid: 3165506
2025-11-01 16:49:10,323 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) rc: 0
2025-11-01 16:49:10,323 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) elapsed time (sec): 0.5576550960540771
2025-11-01 16:49:10,323 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) idrss: 0
2025-11-01 16:49:10,324 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) inblock: 0
2025-11-01 16:49:10,324 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) isrss: 0
2025-11-01 16:49:10,324 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) ixrss: 0
2025-11-01 16:49:10,325 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) majflt: 0
2025-11-01 16:49:10,326 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) maxrss: 546996
2025-11-01 16:49:10,327 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) minflt: 18272
2025-11-01 16:49:10,328 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) msgrcv: 0
2025-11-01 16:49:10,328 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) msgsnd: 0
2025-11-01 16:49:10,329 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) nivcsw: 45
2025-11-01 16:49:10,330 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) nsignals: 0
2025-11-01 16:49:10,330 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) nswap: 0
2025-11-01 16:49:10,331 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) nvcsw: 137
2025-11-01 16:49:10,332 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) oublock: 8
2025-11-01 16:49:10,332 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) stime: 0.389901
2025-11-01 16:49:10,332 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) utime: 0.118572
2025-11-01 16:49:10,332 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) wtime: 0.559
2025-11-01 16:49:10,332 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 16:49:10,333 - DEBUG - ya.test - _save_outputs: Command (pid 3165506) errors:

2025-11-01 16:49:10,333 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 16:49:10,351 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 16:49:10,361 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:49:10,364 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 16:49:10,366 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:49:10,375 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 16:49:10,376 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 1d75d314-f5e8-4fd8-82af-7cd5b3c1e941, localhost:2754): creating call state
2025-11-01 16:49:10,376 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 1d75d314-f5e8-4fd8-82af-7cd5b3c1e941, localhost:2754): request = { database: "/Root" }
2025-11-01 16:49:10,381 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 1d75d314-f5e8-4fd8-82af-7cd5b3c1e941, localhost:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-tvlw7frnpa.auto.internal" port: 2754 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 16:49:10,382 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-tvlw7frnpa.auto.internal:2754, location 1, ssl: False>]>
2025-11-01 16:49:10,383 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 16:49:10,391 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:2754
2025-11-01 16:49:10,394 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_backup.py::TestSingleBackupRestore, test_name: test_single_table_with_data_backup_restore)
2025-11-01 16:49:10,395 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 4d80413a-2249-42bd-a389-d94c2a7b9d84, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,395 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 4d80413a-2249-42bd-a389-d94c2a7b9d84, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 16:49:10,402 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 4d80413a-2249-42bd-a389-d94c2a7b9d84, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:10,403 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 5b75c06e-37d0-4acc-b20e-018ac0db00a4, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,403 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 5b75c06e-37d0-4acc-b20e-018ac0db00a4, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:10,406 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 5b75c06e-37d0-4acc-b20e-018ac0db00a4, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" } } } }
2025-11-01 16:49:10,407 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 70efbd67-2f49-4e63-abce-7e2a44428088, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,409 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 70efbd67-2f49-4e63-abce-7e2a44428088, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/folder/table" columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:10,435 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 70efbd67-2f49-4e63-abce-7e2a44428088, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:10,436 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 6ef9c56a-01c2-402f-a3e4-4c0643b843ef, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,436 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 6ef9c56a-01c2-402f-a3e4-4c0643b843ef, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:10,491 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 6ef9c56a-01c2-402f-a3e4-4c0643b843ef, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:49:10,494 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:10,495 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 16:49:10,496 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 16:49:10,496 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:10,498 - DEBUG - ya.test - execute: Command pid: 3165968
2025-11-01 16:49:10,723 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) rc: 0
2025-11-01 16:49:10,724 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) elapsed time (sec): 0.22371816635131836
2025-11-01 16:49:10,724 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) idrss: 0
2025-11-01 16:49:10,724 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) inblock: 0
2025-11-01 16:49:10,728 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) isrss: 0
2025-11-01 16:49:10,729 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) ixrss: 0
2025-11-01 16:49:10,730 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) majflt: 0
2025-11-01 16:49:10,731 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) maxrss: 166464
2025-11-01 16:49:10,733 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) minflt: 3612
2025-11-01 16:49:10,733 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) msgrcv: 0
2025-11-01 16:49:10,734 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) msgsnd: 0
2025-11-01 16:49:10,735 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) nivcsw: 20
2025-11-01 16:49:10,735 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) nsignals: 0
2025-11-01 16:49:10,736 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) nswap: 0
2025-11-01 16:49:10,737 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) nvcsw: 276
2025-11-01 16:49:10,738 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) oublock: 32
2025-11-01 16:49:10,738 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) stime: 0.018283
2025-11-01 16:49:10,738 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) utime: 0.076789
2025-11-01 16:49:10,739 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) wtime: 0.226
2025-11-01 16:49:10,739 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) output:

2025-11-01 16:49:10,740 - DEBUG - ya.test - _save_outputs: Command (pid 3165968) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 16:49:10,740 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, a0e70814-765a-4a12-85fd-5c4db33de215, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,741 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, a0e70814-765a-4a12-85fd-5c4db33de215, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:10,744 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, a0e70814-765a-4a12-85fd-5c4db33de215, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:10,745 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:10,746 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-01 16:49:10,747 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 16:49:10,747 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored', '--input', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:10,748 - DEBUG - ya.test - execute: Command pid: 3166103
2025-11-01 16:49:10,943 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) rc: 0
2025-11-01 16:49:10,944 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) elapsed time (sec): 0.1932840347290039
2025-11-01 16:49:10,944 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) idrss: 0
2025-11-01 16:49:10,945 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) inblock: 0
2025-11-01 16:49:10,945 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) isrss: 0
2025-11-01 16:49:10,946 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) ixrss: 0
2025-11-01 16:49:10,946 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) majflt: 0
2025-11-01 16:49:10,946 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) maxrss: 166464
2025-11-01 16:49:10,946 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) minflt: 4178
2025-11-01 16:49:10,947 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) msgrcv: 0
2025-11-01 16:49:10,947 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) msgsnd: 0
2025-11-01 16:49:10,948 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) nivcsw: 25
2025-11-01 16:49:10,948 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) nsignals: 0
2025-11-01 16:49:10,948 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) nswap: 0
2025-11-01 16:49:10,949 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) nvcsw: 605
2025-11-01 16:49:10,949 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) oublock: 8
2025-11-01 16:49:10,950 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) stime: 0.061564999999999995
2025-11-01 16:49:10,955 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) utime: 0.047883999999999996
2025-11-01 16:49:10,959 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) wtime: 0.196
2025-11-01 16:49:10,960 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) output:

2025-11-01 16:49:10,960 - DEBUG - ya.test - _save_outputs: Command (pid 3166103) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored"
Path after adjusting: "/Root/restored"

2025-11-01 16:49:10,960 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 8a3d8467-4fd4-4fd6-9b5a-1a225e5c626b, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,962 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 8a3d8467-4fd4-4fd6-9b5a-1a225e5c626b, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:10,966 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 8a3d8467-4fd4-4fd6-9b5a-1a225e5c626b, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: "restored" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750910 tx_id: 281474976710669 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:10,968 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 736db9d3-5128-4764-bafa-78b362d6ee4f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,968 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 736db9d3-5128-4764-bafa-78b362d6ee4f, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-11-01 16:49:10,977 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 736db9d3-5128-4764-bafa-78b362d6ee4f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "restored" owner: "root@builtin" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750910 tx_id: 281474976710669 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1762015750930 tx_id: 281474976710670 } } } } } }
2025-11-01 16:49:10,977 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 07601501-e5ab-40eb-83dd-46e75441c5e3, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,978 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 07601501-e5ab-40eb-83dd-46e75441c5e3, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:10,982 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 07601501-e5ab-40eb-83dd-46e75441c5e3, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:10,983 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 8458b777-4664-4347-bff4-6887b653003f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,984 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 8458b777-4664-4347-bff4-6887b653003f, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:10,988 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 8458b777-4664-4347-bff4-6887b653003f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750930 tx_id: 281474976710670 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:10,989 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 7c3fcac4-2d53-49ac-bab7-834a91249683, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,989 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 7c3fcac4-2d53-49ac-bab7-834a91249683, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 16:49:10,992 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 7c3fcac4-2d53-49ac-bab7-834a91249683, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } } } } }
2025-11-01 16:49:10,992 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 7f20a825-601c-4af6-bfb2-40ddb918a42f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,993 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 7f20a825-601c-4af6-bfb2-40ddb918a42f, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored/table" }
2025-11-01 16:49:10,996 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 7f20a825-601c-4af6-bfb2-40ddb918a42f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750930 tx_id: 281474976710670 } } } } } }
2025-11-01 16:49:10,996 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, ad486490-3814-4f5e-8ef5-6f4cd206953e, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,997 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, ad486490-3814-4f5e-8ef5-6f4cd206953e, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/folder/table" ordered: true }
2025-11-01 16:49:10,998 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, ad486490-3814-4f5e-8ef5-6f4cd206953e, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:10,999 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 66f1f174-090d-4ba7-a844-a01384a97c2b, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:10,999 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 66f1f174-090d-4ba7-a844-a01384a97c2b, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/restored/table" ordered: true }
2025-11-01 16:49:11,001 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 66f1f174-090d-4ba7-a844-a01384a97c2b, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:11,030 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 65cc4e55-01d7-4dea-a4b6-514f17d53fdd, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,031 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 65cc4e55-01d7-4dea-a4b6-514f17d53fdd, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=YWE4NzE3YWQtZjQyNzI1YWMtZTdjYjUzZTUtZjZjMTg3NTI=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,041 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 65cc4e55-01d7-4dea-a4b6-514f17d53fdd, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:11,042 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, bbb4f7da-b624-44aa-9044-53971ce82cd7, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,043 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, bbb4f7da-b624-44aa-9044-53971ce82cd7, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-11-01 16:49:11,053 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, bbb4f7da-b624-44aa-9044-53971ce82cd7, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:11,054 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 958cc7c1-4ff5-45c0-bfa2-a0584b88ae27, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,054 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 958cc7c1-4ff5-45c0-bfa2-a0584b88ae27, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 16:49:11,060 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 958cc7c1-4ff5-45c0-bfa2-a0584b88ae27, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 16:49:11,060 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, a5273a1e-799b-4e13-83d9-d329c78f5db1, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,061 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, a5273a1e-799b-4e13-83d9-d329c78f5db1, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,063 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, a5273a1e-799b-4e13-83d9-d329c78f5db1, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" } } } }
2025-11-01 16:49:11,064 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f32e7dbb-c2c0-41a3-986a-4ae649aab1c3, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,064 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f32e7dbb-c2c0-41a3-986a-4ae649aab1c3, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/folder/table" columns { name: "id" type { type_id: UINT32 } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,068 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f32e7dbb-c2c0-41a3-986a-4ae649aab1c3, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 16:49:11,069 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, af768edc-bbdf-4986-8738-3ab036086dfc, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,070 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, af768edc-bbdf-4986-8738-3ab036086dfc, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,098 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, af768edc-bbdf-4986-8738-3ab036086dfc, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:49:11,099 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:11,100 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-01 16:49:11,101 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-11-01 16:49:11,101 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:11,102 - DEBUG - ya.test - execute: Command pid: 3166415
2025-11-01 16:49:11,294 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) rc: 0
2025-11-01 16:49:11,294 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) elapsed time (sec): 0.1868274211883545
2025-11-01 16:49:11,294 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) idrss: 0
2025-11-01 16:49:11,294 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) inblock: 0
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) isrss: 0
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) ixrss: 0
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) majflt: 0
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) maxrss: 166464
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) minflt: 3608
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) msgrcv: 0
2025-11-01 16:49:11,295 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) msgsnd: 0
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) nivcsw: 26
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) nsignals: 0
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) nswap: 0
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) nvcsw: 256
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) oublock: 32
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) stime: 0.018213
2025-11-01 16:49:11,296 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) utime: 0.065567
2025-11-01 16:49:11,297 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) wtime: 0.192
2025-11-01 16:49:11,297 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) output:

2025-11-01 16:49:11,297 - DEBUG - ya.test - _save_outputs: Command (pid 3166415) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 16:49:11,297 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, bfed1166-6037-4ae0-9126-9125778e7c0c, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,298 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, bfed1166-6037-4ae0-9126-9125778e7c0c, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:11,301 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, bfed1166-6037-4ae0-9126-9125778e7c0c, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:11,302 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:11,303 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.2
2025-11-01 16:49:11,304 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-11-01 16:49:11,304 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_not_null', '--input', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:11,305 - DEBUG - ya.test - execute: Command pid: 3166626
2025-11-01 16:49:11,502 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) rc: 0
2025-11-01 16:49:11,502 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) elapsed time (sec): 0.19588088989257812
2025-11-01 16:49:11,503 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) idrss: 0
2025-11-01 16:49:11,503 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) inblock: 0
2025-11-01 16:49:11,503 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) isrss: 0
2025-11-01 16:49:11,504 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) ixrss: 0
2025-11-01 16:49:11,504 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) majflt: 0
2025-11-01 16:49:11,504 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) maxrss: 166464
2025-11-01 16:49:11,505 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) minflt: 4180
2025-11-01 16:49:11,505 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) msgrcv: 0
2025-11-01 16:49:11,505 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) msgsnd: 0
2025-11-01 16:49:11,506 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) nivcsw: 33
2025-11-01 16:49:11,506 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) nsignals: 0
2025-11-01 16:49:11,507 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) nswap: 0
2025-11-01 16:49:11,507 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) nvcsw: 609
2025-11-01 16:49:11,507 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) oublock: 8
2025-11-01 16:49:11,507 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) stime: 0.025013999999999998
2025-11-01 16:49:11,507 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) utime: 0.075044
2025-11-01 16:49:11,509 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) wtime: 0.197
2025-11-01 16:49:11,509 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) output:

2025-11-01 16:49:11,509 - DEBUG - ya.test - _save_outputs: Command (pid 3166626) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_not_null"
Path after adjusting: "/Root/restored_not_null"

2025-11-01 16:49:11,510 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, c9f5a69e-3946-484a-a02d-72840faf3f6c, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,511 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, c9f5a69e-3946-484a-a02d-72840faf3f6c, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:11,515 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, c9f5a69e-3946-484a-a02d-72840faf3f6c, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: "restored_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015751480 tx_id: 281474976710688 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:11,516 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 408bc2f0-710a-409b-8ec2-9a2c31ff1ed8, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,517 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 408bc2f0-710a-409b-8ec2-9a2c31ff1ed8, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-11-01 16:49:11,520 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 408bc2f0-710a-409b-8ec2-9a2c31ff1ed8, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "restored_not_null" owner: "root@builtin" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015751480 tx_id: 281474976710688 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1762015751500 tx_id: 281474976710689 } } } } } }
2025-11-01 16:49:11,521 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, e5318234-c97a-4b93-abe4-51ef48becdff, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,522 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, e5318234-c97a-4b93-abe4-51ef48becdff, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,526 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, e5318234-c97a-4b93-abe4-51ef48becdff, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:11,526 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, a16e11dc-cd98-4d5a-a9db-d26552b25b8a, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,527 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, a16e11dc-cd98-4d5a-a9db-d26552b25b8a, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,531 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, a16e11dc-cd98-4d5a-a9db-d26552b25b8a, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015751500 tx_id: 281474976710689 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:11,532 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, fbf75cc0-3b07-44c0-a73c-53a066536463, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,532 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, fbf75cc0-3b07-44c0-a73c-53a066536463, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 16:49:11,535 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, fbf75cc0-3b07-44c0-a73c-53a066536463, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } } } } }
2025-11-01 16:49:11,535 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 2f103b0a-6aa5-4fa8-ab42-aac4281d9f5a, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,537 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 2f103b0a-6aa5-4fa8-ab42-aac4281d9f5a, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null/table" }
2025-11-01 16:49:11,541 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 2f103b0a-6aa5-4fa8-ab42-aac4281d9f5a, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015751500 tx_id: 281474976710689 } } } } } }
2025-11-01 16:49:11,541 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 8322cdbc-d068-4ae0-9038-974ca05c8860, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,542 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 8322cdbc-d068-4ae0-9038-974ca05c8860, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/folder/table" ordered: true }
2025-11-01 16:49:11,544 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 8322cdbc-d068-4ae0-9038-974ca05c8860, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:11,545 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, c8cb3b40-b168-4b7a-91cb-e02fe13cc9bd, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,547 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, c8cb3b40-b168-4b7a-91cb-e02fe13cc9bd, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/restored_not_null/table" ordered: true }
2025-11-01 16:49:11,548 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, c8cb3b40-b168-4b7a-91cb-e02fe13cc9bd, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:11,554 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, e509fdcd-917d-485c-ada3-b5b412e5b084, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,555 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, e509fdcd-917d-485c-ada3-b5b412e5b084, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MjkzNGNhZjItZDU5ODIwYTYtMTczMjkwY2QtNjAyNmU2ZTU=" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,575 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, e509fdcd-917d-485c-ada3-b5b412e5b084, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:11,575 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 46dfd015-4728-48cc-bb13-374d8f09e703, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,576 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 46dfd015-4728-48cc-bb13-374d8f09e703, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-11-01 16:49:11,583 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 46dfd015-4728-48cc-bb13-374d8f09e703, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:11,583 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, e8b1dd6d-b368-4cf8-8a10-73816e5f56ed, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,584 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, e8b1dd6d-b368-4cf8-8a10-73816e5f56ed, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 16:49:11,586 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, e8b1dd6d-b368-4cf8-8a10-73816e5f56ed, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 16:49:11,587 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 99350393-bc1b-44bf-bde2-84c75095712f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,587 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 99350393-bc1b-44bf-bde2-84c75095712f, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,589 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 99350393-bc1b-44bf-bde2-84c75095712f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" } } } }
2025-11-01 16:49:11,590 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2125adb8-ef9c-4037-a457-dfcf694335eb, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,590 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2125adb8-ef9c-4037-a457-dfcf694335eb, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/folder/table" columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,594 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2125adb8-ef9c-4037-a457-dfcf694335eb, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 16:49:11,594 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, e3b3b80e-3512-4fbd-adec-0e7872b46d61, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,596 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, e3b3b80e-3512-4fbd-adec-0e7872b46d61, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:11,623 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, e3b3b80e-3512-4fbd-adec-0e7872b46d61, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:49:11,624 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:11,627 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.3
2025-11-01 16:49:11,628 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-11-01 16:49:11,629 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:11,631 - DEBUG - ya.test - execute: Command pid: 3166907
2025-11-01 16:49:11,844 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) rc: 0
2025-11-01 16:49:11,844 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) elapsed time (sec): 0.21199989318847656
2025-11-01 16:49:11,844 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) idrss: 0
2025-11-01 16:49:11,844 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) inblock: 0
2025-11-01 16:49:11,844 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) isrss: 0
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) ixrss: 0
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) majflt: 0
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) maxrss: 166464
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) minflt: 3610
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) msgrcv: 0
2025-11-01 16:49:11,845 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) msgsnd: 0
2025-11-01 16:49:11,846 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) nivcsw: 22
2025-11-01 16:49:11,852 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) nsignals: 0
2025-11-01 16:49:11,853 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) nswap: 0
2025-11-01 16:49:11,854 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) nvcsw: 283
2025-11-01 16:49:11,854 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) oublock: 32
2025-11-01 16:49:11,854 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) stime: 0.027032999999999998
2025-11-01 16:49:11,854 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) utime: 0.058906999999999994
2025-11-01 16:49:11,855 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) wtime: 0.213
2025-11-01 16:49:11,855 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) output:

2025-11-01 16:49:11,855 - DEBUG - ya.test - _save_outputs: Command (pid 3166907) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 16:49:11,856 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, a67ce26a-584a-4c84-86eb-4da4db1d0973, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:11,857 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, a67ce26a-584a-4c84-86eb-4da4db1d0973, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:11,860 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, a67ce26a-584a-4c84-86eb-4da4db1d0973, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:11,861 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:11,862 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.4
2025-11-01 16:49:11,863 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-11-01 16:49:11,863 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert', '--input', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert/backup_files_dir', '--bulk-upsert']' in 'None' (waiting)
2025-11-01 16:49:11,864 - DEBUG - ya.test - execute: Command pid: 3167034
2025-11-01 16:49:12,044 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) rc: 0
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) elapsed time (sec): 0.1796262264251709
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) idrss: 0
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) inblock: 0
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) isrss: 0
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) ixrss: 0
2025-11-01 16:49:12,045 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) majflt: 0
2025-11-01 16:49:12,046 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) maxrss: 166464
2025-11-01 16:49:12,046 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) minflt: 4166
2025-11-01 16:49:12,047 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) msgrcv: 0
2025-11-01 16:49:12,047 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) msgsnd: 0
2025-11-01 16:49:12,047 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) nivcsw: 24
2025-11-01 16:49:12,048 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) nsignals: 0
2025-11-01 16:49:12,048 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) nswap: 0
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) nvcsw: 607
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) oublock: 8
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) stime: 0.041592
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) utime: 0.058227999999999995
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) wtime: 0.181
2025-11-01 16:49:12,049 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) output:

2025-11-01 16:49:12,050 - DEBUG - ya.test - _save_outputs: Command (pid 3167034) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_bulk_upsert"
Path after adjusting: "/Root/restored_bulk_upsert"

2025-11-01 16:49:12,050 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, f03f0bec-4efd-4d17-a916-f7740751aec2, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,051 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, f03f0bec-4efd-4d17-a916-f7740751aec2, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:12,055 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, f03f0bec-4efd-4d17-a916-f7740751aec2, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015752030 tx_id: 281474976710707 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:12,056 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 564fce5f-f123-41f5-88d6-6abc3cd1ad4f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,057 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 564fce5f-f123-41f5-88d6-6abc3cd1ad4f, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-11-01 16:49:12,059 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 564fce5f-f123-41f5-88d6-6abc3cd1ad4f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "restored_bulk_upsert" owner: "root@builtin" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752030 tx_id: 281474976710707 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1762015752050 tx_id: 281474976710708 } } } } } }
2025-11-01 16:49:12,060 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 2f5da1b5-78d2-4dae-a754-ecb90e88669e, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,060 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 2f5da1b5-78d2-4dae-a754-ecb90e88669e, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,063 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 2f5da1b5-78d2-4dae-a754-ecb90e88669e, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:12,064 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, c391716c-875c-4a0b-9fa8-075b64b4d129, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,064 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, c391716c-875c-4a0b-9fa8-075b64b4d129, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,068 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, c391716c-875c-4a0b-9fa8-075b64b4d129, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752050 tx_id: 281474976710708 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:12,068 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 5308c443-114e-4358-b5be-52fcb02ae351, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,069 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 5308c443-114e-4358-b5be-52fcb02ae351, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 16:49:12,071 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 5308c443-114e-4358-b5be-52fcb02ae351, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } } } } }
2025-11-01 16:49:12,071 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, af08b667-8a2f-4531-9537-35831faeca52, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,072 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, af08b667-8a2f-4531-9537-35831faeca52, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert/table" }
2025-11-01 16:49:12,074 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, af08b667-8a2f-4531-9537-35831faeca52, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752050 tx_id: 281474976710708 } } } } } }
2025-11-01 16:49:12,074 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, a34a1ea5-baa1-46ca-ae97-ada7de1125cf, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,075 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, a34a1ea5-baa1-46ca-ae97-ada7de1125cf, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/folder/table" ordered: true }
2025-11-01 16:49:12,076 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, a34a1ea5-baa1-46ca-ae97-ada7de1125cf, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:12,076 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 43876023-ba70-4e78-865e-7e3e2dc60463, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,077 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 43876023-ba70-4e78-865e-7e3e2dc60463, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/restored_bulk_upsert/table" ordered: true }
2025-11-01 16:49:12,077 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 43876023-ba70-4e78-865e-7e3e2dc60463, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:12,083 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, ebee5e75-3805-4f1a-a630-d0960a90a652, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,084 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, ebee5e75-3805-4f1a-a630-d0960a90a652, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=MzY3ZTdhOTgtNzI1MmQ2NzAtMzIwMTNjYTYtMzFmMGRhNmE=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,094 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, ebee5e75-3805-4f1a-a630-d0960a90a652, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:12,095 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, ee4259e5-8771-4574-bf11-884a6c217baf, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,095 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, ee4259e5-8771-4574-bf11-884a6c217baf, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-11-01 16:49:12,103 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, ee4259e5-8771-4574-bf11-884a6c217baf, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:12,103 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 97e559b2-d5ef-42bd-84ab-bd9f42595013, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,104 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 97e559b2-d5ef-42bd-84ab-bd9f42595013, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 16:49:12,107 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 97e559b2-d5ef-42bd-84ab-bd9f42595013, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 16:49:12,108 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, ea62f254-7628-4f22-bf6a-dc92822eef4d, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,108 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, ea62f254-7628-4f22-bf6a-dc92822eef4d, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,110 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, ea62f254-7628-4f22-bf6a-dc92822eef4d, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" } } } }
2025-11-01 16:49:12,111 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 75a89bae-8f75-43a5-8214-43d5dd7a4e31, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,112 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 75a89bae-8f75-43a5-8214-43d5dd7a4e31, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/folder/table" columns { name: "id" type { type_id: UINT32 } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,115 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 75a89bae-8f75-43a5-8214-43d5dd7a4e31, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 16:49:12,116 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 552c498f-acbe-4f83-85cd-07a2cf969969, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,117 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 552c498f-acbe-4f83-85cd-07a2cf969969, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,145 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 552c498f-acbe-4f83-85cd-07a2cf969969, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 16:49:12,146 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:12,147 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.5
2025-11-01 16:49:12,148 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.5
2025-11-01 16:49:12,148 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 16:49:12,150 - DEBUG - ya.test - execute: Command pid: 3167324
2025-11-01 16:49:12,352 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) rc: 0
2025-11-01 16:49:12,352 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) elapsed time (sec): 0.20101356506347656
2025-11-01 16:49:12,352 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) idrss: 0
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) inblock: 0
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) isrss: 0
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) ixrss: 0
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) majflt: 0
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) maxrss: 166464
2025-11-01 16:49:12,353 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) minflt: 3608
2025-11-01 16:49:12,354 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) msgrcv: 0
2025-11-01 16:49:12,355 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) msgsnd: 0
2025-11-01 16:49:12,355 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) nivcsw: 22
2025-11-01 16:49:12,355 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) nsignals: 0
2025-11-01 16:49:12,355 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) nswap: 0
2025-11-01 16:49:12,356 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) nvcsw: 266
2025-11-01 16:49:12,356 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) oublock: 32
2025-11-01 16:49:12,357 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) stime: 0.021709
2025-11-01 16:49:12,357 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) utime: 0.06512899999999999
2025-11-01 16:49:12,358 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) wtime: 0.203
2025-11-01 16:49:12,358 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) output:

2025-11-01 16:49:12,358 - DEBUG - ya.test - _save_outputs: Command (pid 3167324) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 16:49:12,359 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, c6f145d4-1ff9-48a3-b28c-d89121eef75b, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,360 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, c6f145d4-1ff9-48a3-b28c-d89121eef75b, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:12,364 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, c6f145d4-1ff9-48a3-b28c-d89121eef75b, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:12,365 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb
2025-11-01 16:49:12,367 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.6
2025-11-01 16:49:12,368 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.6
2025-11-01 16:49:12,371 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/q6a6/001afc/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:2754', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert_not_null', '--input', '/home/runner/.ya/build/build_root/q6a6/001afc/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert_not_null/backup_files_dir', '--bulk-upsert']' in 'None' (waiting)
2025-11-01 16:49:12,372 - DEBUG - ya.test - execute: Command pid: 3167376
2025-11-01 16:49:12,565 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) rc: 0
2025-11-01 16:49:12,565 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) elapsed time (sec): 0.19257235527038574
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) idrss: 0
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) inblock: 0
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) isrss: 0
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) ixrss: 0
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) majflt: 0
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) maxrss: 166464
2025-11-01 16:49:12,566 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) minflt: 4163
2025-11-01 16:49:12,567 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) msgrcv: 0
2025-11-01 16:49:12,567 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) msgsnd: 0
2025-11-01 16:49:12,568 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) nivcsw: 37
2025-11-01 16:49:12,569 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) nsignals: 0
2025-11-01 16:49:12,569 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) nswap: 0
2025-11-01 16:49:12,570 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) nvcsw: 578
2025-11-01 16:49:12,570 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) oublock: 8
2025-11-01 16:49:12,570 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) stime: 0.051393999999999995
2025-11-01 16:49:12,570 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) utime: 0.050648
2025-11-01 16:49:12,571 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) wtime: 0.194
2025-11-01 16:49:12,571 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) output:

2025-11-01 16:49:12,571 - DEBUG - ya.test - _save_outputs: Command (pid 3167376) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_bulk_upsert_not_null"
Path after adjusting: "/Root/restored_bulk_upsert_not_null"

2025-11-01 16:49:12,571 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 33f167a7-1ec6-45da-9a89-2a157e8b8261, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,572 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 33f167a7-1ec6-45da-9a89-2a157e8b8261, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 16:49:12,576 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 33f167a7-1ec6-45da-9a89-2a157e8b8261, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root" owner: "root" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } permissions { subject: "USERS" permission_names: "ydb.database.connect" } permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750390 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1762015747960 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015750440 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1762015752540 tx_id: 281474976710725 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 16:49:12,576 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 2abe12b9-a274-4b68-be7d-8a2afce7ed9a, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,577 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 2abe12b9-a274-4b68-be7d-8a2afce7ed9a, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-11-01 16:49:12,579 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 2abe12b9-a274-4b68-be7d-8a2afce7ed9a, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "restored_bulk_upsert_not_null" owner: "root@builtin" type: DIRECTORY effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752540 tx_id: 281474976710725 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1762015752560 tx_id: 281474976710726 } } } } } }
2025-11-01 16:49:12,580 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, b6432beb-3e90-4168-a2a6-08168d69d2fa, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,580 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, b6432beb-3e90-4168-a2a6-08168d69d2fa, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,583 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, b6432beb-3e90-4168-a2a6-08168d69d2fa, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:12,584 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 623d2178-4ebb-46a4-b87a-4fc53c95942e, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,584 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 623d2178-4ebb-46a4-b87a-4fc53c95942e, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,588 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 623d2178-4ebb-46a4-b87a-4fc53c95942e, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.DescribeTableResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752560 tx_id: 281474976710726 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 16:49:12,589 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 4afa0ce5-3e69-4bbb-b19b-ae4d785a6406, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,590 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 4afa0ce5-3e69-4bbb-b19b-ae4d785a6406, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 16:49:12,593 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 4afa0ce5-3e69-4bbb-b19b-ae4d785a6406, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015750470 tx_id: 281474976710661 } } } } } }
2025-11-01 16:49:12,593 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 31ae184a-57a3-47ab-b91a-e5255fb75c10, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,594 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 31ae184a-57a3-47ab-b91a-e5255fb75c10, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null/table" }
2025-11-01 16:49:12,597 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 31ae184a-57a3-47ab-b91a-e5255fb75c10, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "table" owner: "root@builtin" type: TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1762015752560 tx_id: 281474976710726 } } } } } }
2025-11-01 16:49:12,599 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, ac83bf6b-0cde-4d61-b75a-111f27c48fcd, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,600 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, ac83bf6b-0cde-4d61-b75a-111f27c48fcd, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/folder/table" ordered: true }
2025-11-01 16:49:12,602 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, ac83bf6b-0cde-4d61-b75a-111f27c48fcd, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:12,603 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, fcc12d10-1f46-428b-963b-939745526c73, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,605 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, fcc12d10-1f46-428b-963b-939745526c73, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/restored_bulk_upsert_not_null/table" ordered: true }
2025-11-01 16:49:12,605 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, fcc12d10-1f46-428b-963b-939745526c73, ghrun-tvlw7frnpa.auto.internal:2754): response = { <_MultiThreadedRendezvous object> }
2025-11-01 16:49:12,614 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, e4150682-17b0-475c-9958-6c715c593820, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,615 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, e4150682-17b0-475c-9958-6c715c593820, ghrun-tvlw7frnpa.auto.internal:2754): request = { session_id: "ydb://session/3?node_id=1&id=OWM5OWQ4Ny0zMjhlNmIyZS05YmYxY2JmOS1jMmE1Y2EwOQ==" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 16:49:12,634 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, e4150682-17b0-475c-9958-6c715c593820, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:12,635 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 83899683-c1d7-4080-b969-95a53b1c481f, ghrun-tvlw7frnpa.auto.internal:2754): creating call state
2025-11-01 16:49:12,636 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 83899683-c1d7-4080-b969-95a53b1c481f, ghrun-tvlw7frnpa.auto.internal:2754): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-11-01 16:49:12,645 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 83899683-c1d7-4080-b969-95a53b1c481f, ghrun-tvlw7frnpa.auto.internal:2754): response = { operation { ready: true status: SUCCESS } }
2025-11-01 16:49:12,646 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 16:49:34,651 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:2754/1
2025-11-01 16:49:34,653 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30858
2025-11-01 16:49:34,653 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/29260
2025-11-01 16:49:34,653 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/24165
2025-11-01 16:49:34,654 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2754
2025-11-01 16:49:34,654 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10820
