2025-11-01 04:19:18,090 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:19:18,090 - INFO - ya.test - pytest_runtest_setup: test_single_table_with_data_backup_restore
2025-11-01 04:19:18,090 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 04:19:18,091 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 04:19:18,166 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd
2025-11-01 04:19:18,167 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/16342
2025-11-01 04:19:18,168 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/g81u/004e5c/r3tmp/kikimr_cluster_hn3eauin
2025-11-01 04:19:18,210 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd
2025-11-01 04:19:18,210 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27628
2025-11-01 04:19:18,211 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20518
2025-11-01 04:19:18,211 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26489
2025-11-01 04:19:18,212 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4384
2025-11-01 04:19:18,212 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/kikimr_configs"
2025-11-01 04:19:18,213 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004e5c/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/g81u/004e5c/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_1f3aniqw.log --grpc-port=27628 --mon-port=20518 --ic-port=16342
2025-11-01 04:19:18,213 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:27628/1, disk_size 68719476736
2025-11-01 04:19:18,213 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/kikimr_configs"
2025-11-01 04:19:18,213 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/g81u/004e5c/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/g81u/004e5c/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_1f3aniqw.log --grpc-port=27628 --mon-port=20518 --ic-port=16342
2025-11-01 04:19:18,214 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/g81u/004e5c/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/g81u/004e5c/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_1f3aniqw.log', '--grpc-port=27628', '--mon-port=20518', '--ic-port=16342')' in '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/test_ydb_backup.py.TestSingleBackupRestore.test_single_table_with_data_backup_restore/cluster/node_1' (no wait)
2025-11-01 04:19:18,216 - DEBUG - ya.test - execute: Command pid: 2503914
2025-11-01 04:19:18,217 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:27628/1
2025-11-01 04:19:18,218 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-01 04:19:18,218 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-01 04:19:18,219 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 04:19:18,220 - DEBUG - ya.test - execute: Command pid: 2503916
2025-11-01 04:19:18,683 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) rc: 0
2025-11-01 04:19:18,684 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) elapsed time (sec): 0.4632680416107178
2025-11-01 04:19:18,684 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) idrss: 0
2025-11-01 04:19:18,684 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) inblock: 0
2025-11-01 04:19:18,684 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) isrss: 0
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) ixrss: 0
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) majflt: 0
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) maxrss: 538372
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) minflt: 16128
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) msgrcv: 0
2025-11-01 04:19:18,685 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) msgsnd: 0
2025-11-01 04:19:18,686 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) nivcsw: 126
2025-11-01 04:19:18,686 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) nsignals: 0
2025-11-01 04:19:18,686 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) nswap: 0
2025-11-01 04:19:18,686 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) nvcsw: 18
2025-11-01 04:19:18,687 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) oublock: 8
2025-11-01 04:19:18,687 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) stime: 0.274711
2025-11-01 04:19:18,687 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) utime: 0.127402
2025-11-01 04:19:18,687 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) wtime: 0.464
2025-11-01 04:19:18,687 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) output:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-i4gyxlpqdu
    Host information: 
        Linux ghrun-i4gyxlpqdu 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-01 04:19:18,688 - DEBUG - ya.test - _save_outputs: Command (pid 2503916) errors:

2025-11-01 04:19:18,688 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 767d72532e5716ba790791cf237fdadb24b0e578
    Branch: 
    Author: Innokentii Mokin <enjection@ya.ru>
    Summary: Merge 96af589a3c3d7740081955df0fe84da0a7b35651 into 2afee58ebdae8491f810ad53605d37376c4e5de6
2025-11-01 04:19:20,788 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd
2025-11-01 04:19:20,789 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27628', '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: 16342\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 04:19:20,789 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-01 04:19:20,790 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-01 04:19:20,790 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27628', '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: 16342\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:19:20,791 - DEBUG - ya.test - execute: Command pid: 2505312
2025-11-01 04:19:21,255 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) rc: 0
2025-11-01 04:19:21,255 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) elapsed time (sec): 0.4630305767059326
2025-11-01 04:19:21,255 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) idrss: 0
2025-11-01 04:19:21,256 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) inblock: 0
2025-11-01 04:19:21,256 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) isrss: 0
2025-11-01 04:19:21,256 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) ixrss: 0
2025-11-01 04:19:21,256 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) majflt: 0
2025-11-01 04:19:21,256 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) maxrss: 546800
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) minflt: 18271
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) msgrcv: 0
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) msgsnd: 0
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) nivcsw: 50
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) nsignals: 0
2025-11-01 04:19:21,257 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) nswap: 0
2025-11-01 04:19:21,258 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) nvcsw: 114
2025-11-01 04:19:21,258 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) oublock: 8
2025-11-01 04:19:21,258 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) stime: 0.268096
2025-11-01 04:19:21,259 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) utime: 0.132047
2025-11-01 04:19:21,259 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) wtime: 0.464
2025-11-01 04:19:21,260 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-01 04:19:21,260 - DEBUG - ya.test - _save_outputs: Command (pid 2505312) errors:

2025-11-01 04:19:21,261 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd
2025-11-01 04:19:21,261 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27628', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 04:19:21,262 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-01 04:19:21,267 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-01 04:19:21,267 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:27628', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 04:19:21,269 - DEBUG - ya.test - execute: Command pid: 2505784
2025-11-01 04:19:21,732 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) rc: 0
2025-11-01 04:19:21,733 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) elapsed time (sec): 0.4627048969268799
2025-11-01 04:19:21,734 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) idrss: 0
2025-11-01 04:19:21,734 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) inblock: 0
2025-11-01 04:19:21,734 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) isrss: 0
2025-11-01 04:19:21,735 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) ixrss: 0
2025-11-01 04:19:21,735 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) majflt: 0
2025-11-01 04:19:21,735 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) maxrss: 546812
2025-11-01 04:19:21,735 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) minflt: 18269
2025-11-01 04:19:21,736 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) msgrcv: 0
2025-11-01 04:19:21,736 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) msgsnd: 0
2025-11-01 04:19:21,737 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) nivcsw: 33
2025-11-01 04:19:21,737 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) nsignals: 0
2025-11-01 04:19:21,737 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) nswap: 0
2025-11-01 04:19:21,737 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) nvcsw: 133
2025-11-01 04:19:21,737 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) oublock: 8
2025-11-01 04:19:21,738 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) stime: 0.272682
2025-11-01 04:19:21,738 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) utime: 0.140351
2025-11-01 04:19:21,738 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) wtime: 0.464
2025-11-01 04:19:21,739 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 04:19:21,739 - DEBUG - ya.test - _save_outputs: Command (pid 2505784) errors:

2025-11-01 04:19:21,739 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 04:19:21,757 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 04:19:21,768 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:19:21,770 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 04:19:21,771 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:19:21,779 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-01 04:19:21,780 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 349e8a84-6043-430b-8f0a-818bee77924f, localhost:27628): creating call state
2025-11-01 04:19:21,780 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 349e8a84-6043-430b-8f0a-818bee77924f, localhost:27628): request = { database: "/Root" }
2025-11-01 04:19:21,785 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 349e8a84-6043-430b-8f0a-818bee77924f, localhost:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-i4gyxlpqdu.auto.internal" port: 27628 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-01 04:19:21,786 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-i4gyxlpqdu.auto.internal:27628, location 1, ssl: False>]>
2025-11-01 04:19:21,787 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 04:19:21,797 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_ydb_backup.py::TestSingleBackupRestore, test_name: test_single_table_with_data_backup_restore)
2025-11-01 04:19:21,798 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, dba04cb0-dc7d-41a2-9a24-c53aa3e83dc0, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:21,799 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, dba04cb0-dc7d-41a2-9a24-c53aa3e83dc0, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 04:19:21,805 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, dba04cb0-dc7d-41a2-9a24-c53aa3e83dc0, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:21,806 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 10b2f8a3-8f05-445d-947c-f905f662f868, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:21,806 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 10b2f8a3-8f05-445d-947c-f905f662f868, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:21,808 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 10b2f8a3-8f05-445d-947c-f905f662f868, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" } } } }
2025-11-01 04:19:21,809 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5b447173-e480-4558-8946-393db660f9b1, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:21,810 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5b447173-e480-4558-8946-393db660f9b1, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/folder/table" columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:21,861 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5b447173-e480-4558-8946-393db660f9b1, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:21,862 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, f2f77d78-6919-4e9c-ad24-0b97bef20dfe, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:21,863 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, f2f77d78-6919-4e9c-ad24-0b97bef20dfe, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:21,912 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, f2f77d78-6919-4e9c-ad24-0b97bef20dfe, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 04:19:21,913 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:21,914 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-01 04:19:21,915 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-01 04:19:21,915 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:21,916 - DEBUG - ya.test - execute: Command pid: 2506143
2025-11-01 04:19:22,106 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) rc: 0
2025-11-01 04:19:22,106 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) elapsed time (sec): 0.18904972076416016
2025-11-01 04:19:22,106 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) idrss: 0
2025-11-01 04:19:22,106 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) inblock: 0
2025-11-01 04:19:22,107 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) isrss: 0
2025-11-01 04:19:22,107 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) ixrss: 0
2025-11-01 04:19:22,107 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) majflt: 0
2025-11-01 04:19:22,107 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) maxrss: 167832
2025-11-01 04:19:22,107 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) minflt: 3611
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) msgrcv: 0
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) msgsnd: 0
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) nivcsw: 11
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) nsignals: 0
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) nswap: 0
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) nvcsw: 264
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) oublock: 32
2025-11-01 04:19:22,108 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) stime: 0.021053
2025-11-01 04:19:22,109 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) utime: 0.067371
2025-11-01 04:19:22,109 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) wtime: 0.19
2025-11-01 04:19:22,109 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) output:

2025-11-01 04:19:22,109 - DEBUG - ya.test - _save_outputs: Command (pid 2506143) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 04:19:22,110 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, f8b76199-dc10-4130-8d58-052937514a9f, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,110 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, f8b76199-dc10-4130-8d58-052937514a9f, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:22,114 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, f8b76199-dc10-4130-8d58-052937514a9f, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:22,115 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:22,116 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-01 04:19:22,117 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-01 04:19:22,117 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored', '--input', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:22,118 - DEBUG - ya.test - execute: Command pid: 2506239
2025-11-01 04:19:22,322 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) rc: 0
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) elapsed time (sec): 0.2021641731262207
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) idrss: 0
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) inblock: 0
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) isrss: 0
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) ixrss: 0
2025-11-01 04:19:22,323 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) majflt: 0
2025-11-01 04:19:22,324 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) maxrss: 167832
2025-11-01 04:19:22,324 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) minflt: 4179
2025-11-01 04:19:22,324 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) msgrcv: 0
2025-11-01 04:19:22,324 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) msgsnd: 0
2025-11-01 04:19:22,324 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) nivcsw: 28
2025-11-01 04:19:22,325 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) nsignals: 0
2025-11-01 04:19:22,325 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) nswap: 0
2025-11-01 04:19:22,325 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) nvcsw: 634
2025-11-01 04:19:22,325 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) oublock: 8
2025-11-01 04:19:22,325 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) stime: 0.042331999999999995
2025-11-01 04:19:22,326 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) utime: 0.07055399999999999
2025-11-01 04:19:22,326 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) wtime: 0.203
2025-11-01 04:19:22,326 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) output:

2025-11-01 04:19:22,326 - DEBUG - ya.test - _save_outputs: Command (pid 2506239) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored"
Path after adjusting: "/Root/restored"

2025-11-01 04:19:22,327 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, f6c5fdbe-1c2e-4fff-a8ac-cbd5f5d20ed0, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,327 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, f6c5fdbe-1c2e-4fff-a8ac-cbd5f5d20ed0, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:22,330 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, f6c5fdbe-1c2e-4fff-a8ac-cbd5f5d20ed0, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: "restored" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970762290 tx_id: 281474976710669 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:22,332 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 80575625-65fd-4763-85c6-9bca7213bab3, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,332 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 80575625-65fd-4763-85c6-9bca7213bab3, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-11-01 04:19:22,335 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 80575625-65fd-4763-85c6-9bca7213bab3, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762290 tx_id: 281474976710669 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761970762310 tx_id: 281474976710670 } } } } } }
2025-11-01 04:19:22,336 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 4807fce5-2a94-4542-869a-96dc88a0b7ed, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,336 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 4807fce5-2a94-4542-869a-96dc88a0b7ed, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,339 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 4807fce5-2a94-4542-869a-96dc88a0b7ed, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:22,341 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, c802c609-798a-4403-b0e5-9ad03011ce04, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,341 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, c802c609-798a-4403-b0e5-9ad03011ce04, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,345 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, c802c609-798a-4403-b0e5-9ad03011ce04, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762310 tx_id: 281474976710670 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:22,346 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, a63741e0-f663-4f4f-8084-010c6b68abe2, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,347 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, a63741e0-f663-4f4f-8084-010c6b68abe2, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 04:19:22,350 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, a63741e0-f663-4f4f-8084-010c6b68abe2, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } } } } }
2025-11-01 04:19:22,350 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 94d7e92a-2783-4a72-8229-5743720389a7, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,351 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 94d7e92a-2783-4a72-8229-5743720389a7, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored/table" }
2025-11-01 04:19:22,353 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 94d7e92a-2783-4a72-8229-5743720389a7, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762310 tx_id: 281474976710670 } } } } } }
2025-11-01 04:19:22,354 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, b94e1563-ec66-47d4-b0cd-714b27867121, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,354 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, b94e1563-ec66-47d4-b0cd-714b27867121, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/folder/table" ordered: true }
2025-11-01 04:19:22,355 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, b94e1563-ec66-47d4-b0cd-714b27867121, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:22,356 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, f79bc9b2-94bf-44e9-9ffa-08bd80c92d03, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,356 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, f79bc9b2-94bf-44e9-9ffa-08bd80c92d03, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/restored/table" ordered: true }
2025-11-01 04:19:22,357 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, f79bc9b2-94bf-44e9-9ffa-08bd80c92d03, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:22,363 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 3a181c32-5afe-4d04-9b58-20dc6dd1bd75, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,364 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 3a181c32-5afe-4d04-9b58-20dc6dd1bd75, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YzNmOTY1MzMtMmI2MmRiOTEtNGI1MzVmMmEtOWE4Mzc4NTE=" path: "/Root/restored/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,374 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 3a181c32-5afe-4d04-9b58-20dc6dd1bd75, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:22,375 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 77728346-edcc-4fa1-b209-80b14bca7253, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,375 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 77728346-edcc-4fa1-b209-80b14bca7253, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored" }
2025-11-01 04:19:22,383 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 77728346-edcc-4fa1-b209-80b14bca7253, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:22,383 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, ee9f3c00-2daf-439d-bb2d-7114fd1c7fce, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,384 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, ee9f3c00-2daf-439d-bb2d-7114fd1c7fce, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 04:19:22,386 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, ee9f3c00-2daf-439d-bb2d-7114fd1c7fce, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 04:19:22,387 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 64028bf3-95a1-4687-a476-ffc6d0b42b61, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,388 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 64028bf3-95a1-4687-a476-ffc6d0b42b61, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,390 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 64028bf3-95a1-4687-a476-ffc6d0b42b61, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" } } } }
2025-11-01 04:19:22,391 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 762116f7-5a40-45a9-9821-cc19628a99cf, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,391 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 762116f7-5a40-45a9-9821-cc19628a99cf, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/folder/table" columns { name: "id" type { type_id: UINT32 } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,396 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 762116f7-5a40-45a9-9821-cc19628a99cf, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 04:19:22,397 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 19452f45-6744-4c5a-8c78-afa55a055490, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,398 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 19452f45-6744-4c5a-8c78-afa55a055490, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,427 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 19452f45-6744-4c5a-8c78-afa55a055490, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 04:19:22,427 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:22,428 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-01 04:19:22,429 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-11-01 04:19:22,429 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:22,430 - DEBUG - ya.test - execute: Command pid: 2506633
2025-11-01 04:19:22,632 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) rc: 0
2025-11-01 04:19:22,632 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) elapsed time (sec): 0.19991278648376465
2025-11-01 04:19:22,632 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) idrss: 0
2025-11-01 04:19:22,632 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) inblock: 0
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) isrss: 0
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) ixrss: 0
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) majflt: 0
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) maxrss: 167832
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) minflt: 3602
2025-11-01 04:19:22,633 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) msgrcv: 0
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) msgsnd: 0
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) nivcsw: 16
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) nsignals: 0
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) nswap: 0
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) nvcsw: 254
2025-11-01 04:19:22,634 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) oublock: 32
2025-11-01 04:19:22,635 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) stime: 0.035274
2025-11-01 04:19:22,635 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) utime: 0.054869999999999995
2025-11-01 04:19:22,635 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) wtime: 0.201
2025-11-01 04:19:22,635 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) output:

2025-11-01 04:19:22,635 - DEBUG - ya.test - _save_outputs: Command (pid 2506633) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 04:19:22,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, b5189a41-7ac9-4043-8093-860586ad2c6e, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,636 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, b5189a41-7ac9-4043-8093-860586ad2c6e, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:22,640 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, b5189a41-7ac9-4043-8093-860586ad2c6e, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:22,641 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:22,642 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.2
2025-11-01 04:19:22,643 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.2
2025-11-01 04:19:22,643 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_not_null', '--input', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:22,644 - DEBUG - ya.test - execute: Command pid: 2506724
2025-11-01 04:19:22,863 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) rc: 0
2025-11-01 04:19:22,864 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) elapsed time (sec): 0.21762847900390625
2025-11-01 04:19:22,864 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) idrss: 0
2025-11-01 04:19:22,864 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) inblock: 0
2025-11-01 04:19:22,864 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) isrss: 0
2025-11-01 04:19:22,864 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) ixrss: 0
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) majflt: 0
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) maxrss: 167832
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) minflt: 4177
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) msgrcv: 0
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) msgsnd: 0
2025-11-01 04:19:22,865 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) nivcsw: 52
2025-11-01 04:19:22,866 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) nsignals: 0
2025-11-01 04:19:22,866 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) nswap: 0
2025-11-01 04:19:22,866 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) nvcsw: 598
2025-11-01 04:19:22,866 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) oublock: 8
2025-11-01 04:19:22,866 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) stime: 0.023389
2025-11-01 04:19:22,867 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) utime: 0.079524
2025-11-01 04:19:22,867 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) wtime: 0.219
2025-11-01 04:19:22,867 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) output:

2025-11-01 04:19:22,867 - DEBUG - ya.test - _save_outputs: Command (pid 2506724) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_not_null"
Path after adjusting: "/Root/restored_not_null"

2025-11-01 04:19:22,868 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 44c840fe-17ea-4022-8dd5-c9eca1d2cc2e, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,868 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 44c840fe-17ea-4022-8dd5-c9eca1d2cc2e, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:22,872 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 44c840fe-17ea-4022-8dd5-c9eca1d2cc2e, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: "restored_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970762820 tx_id: 281474976710688 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:22,873 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 3ec18972-4f5a-4a47-a078-7a148981e119, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,873 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 3ec18972-4f5a-4a47-a078-7a148981e119, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-11-01 04:19:22,876 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 3ec18972-4f5a-4a47-a078-7a148981e119, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762820 tx_id: 281474976710688 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761970762850 tx_id: 281474976710689 } } } } } }
2025-11-01 04:19:22,877 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 687f3efe-ad03-41ac-a956-7eb988a8a1c3, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,877 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 687f3efe-ad03-41ac-a956-7eb988a8a1c3, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,880 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 687f3efe-ad03-41ac-a956-7eb988a8a1c3, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:22,881 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 35687908-6445-4403-a557-416195d57870, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,881 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 35687908-6445-4403-a557-416195d57870, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,885 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 35687908-6445-4403-a557-416195d57870, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762850 tx_id: 281474976710689 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:22,886 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 80de0514-8bba-42c2-9301-ce5ba3b744e4, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,887 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 80de0514-8bba-42c2-9301-ce5ba3b744e4, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 04:19:22,889 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 80de0514-8bba-42c2-9301-ce5ba3b744e4, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } } } } }
2025-11-01 04:19:22,891 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, c15fe40b-5d15-4266-9fce-a1413fce1779, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,891 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, c15fe40b-5d15-4266-9fce-a1413fce1779, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null/table" }
2025-11-01 04:19:22,894 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, c15fe40b-5d15-4266-9fce-a1413fce1779, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970762850 tx_id: 281474976710689 } } } } } }
2025-11-01 04:19:22,895 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, e094c11e-7362-48b3-9841-90e335bafe9a, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,895 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, e094c11e-7362-48b3-9841-90e335bafe9a, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/folder/table" ordered: true }
2025-11-01 04:19:22,896 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, e094c11e-7362-48b3-9841-90e335bafe9a, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:22,897 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 1d344be7-06fa-4f3e-ab65-42ae4e3f7b44, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,897 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 1d344be7-06fa-4f3e-ab65-42ae4e3f7b44, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/restored_not_null/table" ordered: true }
2025-11-01 04:19:22,898 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 1d344be7-06fa-4f3e-ab65-42ae4e3f7b44, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:22,903 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 610f59ee-69df-4315-9fa5-33e1badfc3f9, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,904 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 610f59ee-69df-4315-9fa5-33e1badfc3f9, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=YTQ5ZmZlMGQtNWNkMmU5N2MtMzYzYTA3YjUtYmY0NzNiNg==" path: "/Root/restored_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,914 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 610f59ee-69df-4315-9fa5-33e1badfc3f9, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:22,915 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 4dbbe68e-02b8-4317-9c1e-80c7291c4cc6, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,915 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 4dbbe68e-02b8-4317-9c1e-80c7291c4cc6, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_not_null" }
2025-11-01 04:19:22,934 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 4dbbe68e-02b8-4317-9c1e-80c7291c4cc6, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:22,934 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, 9f3f32ad-64ad-40e9-a70a-d6adbc767d25, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,935 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, 9f3f32ad-64ad-40e9-a70a-d6adbc767d25, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 04:19:22,938 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, 9f3f32ad-64ad-40e9-a70a-d6adbc767d25, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 04:19:22,938 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 73578c8a-65c7-4e1c-be46-2e29a9f54033, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,938 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 73578c8a-65c7-4e1c-be46-2e29a9f54033, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,940 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 73578c8a-65c7-4e1c-be46-2e29a9f54033, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" } } } }
2025-11-01 04:19:22,941 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 56e3658e-67a1-4062-ade3-33c1745d88c6, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,941 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 56e3658e-67a1-4062-ade3-33c1745d88c6, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/folder/table" columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,944 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 56e3658e-67a1-4062-ade3-33c1745d88c6, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 04:19:22,945 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 591ff506-23b9-423f-a8ee-bfdead473c60, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:22,946 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 591ff506-23b9-423f-a8ee-bfdead473c60, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:22,976 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 591ff506-23b9-423f-a8ee-bfdead473c60, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 04:19:22,977 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:22,978 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.3
2025-11-01 04:19:22,978 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.3
2025-11-01 04:19:22,978 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:22,982 - DEBUG - ya.test - execute: Command pid: 2507058
2025-11-01 04:19:23,235 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) rc: 0
2025-11-01 04:19:23,235 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) elapsed time (sec): 0.25246715545654297
2025-11-01 04:19:23,235 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) idrss: 0
2025-11-01 04:19:23,236 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) inblock: 0
2025-11-01 04:19:23,236 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) isrss: 0
2025-11-01 04:19:23,236 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) ixrss: 0
2025-11-01 04:19:23,237 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) majflt: 0
2025-11-01 04:19:23,237 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) maxrss: 167832
2025-11-01 04:19:23,238 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) minflt: 3610
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) msgrcv: 0
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) msgsnd: 0
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) nivcsw: 27
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) nsignals: 0
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) nswap: 0
2025-11-01 04:19:23,239 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) nvcsw: 249
2025-11-01 04:19:23,240 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) oublock: 32
2025-11-01 04:19:23,240 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) stime: 0.029606
2025-11-01 04:19:23,240 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) utime: 0.067672
2025-11-01 04:19:23,240 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) wtime: 0.256
2025-11-01 04:19:23,241 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) output:

2025-11-01 04:19:23,242 - DEBUG - ya.test - _save_outputs: Command (pid 2507058) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 04:19:23,242 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 3cb15b7e-302c-4829-a65e-96bd1027d2af, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,247 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 3cb15b7e-302c-4829-a65e-96bd1027d2af, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:23,251 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 3cb15b7e-302c-4829-a65e-96bd1027d2af, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:23,251 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:23,255 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.4
2025-11-01 04:19:23,256 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.4
2025-11-01 04:19:23,256 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert', '--input', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert/backup_files_dir', '--bulk-upsert']' in 'None' (waiting)
2025-11-01 04:19:23,258 - DEBUG - ya.test - execute: Command pid: 2507314
2025-11-01 04:19:23,520 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) rc: 0
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) elapsed time (sec): 0.2611856460571289
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) idrss: 0
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) inblock: 0
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) isrss: 0
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) ixrss: 0
2025-11-01 04:19:23,521 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) majflt: 0
2025-11-01 04:19:23,522 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) maxrss: 167832
2025-11-01 04:19:23,522 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) minflt: 4166
2025-11-01 04:19:23,522 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) msgrcv: 0
2025-11-01 04:19:23,522 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) msgsnd: 0
2025-11-01 04:19:23,522 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) nivcsw: 111
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) nsignals: 0
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) nswap: 0
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) nvcsw: 505
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) oublock: 8
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) stime: 0.049259
2025-11-01 04:19:23,523 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) utime: 0.053048
2025-11-01 04:19:23,524 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) wtime: 0.263
2025-11-01 04:19:23,524 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) output:

2025-11-01 04:19:23,524 - DEBUG - ya.test - _save_outputs: Command (pid 2507314) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_bulk_upsert"
Path after adjusting: "/Root/restored_bulk_upsert"

2025-11-01 04:19:23,524 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 4074accd-dea3-4795-8345-4619879d3b91, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,525 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 4074accd-dea3-4795-8345-4619879d3b91, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:23,533 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 4074accd-dea3-4795-8345-4619879d3b91, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970763470 tx_id: 281474976710707 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:23,534 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, e0ae5f90-e5a8-4ab5-b37c-6f30fde1a543, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,534 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, e0ae5f90-e5a8-4ab5-b37c-6f30fde1a543, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-11-01 04:19:23,538 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, e0ae5f90-e5a8-4ab5-b37c-6f30fde1a543, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970763470 tx_id: 281474976710707 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761970763500 tx_id: 281474976710708 } } } } } }
2025-11-01 04:19:23,538 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 99305af3-071d-4e7e-8259-3c6bf01e4e38, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,539 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 99305af3-071d-4e7e-8259-3c6bf01e4e38, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,542 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 99305af3-071d-4e7e-8259-3c6bf01e4e38, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:23,543 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 0e4327cb-9adf-4624-8133-7bde08a0e7c5, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,544 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 0e4327cb-9adf-4624-8133-7bde08a0e7c5, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,547 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 0e4327cb-9adf-4624-8133-7bde08a0e7c5, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970763500 tx_id: 281474976710708 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:23,548 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 190fdd79-82c5-4c3e-add3-de3651392c5b, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,549 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 190fdd79-82c5-4c3e-add3-de3651392c5b, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 04:19:23,554 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 190fdd79-82c5-4c3e-add3-de3651392c5b, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } } } } }
2025-11-01 04:19:23,554 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 1ad288e4-4da2-4b00-b658-f4bcb3a4f910, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,555 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 1ad288e4-4da2-4b00-b658-f4bcb3a4f910, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert/table" }
2025-11-01 04:19:23,558 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 1ad288e4-4da2-4b00-b658-f4bcb3a4f910, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970763500 tx_id: 281474976710708 } } } } } }
2025-11-01 04:19:23,558 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 8d980463-1511-4f56-9179-15958240b409, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,559 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 8d980463-1511-4f56-9179-15958240b409, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/folder/table" ordered: true }
2025-11-01 04:19:23,560 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 8d980463-1511-4f56-9179-15958240b409, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:23,560 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, aa64202d-2d00-4f6f-8d38-1aca8ad183c9, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,561 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, aa64202d-2d00-4f6f-8d38-1aca8ad183c9, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/restored_bulk_upsert/table" ordered: true }
2025-11-01 04:19:23,561 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, aa64202d-2d00-4f6f-8d38-1aca8ad183c9, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:23,577 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 3eca2595-c1ef-4727-b718-f0ca67f5fa0d, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,578 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 3eca2595-c1ef-4727-b718-f0ca67f5fa0d, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=ODM5MDk4NGEtMTYyNWIzYWEtNzVkYmJlNDktZTU0ZWJlNWM=" path: "/Root/restored_bulk_upsert/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,596 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 3eca2595-c1ef-4727-b718-f0ca67f5fa0d, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:23,597 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 5408f75a-89c5-4672-b89f-0ab9140a1137, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,598 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 5408f75a-89c5-4672-b89f-0ab9140a1137, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert" }
2025-11-01 04:19:23,614 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 5408f75a-89c5-4672-b89f-0ab9140a1137, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:23,615 - DEBUG - ydb.connection - _prepare_call: RpcState(MakeDirectory, fcadde91-bb89-455b-a055-15154d2471dc, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,615 - DEBUG - ydb.connection - _log_request: RpcState(MakeDirectory, fcadde91-bb89-455b-a055-15154d2471dc, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder" }
2025-11-01 04:19:23,621 - DEBUG - ydb.connection - _log_response: RpcState(MakeDirectory, fcadde91-bb89-455b-a055-15154d2471dc, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 6], type: EPathTypeDir, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_mkdir.cpp:155" severity: 1 } } }
2025-11-01 04:19:23,622 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, d7ddd95b-04a6-4ca1-9663-62dd5441443b, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,622 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, d7ddd95b-04a6-4ca1-9663-62dd5441443b, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,627 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, d7ddd95b-04a6-4ca1-9663-62dd5441443b, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" } } } }
2025-11-01 04:19:23,627 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f15e75b2-3612-4e03-bd4f-46891113b81f, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,628 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f15e75b2-3612-4e03-bd4f-46891113b81f, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/folder/table" columns { name: "id" type { type_id: UINT32 } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,632 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f15e75b2-3612-4e03-bd4f-46891113b81f, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS issues { message: "Check failed: path: \'/Root/folder/table\', error: path exist, request accepts it (id: [OwnerId: 72057594046678944, LocalPathId: 7], type: EPathTypeTable, state: EPathStateNoChanges), source_location: ydb/core/tx/schemeshard/schemeshard__operation_create_table.cpp:504" severity: 1 } } }
2025-11-01 04:19:23,633 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 523cd48a-cc3c-4d8d-a86b-576126bd4797, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,634 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 523cd48a-cc3c-4d8d-a86b-576126bd4797, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "\n        PRAGMA TablePathPrefix(\"/Root/folder\");\n        UPSERT INTO table (`id`, `number`, `string`, `fixed_point`) VALUES (2, 6,  \"pen\",       CAST(\"2.4\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`,           `string`, `fixed_point`) VALUES (3,     \"pineapple\", CAST(\"3.5\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`,          `fixed_point`) VALUES (5, 12,              CAST(\"512.6\" AS Decimal(22,9)));\n        UPSERT INTO table (`id`, `number`, `string`             ) VALUES (7, 15, \"pen\"          );\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:23,664 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 523cd48a-cc3c-4d8d-a86b-576126bd4797, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-01 04:19:23,665 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:23,666 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.5
2025-11-01 04:19:23,667 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.5
2025-11-01 04:19:23,667 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'dump', '--path', '/Root/folder', '--output', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert_not_null/backup_files_dir']' in 'None' (waiting)
2025-11-01 04:19:23,670 - DEBUG - ya.test - execute: Command pid: 2508133
2025-11-01 04:19:23,919 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) rc: 0
2025-11-01 04:19:23,919 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) elapsed time (sec): 0.24750423431396484
2025-11-01 04:19:23,919 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) idrss: 0
2025-11-01 04:19:23,920 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) inblock: 0
2025-11-01 04:19:23,920 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) isrss: 0
2025-11-01 04:19:23,920 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) ixrss: 0
2025-11-01 04:19:23,920 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) majflt: 0
2025-11-01 04:19:23,920 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) maxrss: 167832
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) minflt: 3617
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) msgrcv: 0
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) msgsnd: 0
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) nivcsw: 20
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) nsignals: 0
2025-11-01 04:19:23,921 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) nswap: 0
2025-11-01 04:19:23,922 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) nvcsw: 234
2025-11-01 04:19:23,922 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) oublock: 32
2025-11-01 04:19:23,922 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) stime: 0.030909
2025-11-01 04:19:23,922 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) utime: 0.061818
2025-11-01 04:19:23,923 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) wtime: 0.251
2025-11-01 04:19:23,923 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) output:

2025-11-01 04:19:23,923 - DEBUG - ya.test - _save_outputs: Command (pid 2508133) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/folder"
Path after adjusting: "/Root/folder"

2025-11-01 04:19:23,924 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 8835c519-750e-4e15-ae09-7aaa5bf0a706, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:23,924 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 8835c519-750e-4e15-ae09-7aaa5bf0a706, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:23,929 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 8835c519-750e-4e15-ae09-7aaa5bf0a706, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:23,931 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb
2025-11-01 04:19:23,932 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.6
2025-11-01 04:19:23,933 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.6
2025-11-01 04:19:23,934 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/g81u/004e5c/ydb/apps/ydb/ydb', '--verbose', '--endpoint', 'grpc://localhost:27628', '--database', '/Root', 'tools', 'restore', '--path', '/Root/restored_bulk_upsert_not_null', '--input', '/home/runner/.ya/build/build_root/g81u/004e5c/ydb/tests/functional/ydb_cli/test-results/py3test/testing_out_stuff/test_ydb_backup/chunk24/testing_out_stuff/TestSingleBackupRestore/test_single_table_with_data_backup_restore_bulk_upsert_not_null/backup_files_dir', '--bulk-upsert']' in 'None' (waiting)
2025-11-01 04:19:23,935 - DEBUG - ya.test - execute: Command pid: 2508404
2025-11-01 04:19:24,153 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) rc: 0
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) elapsed time (sec): 0.21717476844787598
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) idrss: 0
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) inblock: 0
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) isrss: 0
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) ixrss: 0
2025-11-01 04:19:24,154 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) majflt: 0
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) maxrss: 167832
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) minflt: 4172
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) msgrcv: 0
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) msgsnd: 0
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) nivcsw: 44
2025-11-01 04:19:24,155 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) nsignals: 0
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) nswap: 0
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) nvcsw: 575
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) oublock: 8
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) stime: 0.056498
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) utime: 0.047806
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) wtime: 0.219
2025-11-01 04:19:24,156 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) output:

2025-11-01 04:19:24,157 - DEBUG - ya.test - _save_outputs: Command (pid 2508404) errors:
No authentication methods were found. Going without authentication
Path before adjusting: "/Root/restored_bulk_upsert_not_null"
Path after adjusting: "/Root/restored_bulk_upsert_not_null"

2025-11-01 04:19:24,157 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 344cc04e-8350-4dce-87dc-36064c62bf4f, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,157 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 344cc04e-8350-4dce-87dc-36064c62bf4f, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root" }
2025-11-01 04:19:24,161 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 344cc04e-8350-4dce-87dc-36064c62bf4f, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761800 tx_id: 1 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761970759520 tx_id: 281474976710657 } } children { name: "folder" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970761850 tx_id: 281474976710660 } } children { name: "restored_bulk_upsert_not_null" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761970764140 tx_id: 281474976710725 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-01 04:19:24,162 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 8b2452e0-6faf-40a3-9d55-78337dbc336f, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,162 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 8b2452e0-6faf-40a3-9d55-78337dbc336f, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-11-01 04:19:24,165 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 8b2452e0-6faf-40a3-9d55-78337dbc336f, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970764140 tx_id: 281474976710725 } } children { name: "table" owner: "root@builtin" type: TABLE created_at { plan_step: 1761970764160 tx_id: 281474976710726 } } } } } }
2025-11-01 04:19:24,165 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 8e396b32-6e35-4550-bf9e-1624d87c77cd, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,166 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 8e396b32-6e35-4550-bf9e-1624d87c77cd, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/folder/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:24,169 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 8e396b32-6e35-4550-bf9e-1624d87c77cd, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:24,170 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribeTable, 415f7dd5-43f4-4f05-b1f4-18d8626f89c9, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,171 - DEBUG - ydb.connection - _log_request: RpcState(DescribeTable, 415f7dd5-43f4-4f05-b1f4-18d8626f89c9, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:24,174 - DEBUG - ydb.connection - _log_response: RpcState(DescribeTable, 415f7dd5-43f4-4f05-b1f4-18d8626f89c9, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970764160 tx_id: 281474976710726 } } columns { name: "id" type { optional_type { item { type_id: UINT32 } } } } columns { name: "number" type { optional_type { item { type_id: UINT64 } } } } columns { name: "string" type { optional_type { item { type_id: STRING } } } } columns { name: "fixed_point" type { optional_type { item { decimal_type { precision: 22 scale: 9 } } } } } primary_key: "id" storage_settings { store_external_blobs: DISABLED } column_families { name: "default" compression: COMPRESSION_NONE } partitioning_settings { partitioning_by_size: ENABLED partition_size_mb: 2048 partitioning_by_load: DISABLED min_partitions_count: 1 } } } } }
2025-11-01 04:19:24,175 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, b427bbc5-9c11-4a4b-9eb9-599f7f0ebe0e, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,175 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, b427bbc5-9c11-4a4b-9eb9-599f7f0ebe0e, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/folder/table" }
2025-11-01 04:19:24,177 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, b427bbc5-9c11-4a4b-9eb9-599f7f0ebe0e, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970761890 tx_id: 281474976710661 } } } } } }
2025-11-01 04:19:24,178 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, e86bf672-cecd-4b4b-b59f-38432db8e8b8, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,178 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, e86bf672-cecd-4b4b-b59f-38432db8e8b8, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null/table" }
2025-11-01 04:19:24,181 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, e86bf672-cecd-4b4b-b59f-38432db8e8b8, ghrun-i4gyxlpqdu.auto.internal:27628): 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: 1761970764160 tx_id: 281474976710726 } } } } } }
2025-11-01 04:19:24,181 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 1941b1f1-dfb7-43f8-83e2-f8c4c6a26a42, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,182 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 1941b1f1-dfb7-43f8-83e2-f8c4c6a26a42, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/folder/table" ordered: true }
2025-11-01 04:19:24,183 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 1941b1f1-dfb7-43f8-83e2-f8c4c6a26a42, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:24,183 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamReadTable, 24c733a7-6d71-4ea0-b4f7-510a2cca27cb, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,184 - DEBUG - ydb.connection - _log_request: RpcState(StreamReadTable, 24c733a7-6d71-4ea0-b4f7-510a2cca27cb, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/restored_bulk_upsert_not_null/table" ordered: true }
2025-11-01 04:19:24,184 - DEBUG - ydb.connection - _log_response: RpcState(StreamReadTable, 24c733a7-6d71-4ea0-b4f7-510a2cca27cb, ghrun-i4gyxlpqdu.auto.internal:27628): response = { <_MultiThreadedRendezvous object> }
2025-11-01 04:19:24,194 - DEBUG - ydb.connection - _prepare_call: RpcState(DropTable, 8e3d1f54-cf4f-42c0-bf11-c6d7c6bc5b12, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,195 - DEBUG - ydb.connection - _log_request: RpcState(DropTable, 8e3d1f54-cf4f-42c0-bf11-c6d7c6bc5b12, ghrun-i4gyxlpqdu.auto.internal:27628): request = { session_id: "ydb://session/3?node_id=1&id=NGQ4ZTQzMzMtN2NkOTJmYTQtODZlYmFhZGYtZjc0NDNlZjg=" path: "/Root/restored_bulk_upsert_not_null/table" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-01 04:19:24,204 - DEBUG - ydb.connection - _log_response: RpcState(DropTable, 8e3d1f54-cf4f-42c0-bf11-c6d7c6bc5b12, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:24,204 - DEBUG - ydb.connection - _prepare_call: RpcState(RemoveDirectory, 75697b71-b706-4b22-bdcf-031b6b9fa9db, ghrun-i4gyxlpqdu.auto.internal:27628): creating call state
2025-11-01 04:19:24,205 - DEBUG - ydb.connection - _log_request: RpcState(RemoveDirectory, 75697b71-b706-4b22-bdcf-031b6b9fa9db, ghrun-i4gyxlpqdu.auto.internal:27628): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/restored_bulk_upsert_not_null" }
2025-11-01 04:19:24,216 - DEBUG - ydb.connection - _log_response: RpcState(RemoveDirectory, 75697b71-b706-4b22-bdcf-031b6b9fa9db, ghrun-i4gyxlpqdu.auto.internal:27628): response = { operation { ready: true status: SUCCESS } }
2025-11-01 04:19:24,217 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-01 04:19:46,223 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:27628/1
2025-11-01 04:19:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4384
2025-11-01 04:19:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26489
2025-11-01 04:19:46,224 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20518
2025-11-01 04:19:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27628
2025-11-01 04:19:46,225 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/16342
