2025-10-31 08:42:08,071 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:08,071 - INFO - ya.test - pytest_runtest_setup: test_single_table_with_data_backup_restore
2025-10-31 08:42:08,072 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-31 08:42:08,072 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-31 08:42:08,139 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd
2025-10-31 08:42:08,145 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62659
2025-10-31 08:42:08,148 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/pogg/001ad8/r3tmp/kikimr_cluster_satiqg30
2025-10-31 08:42:08,187 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd
2025-10-31 08:42:08,187 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6229
2025-10-31 08:42:08,189 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/7362
2025-10-31 08:42:08,190 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6003
2025-10-31 08:42:08,190 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21204
2025-10-31 08:42:08,191 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:08,192 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001ad8/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/pogg/001ad8/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_5qbsizqe.log --grpc-port=6229 --mon-port=7362 --ic-port=62659
2025-10-31 08:42:08,193 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:6229/1, disk_size 68719476736
2025-10-31 08:42:08,194 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:08,194 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/pogg/001ad8/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/pogg/001ad8/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_5qbsizqe.log --grpc-port=6229 --mon-port=7362 --ic-port=62659
2025-10-31 08:42:08,195 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/pogg/001ad8/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/pogg/001ad8/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_5qbsizqe.log', '--grpc-port=6229', '--mon-port=7362', '--ic-port=62659')' in '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:08,198 - DEBUG - ya.test - execute: Command pid: 3263557
2025-10-31 08:42:08,200 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:6229/1
2025-10-31 08:42:08,202 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-31 08:42:08,202 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-31 08:42:08,202 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-31 08:42:08,203 - DEBUG - ya.test - execute: Command pid: 3263558
2025-10-31 08:42:08,944 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) rc: 0
2025-10-31 08:42:08,944 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) elapsed time (sec): 0.7377676963806152
2025-10-31 08:42:08,944 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) idrss: 0
2025-10-31 08:42:08,944 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) inblock: 0
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) isrss: 0
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) ixrss: 0
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) majflt: 0
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) maxrss: 538184
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) minflt: 16139
2025-10-31 08:42:08,945 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) msgrcv: 0
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) msgsnd: 0
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) nivcsw: 49
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) nsignals: 0
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) nswap: 0
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) nvcsw: 17
2025-10-31 08:42:08,946 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) oublock: 8
2025-10-31 08:42:08,947 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) stime: 0.561874
2025-10-31 08:42:08,947 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) utime: 0.11885499999999999
2025-10-31 08:42:08,947 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) wtime: 0.741
2025-10-31 08:42:08,947 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) output:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-uabpkrvm6i
    Host information: 
        Linux ghrun-uabpkrvm6i 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-10-31 08:42:08,947 - DEBUG - ya.test - _save_outputs: Command (pid 3263558) errors:

2025-10-31 08:42:08,948 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 82bf8aab4f547668632ff26479ecdb9996428c61
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 43cd17c8a58e28cd156b58873e20cf204c35cf0d into e300863ab69d6519229a61bcfeb54a36b8d86bd0
2025-10-31 08:42:11,028 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd
2025-10-31 08:42:11,028 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6229', '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: 62659\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-31 08:42:11,029 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-31 08:42:11,030 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-31 08:42:11,030 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6229', '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: 62659\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 08:42:11,031 - DEBUG - ya.test - execute: Command pid: 3266054
2025-10-31 08:42:11,567 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) rc: 0
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) elapsed time (sec): 0.5356705188751221
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) idrss: 0
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) inblock: 0
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) isrss: 0
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) ixrss: 0
2025-10-31 08:42:11,568 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) majflt: 0
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) maxrss: 546660
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) minflt: 18271
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) msgrcv: 0
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) msgsnd: 0
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) nivcsw: 13
2025-10-31 08:42:11,569 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) nsignals: 0
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) nswap: 0
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) nvcsw: 137
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) oublock: 8
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) stime: 0.371164
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) utime: 0.11103099999999999
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) wtime: 0.537
2025-10-31 08:42:11,570 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-31 08:42:11,571 - DEBUG - ya.test - _save_outputs: Command (pid 3266054) errors:

2025-10-31 08:42:11,571 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd
2025-10-31 08:42:11,572 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6229', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-10-31 08:42:11,578 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-31 08:42:11,579 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-31 08:42:11,580 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:6229', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-31 08:42:11,581 - DEBUG - ya.test - execute: Command pid: 3266985
2025-10-31 08:42:12,029 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) rc: 0
2025-10-31 08:42:12,030 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) elapsed time (sec): 0.44762325286865234
2025-10-31 08:42:12,030 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) idrss: 0
2025-10-31 08:42:12,030 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) inblock: 0
2025-10-31 08:42:12,030 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) isrss: 0
2025-10-31 08:42:12,030 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) ixrss: 0
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) majflt: 0
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) maxrss: 546664
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) minflt: 18269
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) msgrcv: 0
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) msgsnd: 0
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) nivcsw: 15
2025-10-31 08:42:12,031 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) nsignals: 0
2025-10-31 08:42:12,032 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) nswap: 0
2025-10-31 08:42:12,032 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) nvcsw: 142
2025-10-31 08:42:12,032 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) oublock: 8
2025-10-31 08:42:12,032 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) stime: 0.30363599999999996
2025-10-31 08:42:12,032 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) utime: 0.09988
2025-10-31 08:42:12,033 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) wtime: 0.449
2025-10-31 08:42:12,033 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-31 08:42:12,033 - DEBUG - ya.test - _save_outputs: Command (pid 3266985) errors:

2025-10-31 08:42:12,033 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-31 08:42:12,048 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-31 08:42:12,060 - 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-10-31 08:42:12,062 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-31 08:42:12,065 - 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-10-31 08:42:12,076 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-10-31 08:42:12,076 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 97bd4cb1-da99-4585-ab46-b3e30b42be46, localhost:6229): creating call state
2025-10-31 08:42:12,077 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 97bd4cb1-da99-4585-ab46-b3e30b42be46, localhost:6229): request = { database: "/Root" }
2025-10-31 08:42:12,082 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 97bd4cb1-da99-4585-ab46-b3e30b42be46, localhost:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-uabpkrvm6i.auto.internal" port: 6229 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-10-31 08:42:12,082 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-uabpkrvm6i.auto.internal:6229, location 1, ssl: False>]>
2025-10-31 08:42:12,083 - 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-10-31 08:42:12,094 - 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-10-31 08:42:12,095 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 1eb82bf1-757d-4b18-a36d-a0c45814b113, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,096 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 1eb82bf1-757d-4b18-a36d-a0c45814b113, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-10-31 08:42:12,102 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 1eb82bf1-757d-4b18-a36d-a0c45814b113, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:12,103 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 0cf5eb62-7b55-47be-8db4-3923d9ff3ab2, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,103 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 0cf5eb62-7b55-47be-8db4-3923d9ff3ab2, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:12,106 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 0cf5eb62-7b55-47be-8db4-3923d9ff3ab2, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" } } } }
2025-10-31 08:42:12,107 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5a28bcd6-4143-4c27-8ec7-964ac10c98b8, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,107 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5a28bcd6-4143-4c27-8ec7-964ac10c98b8, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" 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-10-31 08:42:12,138 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5a28bcd6-4143-4c27-8ec7-964ac10c98b8, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:12,140 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, cd76ad37-a669-4020-ad07-664a081b61a6, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,140 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, cd76ad37-a669-4020-ad07-664a081b61a6, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" 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-10-31 08:42:12,195 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, cd76ad37-a669-4020-ad07-664a081b61a6, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 08:42:12,196 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:12,197 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-31 08:42:12,197 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-31 08:42:12,197 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:12,198 - DEBUG - ya.test - execute: Command pid: 3267935
2025-10-31 08:42:12,414 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) rc: 0
2025-10-31 08:42:12,415 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) elapsed time (sec): 0.21485567092895508
2025-10-31 08:42:12,415 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) idrss: 0
2025-10-31 08:42:12,415 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) inblock: 0
2025-10-31 08:42:12,418 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) isrss: 0
2025-10-31 08:42:12,419 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) ixrss: 0
2025-10-31 08:42:12,419 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) majflt: 0
2025-10-31 08:42:12,419 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) maxrss: 168044
2025-10-31 08:42:12,419 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) minflt: 3605
2025-10-31 08:42:12,419 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) msgrcv: 0
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) msgsnd: 0
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) nivcsw: 9
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) nsignals: 0
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) nswap: 0
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) nvcsw: 277
2025-10-31 08:42:12,420 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) oublock: 32
2025-10-31 08:42:12,421 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) stime: 0.023025
2025-10-31 08:42:12,421 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) utime: 0.073683
2025-10-31 08:42:12,421 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) wtime: 0.216
2025-10-31 08:42:12,421 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) output:

2025-10-31 08:42:12,421 - DEBUG - ya.test - _save_outputs: Command (pid 3267935) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-10-31 08:42:12,426 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, c3f4fccd-3b19-4424-80dc-906f5eb13824, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,427 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, c3f4fccd-3b19-4424-80dc-906f5eb13824, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:12,430 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, c3f4fccd-3b19-4424-80dc-906f5eb13824, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:12,431 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:12,432 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-10-31 08:42:12,433 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-31 08:42:12,433 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored', '--input', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:12,434 - DEBUG - ya.test - execute: Command pid: 3268102
2025-10-31 08:42:12,681 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) rc: 0
2025-10-31 08:42:12,681 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) elapsed time (sec): 0.24631166458129883
2025-10-31 08:42:12,681 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) idrss: 0
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) inblock: 0
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) isrss: 0
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) ixrss: 0
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) majflt: 0
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) maxrss: 168044
2025-10-31 08:42:12,682 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) minflt: 4181
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) msgrcv: 0
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) msgsnd: 0
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) nivcsw: 68
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) nsignals: 0
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) nswap: 0
2025-10-31 08:42:12,683 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) nvcsw: 601
2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) oublock: 8
2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) stime: 0.037508
2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) utime: 0.06564
2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) wtime: 0.247
2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) output:

2025-10-31 08:42:12,684 - DEBUG - ya.test - _save_outputs: Command (pid 3268102) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored"
Path after adjusting: "/Root/restored"

2025-10-31 08:42:12,685 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, f243a70c-d83d-40c0-9605-f4ef578f7864, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,685 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, f243a70c-d83d-40c0-9605-f4ef578f7864, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:12,690 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, f243a70c-d83d-40c0-9605-f4ef578f7864, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: "restored" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132610 tx_id: 281474976710669 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:12,691 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, b6360c17-fc55-40b7-a473-8b4f97b0f8aa, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,691 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, b6360c17-fc55-40b7-a473-8b4f97b0f8aa, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-10-31 08:42:12,694 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, b6360c17-fc55-40b7-a473-8b4f97b0f8aa, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132610 tx_id: 281474976710669 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761900132630 tx_id: 281474976710670 } } } } } }
2025-10-31 08:42:12,694 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, ba342730-c0a6-4c8f-95fc-4ddd9cdf53d0, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,695 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, ba342730-c0a6-4c8f-95fc-4ddd9cdf53d0, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:12,698 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, ba342730-c0a6-4c8f-95fc-4ddd9cdf53d0, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 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-10-31 08:42:12,699 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 187a0578-98de-4e26-b565-22840d2bc01f, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,700 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 187a0578-98de-4e26-b565-22840d2bc01f, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:12,703 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 187a0578-98de-4e26-b565-22840d2bc01f, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132630 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-10-31 08:42:12,705 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, d60ddcb9-ada4-4547-91df-b803023e4e2a, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,706 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, d60ddcb9-ada4-4547-91df-b803023e4e2a, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-10-31 08:42:12,709 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, d60ddcb9-ada4-4547-91df-b803023e4e2a, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 tx_id: 281474976710661 } } } } } }
2025-10-31 08:42:12,710 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 91675d00-b9c1-4495-8af5-55a840d66132, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,710 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 91675d00-b9c1-4495-8af5-55a840d66132, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored/table" }
2025-10-31 08:42:12,713 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 91675d00-b9c1-4495-8af5-55a840d66132, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132630 tx_id: 281474976710670 } } } } } }
2025-10-31 08:42:12,714 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 9ead9759-2c11-421e-92a7-1bd23696cdfb, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,715 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 9ead9759-2c11-421e-92a7-1bd23696cdfb, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" path: "/Root/folder/table" ordered: true }
2025-10-31 08:42:12,717 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 9ead9759-2c11-421e-92a7-1bd23696cdfb, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:12,717 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, dc170c67-8329-4174-8299-8788b2737e6e, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,718 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, dc170c67-8329-4174-8299-8788b2737e6e, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" path: "/Root/restored/table" ordered: true }
2025-10-31 08:42:12,719 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, dc170c67-8329-4174-8299-8788b2737e6e, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:12,735 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 4c71f7f9-947d-4669-8a60-fc536f34804e, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,736 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 4c71f7f9-947d-4669-8a60-fc536f34804e, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NzczNTc2YjYtYTNkOTgyZmQtMjAxZDU5MTQtYmQ1ZDI3OGM=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:12,755 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 4c71f7f9-947d-4669-8a60-fc536f34804e, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:12,756 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 73a0fa6d-0260-4c5a-8823-2845b255a388, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,757 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 73a0fa6d-0260-4c5a-8823-2845b255a388, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-10-31 08:42:12,762 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 73a0fa6d-0260-4c5a-8823-2845b255a388, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:12,763 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 41c036b0-263b-4a18-beb0-eac111a84661, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,764 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 41c036b0-263b-4a18-beb0-eac111a84661, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-10-31 08:42:12,768 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 41c036b0-263b-4a18-beb0-eac111a84661, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:12,769 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, fb6cf54c-358e-4470-a774-5e045d8e7bef, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,769 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, fb6cf54c-358e-4470-a774-5e045d8e7bef, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:12,771 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, fb6cf54c-358e-4470-a774-5e045d8e7bef, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" } } } }
2025-10-31 08:42:12,772 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, b71817e8-5b65-4298-b15f-013d77f450d4, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,774 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, b71817e8-5b65-4298-b15f-013d77f450d4, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" 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-10-31 08:42:12,778 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, b71817e8-5b65-4298-b15f-013d77f450d4, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:12,779 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 6f0396b4-b543-4da5-89b2-b34b99e1e9a0, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:12,780 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 6f0396b4-b543-4da5-89b2-b34b99e1e9a0, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" 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-10-31 08:42:12,809 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 6f0396b4-b543-4da5-89b2-b34b99e1e9a0, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 08:42:12,810 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:12,811 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-10-31 08:42:12,812 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-10-31 08:42:12,812 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:12,813 - DEBUG - ya.test - execute: Command pid: 3268519
2025-10-31 08:42:13,025 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) rc: 0
2025-10-31 08:42:13,025 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) elapsed time (sec): 0.21091008186340332
2025-10-31 08:42:13,025 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) idrss: 0
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) inblock: 0
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) isrss: 0
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) ixrss: 0
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) majflt: 0
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) maxrss: 168044
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) minflt: 3615
2025-10-31 08:42:13,026 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) msgrcv: 0
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) msgsnd: 0
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) nivcsw: 9
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) nsignals: 0
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) nswap: 0
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) nvcsw: 283
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) oublock: 32
2025-10-31 08:42:13,027 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) stime: 0.030098
2025-10-31 08:42:13,028 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) utime: 0.06019
2025-10-31 08:42:13,028 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) wtime: 0.212
2025-10-31 08:42:13,028 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) output:

2025-10-31 08:42:13,028 - DEBUG - ya.test - _save_outputs: Command (pid 3268519) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-10-31 08:42:13,029 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, dc6e831f-61b9-431f-8af8-4059dc31d8e1, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,029 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, dc6e831f-61b9-431f-8af8-4059dc31d8e1, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:13,033 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, dc6e831f-61b9-431f-8af8-4059dc31d8e1, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:13,034 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:13,035 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.2
2025-10-31 08:42:13,036 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-10-31 08:42:13,036 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_not_null', '--input', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:13,037 - DEBUG - ya.test - execute: Command pid: 3269031
2025-10-31 08:42:13,237 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) rc: 0
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) elapsed time (sec): 0.19948768615722656
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) idrss: 0
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) inblock: 0
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) isrss: 0
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) ixrss: 0
2025-10-31 08:42:13,238 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) majflt: 0
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) maxrss: 168044
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) minflt: 4178
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) msgrcv: 0
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) msgsnd: 0
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) nivcsw: 56
2025-10-31 08:42:13,239 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) nsignals: 0
2025-10-31 08:42:13,240 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) nswap: 0
2025-10-31 08:42:13,240 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) nvcsw: 623
2025-10-31 08:42:13,240 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) oublock: 8
2025-10-31 08:42:13,240 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) stime: 0.03315
2025-10-31 08:42:13,240 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) utime: 0.074589
2025-10-31 08:42:13,241 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) wtime: 0.201
2025-10-31 08:42:13,241 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) output:

2025-10-31 08:42:13,241 - DEBUG - ya.test - _save_outputs: Command (pid 3269031) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_not_null"
Path after adjusting: "/Root/restored_not_null"

2025-10-31 08:42:13,241 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 3df02262-0a9d-4781-ab94-f0effd9820d0, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,242 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 3df02262-0a9d-4781-ab94-f0effd9820d0, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:13,246 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 3df02262-0a9d-4781-ab94-f0effd9820d0, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: "restored_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900133200 tx_id: 281474976710688 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:13,247 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 55b8c9ef-02f7-4316-865e-b0f22e6b4019, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,247 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 55b8c9ef-02f7-4316-865e-b0f22e6b4019, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-10-31 08:42:13,250 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 55b8c9ef-02f7-4316-865e-b0f22e6b4019, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133200 tx_id: 281474976710688 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761900133220 tx_id: 281474976710689 } } } } } }
2025-10-31 08:42:13,251 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 5aa029e8-2b5c-43c5-a0e3-2ff931dc6018, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,252 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 5aa029e8-2b5c-43c5-a0e3-2ff931dc6018, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,255 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 5aa029e8-2b5c-43c5-a0e3-2ff931dc6018, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 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-10-31 08:42:13,256 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 64f538d0-e0d6-4c2c-9b9a-62784c06d225, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,257 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 64f538d0-e0d6-4c2c-9b9a-62784c06d225, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,261 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 64f538d0-e0d6-4c2c-9b9a-62784c06d225, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133220 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-10-31 08:42:13,262 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, fc20c355-dfed-40c1-89cd-d0a8b9b60971, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,263 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, fc20c355-dfed-40c1-89cd-d0a8b9b60971, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-10-31 08:42:13,265 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, fc20c355-dfed-40c1-89cd-d0a8b9b60971, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 tx_id: 281474976710661 } } } } } }
2025-10-31 08:42:13,266 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 0f3bec3d-f13c-4f48-acf9-1084b43809ec, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,266 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 0f3bec3d-f13c-4f48-acf9-1084b43809ec, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null/table" }
2025-10-31 08:42:13,269 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 0f3bec3d-f13c-4f48-acf9-1084b43809ec, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133220 tx_id: 281474976710689 } } } } } }
2025-10-31 08:42:13,270 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 3793dabe-2b51-44db-b2c2-32146f54f570, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,270 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 3793dabe-2b51-44db-b2c2-32146f54f570, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" path: "/Root/folder/table" ordered: true }
2025-10-31 08:42:13,271 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 3793dabe-2b51-44db-b2c2-32146f54f570, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:13,272 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, f15a27c8-f641-48a5-87b9-ccba023d727b, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,272 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, f15a27c8-f641-48a5-87b9-ccba023d727b, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" path: "/Root/restored_not_null/table" ordered: true }
2025-10-31 08:42:13,273 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, f15a27c8-f641-48a5-87b9-ccba023d727b, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:13,285 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 8fb51ee2-672c-4569-99ab-1ac5a0b9e2fa, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,286 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 8fb51ee2-672c-4569-99ab-1ac5a0b9e2fa, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=ZDAwYWUzNTMtODNlMWUzYTUtMTFjM2Q2MC02MjVhMzRhZA==" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,305 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 8fb51ee2-672c-4569-99ab-1ac5a0b9e2fa, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:13,306 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 05efb4ee-7e94-42af-8de9-5173fed52ae4, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,306 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 05efb4ee-7e94-42af-8de9-5173fed52ae4, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-10-31 08:42:13,324 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 05efb4ee-7e94-42af-8de9-5173fed52ae4, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:13,324 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 5fe80f7d-009a-412e-afea-23642543c2ce, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,325 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 5fe80f7d-009a-412e-afea-23642543c2ce, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-10-31 08:42:13,329 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 5fe80f7d-009a-412e-afea-23642543c2ce, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:13,329 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 92829615-cfef-4cb6-8254-30343bd996e6, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,330 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 92829615-cfef-4cb6-8254-30343bd996e6, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,332 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 92829615-cfef-4cb6-8254-30343bd996e6, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" } } } }
2025-10-31 08:42:13,333 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f0e92d8c-c1c9-45e0-bb1a-31115146582a, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,334 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f0e92d8c-c1c9-45e0-bb1a-31115146582a, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" 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-10-31 08:42:13,338 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f0e92d8c-c1c9-45e0-bb1a-31115146582a, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:13,339 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 86324ce3-8e40-449b-811d-86117c74a7ca, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,340 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 86324ce3-8e40-449b-811d-86117c74a7ca, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" 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-10-31 08:42:13,379 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 86324ce3-8e40-449b-811d-86117c74a7ca, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 08:42:13,380 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:13,382 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.3
2025-10-31 08:42:13,383 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-10-31 08:42:13,383 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:13,384 - DEBUG - ya.test - execute: Command pid: 3269620
2025-10-31 08:42:13,599 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) rc: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) elapsed time (sec): 0.2141554355621338
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) idrss: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) inblock: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) isrss: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) ixrss: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) majflt: 0
2025-10-31 08:42:13,600 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) maxrss: 168044
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) minflt: 3604
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) msgrcv: 0
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) msgsnd: 0
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) nivcsw: 13
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) nsignals: 0
2025-10-31 08:42:13,601 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) nswap: 0
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) nvcsw: 274
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) oublock: 32
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) stime: 0.039918999999999996
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) utime: 0.049899
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) wtime: 0.215
2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) output:

2025-10-31 08:42:13,602 - DEBUG - ya.test - _save_outputs: Command (pid 3269620) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-10-31 08:42:13,603 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 3ef8d8c3-f955-4361-956b-149880d5e4c2, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,603 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 3ef8d8c3-f955-4361-956b-149880d5e4c2, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:13,607 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 3ef8d8c3-f955-4361-956b-149880d5e4c2, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:13,608 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:13,609 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.4
2025-10-31 08:42:13,610 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-10-31 08:42:13,610 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert', '--input', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:13,611 - DEBUG - ya.test - execute: Command pid: 3269922
2025-10-31 08:42:13,814 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) rc: 0
2025-10-31 08:42:13,815 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) elapsed time (sec): 0.20264029502868652
2025-10-31 08:42:13,815 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) idrss: 0
2025-10-31 08:42:13,815 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) inblock: 0
2025-10-31 08:42:13,815 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) isrss: 0
2025-10-31 08:42:13,815 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) ixrss: 0
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) majflt: 0
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) maxrss: 168044
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) minflt: 4171
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) msgrcv: 0
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) msgsnd: 0
2025-10-31 08:42:13,816 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) nivcsw: 28
2025-10-31 08:42:13,817 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) nsignals: 0
2025-10-31 08:42:13,817 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) nswap: 0
2025-10-31 08:42:13,817 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) nvcsw: 603
2025-10-31 08:42:13,817 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) oublock: 8
2025-10-31 08:42:13,817 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) stime: 0.026629999999999997
2025-10-31 08:42:13,818 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) utime: 0.07989199999999999
2025-10-31 08:42:13,818 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) wtime: 0.204
2025-10-31 08:42:13,818 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) output:

2025-10-31 08:42:13,818 - DEBUG - ya.test - _save_outputs: Command (pid 3269922) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_bulk_upsert"
Path after adjusting: "/Root/restored_bulk_upsert"

2025-10-31 08:42:13,819 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, b7a9fe17-3d9d-4ae2-9b10-b78ecabef088, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,819 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, b7a9fe17-3d9d-4ae2-9b10-b78ecabef088, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:13,823 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, b7a9fe17-3d9d-4ae2-9b10-b78ecabef088, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900133780 tx_id: 281474976710707 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:13,824 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 11e6be45-e0bc-4fc3-8d67-183b2ed09c6e, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,824 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 11e6be45-e0bc-4fc3-8d67-183b2ed09c6e, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-10-31 08:42:13,827 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 11e6be45-e0bc-4fc3-8d67-183b2ed09c6e, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133780 tx_id: 281474976710707 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761900133800 tx_id: 281474976710708 } } } } } }
2025-10-31 08:42:13,827 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, c81960ca-d1ea-4145-8d80-5affcc76c468, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,828 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, c81960ca-d1ea-4145-8d80-5affcc76c468, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,831 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, c81960ca-d1ea-4145-8d80-5affcc76c468, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 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-10-31 08:42:13,832 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 6989e892-7921-4ea5-b27e-b3ae01bd9694, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,832 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 6989e892-7921-4ea5-b27e-b3ae01bd9694, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,835 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 6989e892-7921-4ea5-b27e-b3ae01bd9694, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133800 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-10-31 08:42:13,836 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, fc4e9d3e-6cc4-464d-bf1d-6b96728748c6, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,837 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, fc4e9d3e-6cc4-464d-bf1d-6b96728748c6, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-10-31 08:42:13,839 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, fc4e9d3e-6cc4-464d-bf1d-6b96728748c6, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 tx_id: 281474976710661 } } } } } }
2025-10-31 08:42:13,840 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 176a17d1-4465-43f7-b753-558cf083c133, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,840 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 176a17d1-4465-43f7-b753-558cf083c133, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert/table" }
2025-10-31 08:42:13,843 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 176a17d1-4465-43f7-b753-558cf083c133, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900133800 tx_id: 281474976710708 } } } } } }
2025-10-31 08:42:13,843 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, f5ce863b-62b2-418e-b29c-c879e0f97b9b, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,844 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, f5ce863b-62b2-418e-b29c-c879e0f97b9b, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" path: "/Root/folder/table" ordered: true }
2025-10-31 08:42:13,845 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, f5ce863b-62b2-418e-b29c-c879e0f97b9b, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:13,845 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, e9b0201f-a79e-4bbc-99bd-e40c2d94a7e4, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,846 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, e9b0201f-a79e-4bbc-99bd-e40c2d94a7e4, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" path: "/Root/restored_bulk_upsert/table" ordered: true }
2025-10-31 08:42:13,846 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, e9b0201f-a79e-4bbc-99bd-e40c2d94a7e4, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:13,853 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, c44b6dd4-e212-4bae-b4b6-cb609b85b186, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,854 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, c44b6dd4-e212-4bae-b4b6-cb609b85b186, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=MzQ5YzYxZDEtNDJiM2VjZDQtYmViOTg0NzktYzQ1M2FlZGM=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,875 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, c44b6dd4-e212-4bae-b4b6-cb609b85b186, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:13,876 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 6b77808d-4acd-4096-8ed3-7f99c323dd0b, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,877 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 6b77808d-4acd-4096-8ed3-7f99c323dd0b, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-10-31 08:42:13,893 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 6b77808d-4acd-4096-8ed3-7f99c323dd0b, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:13,894 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, b4a04781-a2f5-47da-9870-6eb9d3e5ad94, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,894 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, b4a04781-a2f5-47da-9870-6eb9d3e5ad94, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-10-31 08:42:13,897 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, b4a04781-a2f5-47da-9870-6eb9d3e5ad94, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:13,898 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, dfbb3e99-fd90-4483-9f31-40c4bcb085a9, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,898 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, dfbb3e99-fd90-4483-9f31-40c4bcb085a9, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:13,900 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, dfbb3e99-fd90-4483-9f31-40c4bcb085a9, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" } } } }
2025-10-31 08:42:13,901 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 48538c07-2426-4be8-bbe7-51165710c69b, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,901 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 48538c07-2426-4be8-bbe7-51165710c69b, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" 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-10-31 08:42:13,905 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 48538c07-2426-4be8-bbe7-51165710c69b, ghrun-uabpkrvm6i.auto.internal:6229): 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-10-31 08:42:13,907 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 2d718f6b-5e2e-4b93-a3c3-f970fe5520d2, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:13,907 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 2d718f6b-5e2e-4b93-a3c3-f970fe5520d2, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" 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-10-31 08:42:13,938 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 2d718f6b-5e2e-4b93-a3c3-f970fe5520d2, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-31 08:42:13,938 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:13,940 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.5
2025-10-31 08:42:13,940 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.5
2025-10-31 08:42:13,941 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:13,942 - DEBUG - ya.test - execute: Command pid: 3270430
2025-10-31 08:42:14,137 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) rc: 0
2025-10-31 08:42:14,137 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) elapsed time (sec): 0.1938786506652832
2025-10-31 08:42:14,137 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) idrss: 0
2025-10-31 08:42:14,137 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) inblock: 0
2025-10-31 08:42:14,137 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) isrss: 0
2025-10-31 08:42:14,138 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) ixrss: 0
2025-10-31 08:42:14,138 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) majflt: 0
2025-10-31 08:42:14,138 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) maxrss: 168044
2025-10-31 08:42:14,138 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) minflt: 3609
2025-10-31 08:42:14,138 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) msgrcv: 0
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) msgsnd: 0
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) nivcsw: 15
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) nsignals: 0
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) nswap: 0
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) nvcsw: 287
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) oublock: 32
2025-10-31 08:42:14,139 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) stime: 0.017717999999999998
2025-10-31 08:42:14,140 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) utime: 0.067329
2025-10-31 08:42:14,140 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) wtime: 0.195
2025-10-31 08:42:14,140 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) output:

2025-10-31 08:42:14,140 - DEBUG - ya.test - _save_outputs: Command (pid 3270430) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-10-31 08:42:14,141 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 85f7b3ee-de0c-4abd-9849-45389ffcec1c, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,141 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 85f7b3ee-de0c-4abd-9849-45389ffcec1c, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:14,145 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 85f7b3ee-de0c-4abd-9849-45389ffcec1c, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:14,146 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb
2025-10-31 08:42:14,147 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.6
2025-10-31 08:42:14,147 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.6
2025-10-31 08:42:14,147 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/pogg/001ad8/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:6229', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert_not_null', '--input', '/home/runner/.ya/build/build_root/pogg/001ad8/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-10-31 08:42:14,148 - DEBUG - ya.test - execute: Command pid: 3270669
2025-10-31 08:42:14,316 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) rc: 0
2025-10-31 08:42:14,316 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) elapsed time (sec): 0.16647982597351074
2025-10-31 08:42:14,316 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) idrss: 0
2025-10-31 08:42:14,316 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) inblock: 0
2025-10-31 08:42:14,316 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) isrss: 0
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) ixrss: 0
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) majflt: 0
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) maxrss: 168044
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) minflt: 4161
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) msgrcv: 0
2025-10-31 08:42:14,317 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) msgsnd: 0
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) nivcsw: 0
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) nsignals: 0
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) nswap: 0
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) nvcsw: 621
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) oublock: 8
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) stime: 0.028915
2025-10-31 08:42:14,318 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) utime: 0.066093
2025-10-31 08:42:14,319 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) wtime: 0.168
2025-10-31 08:42:14,319 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) output:

2025-10-31 08:42:14,319 - DEBUG - ya.test - _save_outputs: Command (pid 3270669) 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-10-31 08:42:14,319 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 6042204b-a493-40df-a6ce-1f54a4c8355b, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,320 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 6042204b-a493-40df-a6ce-1f54a4c8355b, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-10-31 08:42:14,323 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 6042204b-a493-40df-a6ce-1f54a4c8355b, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132090 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761900129730 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900132140 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761900134310 tx_id: 281474976710725 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-31 08:42:14,324 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, a687fcc8-b5ea-4d7a-9d9d-977baf9b63b6, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,325 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, a687fcc8-b5ea-4d7a-9d9d-977baf9b63b6, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-10-31 08:42:14,327 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, a687fcc8-b5ea-4d7a-9d9d-977baf9b63b6, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900134310 tx_id: 281474976710725 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761900134330 tx_id: 281474976710726 } } } } } }
2025-10-31 08:42:14,328 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 375bb07d-0539-48ab-a5e7-96f75ad594fb, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,329 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 375bb07d-0539-48ab-a5e7-96f75ad594fb, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:14,332 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 375bb07d-0539-48ab-a5e7-96f75ad594fb, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 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-10-31 08:42:14,332 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, bed298db-cd6a-45bf-adc9-f48abcabe484, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,333 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, bed298db-cd6a-45bf-adc9-f48abcabe484, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:14,336 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, bed298db-cd6a-45bf-adc9-f48abcabe484, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900134330 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-10-31 08:42:14,337 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 2908e03f-0633-475d-867d-b32c9b79edbb, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,338 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 2908e03f-0633-475d-867d-b32c9b79edbb, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-10-31 08:42:14,340 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 2908e03f-0633-475d-867d-b32c9b79edbb, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900132170 tx_id: 281474976710661 } } } } } }
2025-10-31 08:42:14,341 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 7e04bec0-1f29-4e51-9665-6b325004c086, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,341 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 7e04bec0-1f29-4e51-9665-6b325004c086, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null/table" }
2025-10-31 08:42:14,344 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 7e04bec0-1f29-4e51-9665-6b325004c086, ghrun-uabpkrvm6i.auto.internal:6229): 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: 1761900134330 tx_id: 281474976710726 } } } } } }
2025-10-31 08:42:14,344 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, c6ee52b7-f542-4430-a65c-57b1737837ab, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,344 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, c6ee52b7-f542-4430-a65c-57b1737837ab, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" path: "/Root/folder/table" ordered: true }
2025-10-31 08:42:14,346 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, c6ee52b7-f542-4430-a65c-57b1737837ab, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:14,346 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, f3ab1003-ba66-46f9-a393-bfeba1b86b25, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,346 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, f3ab1003-ba66-46f9-a393-bfeba1b86b25, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" path: "/Root/restored_bulk_upsert_not_null/table" ordered: true }
2025-10-31 08:42:14,347 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, f3ab1003-ba66-46f9-a393-bfeba1b86b25, ghrun-uabpkrvm6i.auto.internal:6229): response = { <_MultiThreadedRendezvous object> }
2025-10-31 08:42:14,353 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 1e008535-3251-4c6c-a24c-2ee026d851e9, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,354 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 1e008535-3251-4c6c-a24c-2ee026d851e9, ghrun-uabpkrvm6i.auto.internal:6229): request = { session_id: "ydb://session/3?node_id=1&id=NTU3NzFkMTktMjliOTBmYzYtMmJhMGUxMzAtY2EwZTQwNDI=" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-31 08:42:14,374 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 1e008535-3251-4c6c-a24c-2ee026d851e9, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:14,375 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, ae55de43-ce5b-47fd-b2b3-2dbf1ebf4980, ghrun-uabpkrvm6i.auto.internal:6229): creating call state
2025-10-31 08:42:14,376 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, ae55de43-ce5b-47fd-b2b3-2dbf1ebf4980, ghrun-uabpkrvm6i.auto.internal:6229): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-10-31 08:42:14,382 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, ae55de43-ce5b-47fd-b2b3-2dbf1ebf4980, ghrun-uabpkrvm6i.auto.internal:6229): response = { operation { ready: true status: SUCCESS } }
2025-10-31 08:42:14,384 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-31 08:42:36,386 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:6229/1
2025-10-31 08:42:36,387 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21204
2025-10-31 08:42:36,387 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6003
2025-10-31 08:42:36,388 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7362
2025-10-31 08:42:36,388 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6229
2025-10-31 08:42:36,388 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62659
