2025-11-04 12:07:33,134 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-04 12:07:33,134 - INFO - ya.test - pytest_runtest_setup: test_private_queue_recreation[tables_format_v1-fifo]
2025-11-04 12:07:33,134 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-04 12:07:33,134 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-04 12:07:33,215 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd
2025-11-04 12:07:33,217 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14845
2025-11-04 12:07:33,219 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/6mpi/001b24/r3tmp/kikimr_cluster_t22t6hfe
2025-11-04 12:07:33,261 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd
2025-11-04 12:07:33,261 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24498
2025-11-04 12:07:33,262 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/10227
2025-11-04 12:07:33,262 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24833
2025-11-04 12:07:33,262 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24685
2025-11-04 12:07:33,263 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24686
2025-11-04 12:07:33,264 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13600
2025-11-04 12:07:33,265 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/kikimr_configs"
2025-11-04 12:07:33,266 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/6mpi/001b24/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/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/node_1/logfile_i2gcl8pg.log --grpc-port=24498 --mon-port=10227 --ic-port=14845 --sqs-port=13600
2025-11-04 12:07:33,266 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:24498/1, disk_size 68719476736
2025-11-04 12:07:33,266 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/kikimr_configs"
2025-11-04 12:07:33,267 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/6mpi/001b24/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/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/node_1/logfile_i2gcl8pg.log --grpc-port=24498 --mon-port=10227 --ic-port=14845 --sqs-port=13600
2025-11-04 12:07:33,268 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/node_1/logfile_i2gcl8pg.log', '--grpc-port=24498', '--mon-port=10227', '--ic-port=14845', '--sqs-port=13600')' in '/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/node_1' (no wait)
2025-11-04 12:07:33,270 - DEBUG - ya.test - execute: Command pid: 2645236
2025-11-04 12:07:33,271 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:24498/1
2025-11-04 12:07:33,272 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-04 12:07:33,273 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-04 12:07:33,276 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-04 12:07:33,280 - DEBUG - ya.test - execute: Command pid: 2645242
2025-11-04 12:07:33,773 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) rc: 0
2025-11-04 12:07:33,773 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) elapsed time (sec): 0.49245142936706543
2025-11-04 12:07:33,773 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) idrss: 0
2025-11-04 12:07:33,774 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) inblock: 0
2025-11-04 12:07:33,774 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) isrss: 0
2025-11-04 12:07:33,774 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) ixrss: 0
2025-11-04 12:07:33,774 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) majflt: 0
2025-11-04 12:07:33,775 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) maxrss: 538572
2025-11-04 12:07:33,775 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) minflt: 16128
2025-11-04 12:07:33,781 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) msgrcv: 0
2025-11-04 12:07:33,781 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) msgsnd: 0
2025-11-04 12:07:33,781 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) nivcsw: 80
2025-11-04 12:07:33,781 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) nsignals: 0
2025-11-04 12:07:33,781 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) nswap: 0
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) nvcsw: 13
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) oublock: 8
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) stime: 0.28995699999999996
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) utime: 0.10467
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) wtime: 0.496
2025-11-04 12:07:33,782 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) output:
Git info:
    Commit: 1929c9518fdd96b4e46371c8ffa93f5a23ca8f28
    Branch: 
    Author: AlexSm <alex@ydb.tech>
    Summary: Merge eceb86f303f339ed52a89fe27dbbc6af3d6e1458 into f5ad9b55634ac97de44bee49e39356e042dc62cf

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-txp46ju72i
    Host information: 
        Linux ghrun-txp46ju72i 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-04 12:07:33,783 - DEBUG - ya.test - _save_outputs: Command (pid 2645242) errors:

2025-11-04 12:07:33,783 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 1929c9518fdd96b4e46371c8ffa93f5a23ca8f28
    Branch: 
    Author: AlexSm <alex@ydb.tech>
    Summary: Merge eceb86f303f339ed52a89fe27dbbc6af3d6e1458 into f5ad9b55634ac97de44bee49e39356e042dc62cf
2025-11-04 12:07:35,743 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd
2025-11-04 12:07:35,743 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24498', '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: 14845\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-04 12:07:35,761 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-04 12:07:35,762 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-04 12:07:35,772 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24498', '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: 14845\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-04 12:07:35,774 - DEBUG - ya.test - execute: Command pid: 2646531
2025-11-04 12:07:36,651 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) rc: 0
2025-11-04 12:07:36,652 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) elapsed time (sec): 0.876751184463501
2025-11-04 12:07:36,652 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) idrss: 0
2025-11-04 12:07:36,652 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) inblock: 0
2025-11-04 12:07:36,652 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) isrss: 0
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) ixrss: 0
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) majflt: 0
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) maxrss: 546972
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) minflt: 18276
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) msgrcv: 0
2025-11-04 12:07:36,653 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) msgsnd: 0
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) nivcsw: 117
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) nsignals: 0
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) nswap: 0
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) nvcsw: 126
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) oublock: 8
2025-11-04 12:07:36,654 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) stime: 0.459425
2025-11-04 12:07:36,655 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) utime: 0.128524
2025-11-04 12:07:36,655 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) wtime: 0.878
2025-11-04 12:07:36,655 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-11-04 12:07:36,655 - DEBUG - ya.test - _save_outputs: Command (pid 2646531) errors:

2025-11-04 12:07:36,656 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd
2025-11-04 12:07:36,656 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24498', '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-04 12:07:36,657 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-04 12:07:36,658 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-04 12:07:36,658 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:24498', '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-04 12:07:36,659 - DEBUG - ya.test - execute: Command pid: 2646819
2025-11-04 12:07:37,400 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) rc: 0
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) elapsed time (sec): 0.7402801513671875
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) idrss: 0
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) inblock: 0
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) isrss: 0
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) ixrss: 0
2025-11-04 12:07:37,401 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) majflt: 0
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) maxrss: 546984
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) minflt: 18274
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) msgrcv: 0
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) msgsnd: 0
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) nivcsw: 111
2025-11-04 12:07:37,402 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) nsignals: 0
2025-11-04 12:07:37,403 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) nswap: 0
2025-11-04 12:07:37,403 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) nvcsw: 125
2025-11-04 12:07:37,403 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) oublock: 8
2025-11-04 12:07:37,403 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) stime: 0.510325
2025-11-04 12:07:37,403 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) utime: 0.138462
2025-11-04 12:07:37,404 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) wtime: 0.741
2025-11-04 12:07:37,404 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-04 12:07:37,416 - DEBUG - ya.test - _save_outputs: Command (pid 2646819) errors:

2025-11-04 12:07:37,418 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-04 12:07:37,444 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-04 12:07:37,457 - 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-04 12:07:37,459 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-04 12:07:37,464 - 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-04 12:07:37,481 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-04 12:07:37,481 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 082a2964-e514-4f8e-a579-6fb0092857e2, localhost:24498): creating call state
2025-11-04 12:07:37,482 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 082a2964-e514-4f8e-a579-6fb0092857e2, localhost:24498): request = { database: "/Root" }
2025-11-04 12:07:37,490 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 082a2964-e514-4f8e-a579-6fb0092857e2, localhost:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-txp46ju72i.auto.internal" port: 24498 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-04 12:07:37,490 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-txp46ju72i.auto.internal:24498, location 1, ssl: False>]>
2025-11-04 12:07:37,490 - 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-04 12:07:37,509 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24498
2025-11-04 12:07:37,516 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-04 12:07:37,517 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7fb10263f800 state=pending>
2025-11-04 12:07:37,518 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-04 12:07:37,518 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:37,518 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:37,519 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 19d3e387-ccc4-4d04-980f-103e62347799, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,519 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 19d3e387-ccc4-4d04-980f-103e62347799, ghrun-txp46ju72i.auto.internal:24498): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-04 12:07:37,533 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 19d3e387-ccc4-4d04-980f-103e62347799, ghrun-txp46ju72i.auto.internal:24498): on response callback started
2025-11-04 12:07:37,534 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 19d3e387-ccc4-4d04-980f-103e62347799, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" } } } }
2025-11-04 12:07:37,539 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 19d3e387-ccc4-4d04-980f-103e62347799, ghrun-txp46ju72i.auto.internal:24498): on response callback success
2025-11-04 12:07:37,539 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:37,540 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:37,541 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 829c2dea-4166-441e-96fb-d9870339308a, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,552 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 829c2dea-4166-441e-96fb-d9870339308a, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS//.AtomicCounter" columns { name: "counter_key" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UINT64 } } } } primary_key: "counter_key" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,635 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 829c2dea-4166-441e-96fb-d9870339308a, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:37,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 7dad5db7-f114-4d8c-9d40-06340138500c, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,637 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 7dad5db7-f114-4d8c-9d40-06340138500c, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\nINSERT INTO `/Root/PathSQS//.AtomicCounter` (counter_key, value) VALUES (0, 0);" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,689 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 7dad5db7-f114-4d8c-9d40-06340138500c, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-04 12:07:37,716 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ae6bbaf9-6610-494f-90f4-fc12857d27d7, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,718 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ae6bbaf9-6610-494f-90f4-fc12857d27d7, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS//.Queues" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "QueueName" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,801 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ae6bbaf9-6610-494f-90f4-fc12857d27d7, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:37,802 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2ef1bbdc-3e76-4192-8b61-2033fa2a5b87, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,803 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2ef1bbdc-3e76-4192-8b61-2033fa2a5b87, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS//.Events" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "EventType" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "EventTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Labels" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "QueueName" primary_key: "EventType" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,861 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2ef1bbdc-3e76-4192-8b61-2033fa2a5b87, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:37,862 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 1fd9775d-ece1-4aa4-bc49-51e8369a1e13, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,863 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 1fd9775d-ece1-4aa4-bc49-51e8369a1e13, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS//.Settings" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Name" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "Name" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,899 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 1fd9775d-ece1-4aa4-bc49-51e8369a1e13, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:37,929 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, dd49a869-c531-4138-b36e-9411c5d7e883, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:37,931 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, dd49a869-c531-4138-b36e-9411c5d7e883, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS//.RemovedQueues" columns { name: "RemoveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT32 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "StartProcessTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "NodeProcess" type { optional_type { item { type_id: UINT32 } } } } primary_key: "RemoveTimestamp" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:37,997 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, dd49a869-c531-4138-b36e-9411c5d7e883, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,018 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, c6913171-274f-4fe8-8a9f-40c7a7433bf5, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,020 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, c6913171-274f-4fe8-8a9f-40c7a7433bf5, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//SentTimestampIdx" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "SentTimestamp" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,086 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, c6913171-274f-4fe8-8a9f-40c7a7433bf5, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,087 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2531446b-2fbc-4ee9-9e21-c3d9bf651182, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,088 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2531446b-2fbc-4ee9-9e21-c3d9bf651182, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//Messages" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,156 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2531446b-2fbc-4ee9-9e21-c3d9bf651182, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,157 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 2a2ba670-0eec-422f-a25d-2e6c732158b9, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,158 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 2a2ba670-0eec-422f-a25d-2e6c732158b9, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//State" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "CleanupTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LastModifiedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RetentionBoundary" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "MessageCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "ReadOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "WriteOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupVersion" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyVersion" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "Shard" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,199 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 2a2ba670-0eec-422f-a25d-2e6c732158b9, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,200 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, d6b9feee-aff0-4409-a0bb-1b838d1ce42d, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,202 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, d6b9feee-aff0-4409-a0bb-1b838d1ce42d, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//Attributes" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ContentBasedDeduplication" type { optional_type { item { type_id: BOOL } } } } columns { name: "DelaySeconds" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "MaximumMessageSize" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageRetentionPeriod" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveMessageWaitTime" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityTimeout" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DlqArn" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MaxReceiveCount" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ShowDetailedCountersDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,245 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, d6b9feee-aff0-4409-a0bb-1b838d1ce42d, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,246 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, d4d8845c-f76b-4597-a365-5d8bf22b5141, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,247 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, d4d8845c-f76b-4597-a365-5d8bf22b5141, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//SentTimestampIdx" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "SentTimestamp" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,287 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, d4d8845c-f76b-4597-a365-5d8bf22b5141, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,288 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5c1a4bb4-439e-43bd-8481-516fe98e9c25, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,291 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5c1a4bb4-439e-43bd-8481-516fe98e9c25, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Messages" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } columns { name: "NextOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "NextRandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveCount" type { optional_type { item { type_id: UINT32 } } } } columns { name: "FirstReceiveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,368 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5c1a4bb4-439e-43bd-8481-516fe98e9c25, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,369 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 9aed0413-3fa5-400e-a44b-d53b8d1c83e5, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,371 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 9aed0413-3fa5-400e-a44b-d53b8d1c83e5, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//State" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LastModifiedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RetentionBoundary" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "MessageCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "ReadOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "WriteOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupVersion" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyVersion" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,428 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 9aed0413-3fa5-400e-a44b-d53b8d1c83e5, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,429 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 835013ea-685e-4e29-85a6-65e24b517f6a, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,434 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 835013ea-685e-4e29-85a6-65e24b517f6a, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Attributes" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ContentBasedDeduplication" type { optional_type { item { type_id: BOOL } } } } columns { name: "DelaySeconds" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "MaximumMessageSize" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageRetentionPeriod" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveMessageWaitTime" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityTimeout" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DlqArn" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MaxReceiveCount" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ShowDetailedCountersDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,509 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 835013ea-685e-4e29-85a6-65e24b517f6a, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,510 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 4d4721f6-c92b-4359-9d36-5250c6e68fc0, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,511 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 4d4721f6-c92b-4359-9d36-5250c6e68fc0, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//Infly" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LoadId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FirstReceiveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LockTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveCount" type { optional_type { item { type_id: UINT32 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,554 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 4d4721f6-c92b-4359-9d36-5250c6e68fc0, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,556 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 7320c834-9d31-4490-a809-8f47d70d24a2, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,557 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 7320c834-9d31-4490-a809-8f47d70d24a2, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.STD//MessageData" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Attributes" type { optional_type { item { type_id: STRING } } } } columns { name: "Data" type { optional_type { item { type_id: STRING } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } columns { name: "SenderId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "RandomId" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,622 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 7320c834-9d31-4490-a809-8f47d70d24a2, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,623 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 6589462f-a96d-489a-a9ec-acd1c85629fb, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,626 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 6589462f-a96d-489a-a9ec-acd1c85629fb, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Reads" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveAttemptId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Deadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "ReceiveAttemptId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,669 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 6589462f-a96d-489a-a9ec-acd1c85629fb, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,670 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f4adef99-8f72-4c98-8ab7-6e5a91e1a8eb, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,671 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f4adef99-8f72-4c98-8ab7-6e5a91e1a8eb, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Groups" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } columns { name: "VisibilityDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Head" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Tail" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveAttemptId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "LockTimestamp" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "GroupId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,720 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f4adef99-8f72-4c98-8ab7-6e5a91e1a8eb, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,721 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 981e3b8e-1f7e-479c-a940-7a2807fd5037, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,722 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 981e3b8e-1f7e-479c-a940-7a2807fd5037, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Deduplication" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DedupId" type { optional_type { item { type_id: STRING } } } } columns { name: "Deadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "DedupId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,754 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 981e3b8e-1f7e-479c-a940-7a2807fd5037, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,758 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 9aff45aa-9da4-499e-b15e-9867bd23efd0, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,777 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 9aff45aa-9da4-499e-b15e-9867bd23efd0, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" path: "/Root/PathSQS/.FIFO//Data" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SenderId" type { optional_type { item { type_id: STRING } } } } columns { name: "DedupId" type { optional_type { item { type_id: STRING } } } } columns { name: "Attributes" type { optional_type { item { type_id: STRING } } } } columns { name: "Data" type { optional_type { item { type_id: STRING } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "RandomId" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-11-04 12:07:38,809 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 9aff45aa-9da4-499e-b15e-9867bd23efd0, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,813 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:38,831 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-11-04 12:07:38,832 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-04 12:07:38,832 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-11-04 12:07:38,832 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7fb10263f120>, reason: session-pool-terminated
2025-11-04 12:07:38,832 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7fb10263f120> is no longer active. Current active count 0.
2025-11-04 12:07:38,838 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 8aaf343c-4f02-4131-8481-f5087db5870b, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:38,839 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 8aaf343c-4f02-4131-8481-f5087db5870b, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=OWExNmYyYzctOGU1ODMyNzYtY2Y5MmVlOGQtNWFmNzg0MGE=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-04 12:07:38,833 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-11-04 12:07:38,848 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 8aaf343c-4f02-4131-8481-f5087db5870b, ghrun-txp46ju72i.auto.internal:24498): on response callback started
2025-11-04 12:07:38,849 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 8aaf343c-4f02-4131-8481-f5087db5870b, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS } }
2025-11-04 12:07:38,849 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 8aaf343c-4f02-4131-8481-f5087db5870b, ghrun-txp46ju72i.auto.internal:24498): on response callback success
2025-11-04 12:07:38,850 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7fb10263f120>
2025-11-04 12:07:38,850 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-11-04 12:07:38,850 - DEBUG - ydb.topic - close: Close topic client
2025-11-04 12:07:38,850 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-04 12:07:38,850 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24498
2025-11-04 12:07:38,851 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-txp46ju72i.auto.internal:24498
2025-11-04 12:07:38,852 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-04 12:07:38,853 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to curl.out
2025-11-04 12:07:38,858 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to curl.err
2025-11-04 12:07:38,865 - DEBUG - ya.test - execute: Executing '['curl', '-v', 'localhost:13600?Action=CreateUser&UserName=metauser', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-04 12:07:38,869 - DEBUG - ya.test - execute: Command pid: 2647803
2025-11-04 12:07:38,894 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) rc: 0
2025-11-04 12:07:38,895 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) elapsed time (sec): 0.022716760635375977
2025-11-04 12:07:38,895 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) idrss: 0
2025-11-04 12:07:38,895 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) inblock: 0
2025-11-04 12:07:38,895 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) isrss: 0
2025-11-04 12:07:38,895 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) ixrss: 0
2025-11-04 12:07:38,896 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) majflt: 0
2025-11-04 12:07:38,896 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) maxrss: 170164
2025-11-04 12:07:38,896 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) minflt: 592
2025-11-04 12:07:38,896 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) msgrcv: 0
2025-11-04 12:07:38,896 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) msgsnd: 0
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) nivcsw: 3
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) nsignals: 0
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) nswap: 0
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) nvcsw: 2
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) oublock: 16
2025-11-04 12:07:38,897 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) stime: 0.0
2025-11-04 12:07:38,898 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) utime: 0.010943999999999999
2025-11-04 12:07:38,898 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) wtime: 0.027
2025-11-04 12:07:38,898 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) output:
<?xml version="1.0" encoding="UTF-8"?>
<CreateUserResponse><ResponseMetadata><RequestId>d7cc0728-a3da4601-488f2a71-5aedcb3</RequestId></ResponseMetadata></CreateUserResponse>

2025-11-04 12:07:38,898 - DEBUG - ya.test - _save_outputs: Command (pid 2647803) errors:
*   Trying 127.0.0.1:13600...
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0* Connected to localhost (127.0.0.1) port 13600 (#0)
> GET /?Action=CreateUser&UserName=metauser HTTP/1.1
> Host: localhost:13600
> User-Agent: curl/7.81.0
> Accept: */*
> authorization: aaa credential=abacaba/20220830/ec2/aws4_request
> 
* Mark bundle as not supporting multiuse
< HTTP/1.1 200 Ok
< Content-Type: application/xml
< Content-Length: 175
< Connection: Keep-Alive
< 
{ [175 bytes data]

100   175  100   175    0     0  11609      0 --:--:-- --:--:-- --:--:-- 12500
* Connection #0 to host localhost left intact

2025-11-04 12:07:38,900 - DEBUG - root - setup_method: Test started: test_private_queue_recreation
2025-11-04 12:07:38,905 - DEBUG - root - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo
2025-11-04 12:07:38,905 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/kikimr_configs"
2025-11-04 12:07:38,905 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/6mpi/001b24/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/6mpi/001b24/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk7/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v1-fifo/cluster/node_1/logfile_i2gcl8pg.log --grpc-port=24498 --mon-port=10227 --ic-port=14845 --sqs-port=13600
2025-11-04 12:07:38,905 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:24498/1
2025-11-04 12:07:38,907 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-04 12:07:38,913 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-04 12:07:38,920 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/6mpi/001b24/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-04 12:07:38,926 - DEBUG - ya.test - execute: Command pid: 2647850
2025-11-04 12:07:39,680 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) rc: 0
2025-11-04 12:07:39,681 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) elapsed time (sec): 0.7524423599243164
2025-11-04 12:07:39,681 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) idrss: 0
2025-11-04 12:07:39,681 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) inblock: 0
2025-11-04 12:07:39,681 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) isrss: 0
2025-11-04 12:07:39,681 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) ixrss: 0
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) majflt: 0
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) maxrss: 538572
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) minflt: 16175
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) msgrcv: 0
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) msgsnd: 0
2025-11-04 12:07:39,682 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) nivcsw: 118
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) nsignals: 0
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) nswap: 0
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) nvcsw: 23
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) oublock: 8
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) stime: 0.480381
2025-11-04 12:07:39,683 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) utime: 0.12074
2025-11-04 12:07:39,684 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) wtime: 0.755
2025-11-04 12:07:39,684 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) output:
Git info:
    Commit: 1929c9518fdd96b4e46371c8ffa93f5a23ca8f28
    Branch: 
    Author: AlexSm <alex@ydb.tech>
    Summary: Merge eceb86f303f339ed52a89fe27dbbc6af3d6e1458 into f5ad9b55634ac97de44bee49e39356e042dc62cf

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-txp46ju72i
    Host information: 
        Linux ghrun-txp46ju72i 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-04 12:07:39,684 - DEBUG - ya.test - _save_outputs: Command (pid 2647850) errors:

2025-11-04 12:07:39,684 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 1929c9518fdd96b4e46371c8ffa93f5a23ca8f28
    Branch: 
    Author: AlexSm <alex@ydb.tech>
    Summary: Merge eceb86f303f339ed52a89fe27dbbc6af3d6e1458 into f5ad9b55634ac97de44bee49e39356e042dc62cf
2025-11-04 12:07:39,689 - DEBUG - root - _setup_user: Running curl -v localhost:13600?Action=CreateUser&UserName=U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 -H authorization: aaa credential=abacaba/20220830/ec2/aws4_request
2025-11-04 12:07:39,694 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to curl.out.0
2025-11-04 12:07:39,695 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to curl.err.0
2025-11-04 12:07:39,695 - DEBUG - ya.test - execute: Executing '['curl', '-v', 'localhost:13600?Action=CreateUser&UserName=U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-04 12:07:39,705 - DEBUG - ya.test - execute: Command pid: 2648130
2025-11-04 12:07:39,720 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) rc: 0
2025-11-04 12:07:39,721 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) elapsed time (sec): 0.012372255325317383
2025-11-04 12:07:39,721 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) idrss: 0
2025-11-04 12:07:39,721 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) inblock: 0
2025-11-04 12:07:39,721 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) isrss: 0
2025-11-04 12:07:39,721 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) ixrss: 0
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) majflt: 0
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) maxrss: 170164
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) minflt: 592
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) msgrcv: 0
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) msgsnd: 0
2025-11-04 12:07:39,722 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) nivcsw: 4
2025-11-04 12:07:39,723 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) nsignals: 0
2025-11-04 12:07:39,723 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) nswap: 0
2025-11-04 12:07:39,723 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) nvcsw: 2
2025-11-04 12:07:39,723 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) oublock: 16
2025-11-04 12:07:39,723 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) stime: 0.007430999999999999
2025-11-04 12:07:39,724 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) utime: 0.003715
2025-11-04 12:07:39,724 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) wtime: 0.023
2025-11-04 12:07:39,724 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) output:
<?xml version="1.0" encoding="UTF-8"?>
<CreateUserResponse><ResponseMetadata><RequestId>dd15d44d-82de102c-93b73715-42c78bcd</RequestId></ResponseMetadata></CreateUserResponse>

2025-11-04 12:07:39,726 - DEBUG - ya.test - _save_outputs: Command (pid 2648130) errors:
*   Trying 127.0.0.1:13600...
  % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
                                 Dload  Upload   Total   Spent    Left  Speed

  0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0* Connected to localhost (127.0.0.1) port 13600 (#0)
> GET /?Action=CreateUser&UserName=U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 HTTP/1.1
> Host: localhost:13600
> User-Agent: curl/7.81.0
> Accept: */*
> authorization: aaa credential=abacaba/20220830/ec2/aws4_request
> 
* Mark bundle as not supporting multiuse
< HTTP/1.1 200 Ok
< Content-Type: application/xml
< Content-Length: 176
< Connection: Keep-Alive
< 
{ [176 bytes data]

100   176  100   176    0     0  17270      0 --:--:-- --:--:-- --:--:-- 19555
* Connection #0 to host localhost left intact

2025-11-04 12:07:39,727 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Listing SQS users
2025-11-04 12:07:39,727 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600 from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: Action=ListQueues
2025-11-04 12:07:39,731 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:13600
2025-11-04 12:07:39,918 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST / HTTP/1.1" 200 195
2025-11-04 12:07:39,941 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:39,942 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<ListQueuesResponse><ListQueuesResult/><ResponseMetadata><RequestId>e2e7c7d3-31bc4f64-534bb33f-5cc16ce6</RequestId></ResponseMetadata></ListQueuesResponse>

2025-11-04 12:07:39,942 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:39,943 - ERROR - ydb.tests.library.sqs.requests_client - _process_response: Could not process response from SQS: {'ListQueuesResponse': {'ListQueuesResult': None, 'ResponseMetadata': {'RequestId': 'e2e7c7d3-31bc4f64-534bb33f-5cc16ce6'}}}. <class 'TypeError'>: 'NoneType' object is not subscriptable
2025-11-04 12:07:39,943 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Success. Api is up.
2025-11-04 12:07:39,944 - 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-04 12:07:39,946 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-04 12:07:39,947 - 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-04 12:07:39,964 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-04 12:07:39,965 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 335fa399-b51e-4e3c-8d7b-2424ad4bb36c, localhost:24498): creating call state
2025-11-04 12:07:39,965 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 335fa399-b51e-4e3c-8d7b-2424ad4bb36c, localhost:24498): request = { database: "/Root" }
2025-11-04 12:07:39,970 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 335fa399-b51e-4e3c-8d7b-2424ad4bb36c, localhost:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-txp46ju72i.auto.internal" port: 24498 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-04 12:07:39,970 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-txp46ju72i.auto.internal:24498, location 1, ssl: False>]>
2025-11-04 12:07:39,971 - 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-04 12:07:39,997 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_common.py::TestCommonYandexWithPath, test_name: test_private_queue_recreation[tables_format_v1-fifo])
2025-11-04 12:07:39,998 - DEBUG - root - _execute_yql_query: Executing database query: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES ("U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25", "CreateQueuesWithTabletFormat", "1")"
2025-11-04 12:07:39,998 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 8e6d7b65-190d-4213-9a24-cbbf75059356, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:39,998 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 8e6d7b65-190d-4213-9a24-cbbf75059356, ghrun-txp46ju72i.auto.internal:24498): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,002 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 8e6d7b65-190d-4213-9a24-cbbf75059356, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=M2ZlMTQ3YjUtM2FiNjRjYi1kYThmN2I2NC1lZThmNDUxMw==" } } } }
2025-11-04 12:07:40,002 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, e2bdd87f-ee32-4be6-a376-5060d3ae3bc9, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:40,003 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, e2bdd87f-ee32-4be6-a376-5060d3ae3bc9, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=M2ZlMTQ3YjUtM2FiNjRjYi1kYThmN2I2NC1lZThmNDUxMw==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES (\"U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25\", \"CreateQueuesWithTabletFormat\", \"1\")" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,021 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, e2bdd87f-ee32-4be6-a376-5060d3ae3bc9, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-04 12:07:40,021 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600 from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: QueueName=Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-04 12:07:40,077 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST / HTTP/1.1" 200 414
2025-11-04 12:07:40,097 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,097 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-txp46ju72i.auto.internal:13600/U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25/Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>3a9c2a30-4afe4dba-eecc9543-d982eb1a</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-04 12:07:40,098 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,099 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600 from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: QueueUrl=http%3A%2F%2Fghrun-txp46ju72i.auto.internal%3A13600%2FU_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25%2FQ_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo&AttributeName.1=All&Action=GetQueueAttributes
2025-11-04 12:07:40,154 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST / HTTP/1.1" 200 1304
2025-11-04 12:07:40,185 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,186 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<GetQueueAttributesResponse><GetQueueAttributesResult><Attribute><Name>ApproximateNumberOfMessages</Name><Value>0</Value></Attribute><Attribute><Name>ApproximateNumberOfMessagesDelayed</Name><Value>0</Value></Attribute><Attribute><Name>ApproximateNumberOfMessagesNotVisible</Name><Value>0</Value></Attribute><Attribute><Name>ContentBasedDeduplication</Name><Value>false</Value></Attribute><Attribute><Name>CreatedTimestamp</Name><Value>1762258060</Value></Attribute><Attribute><Name>DelaySeconds</Name><Value>0</Value></Attribute><Attribute><Name>FifoQueue</Name><Value>true</Value></Attribute><Attribute><Name>MaximumMessageSize</Name><Value>262144</Value></Attribute><Attribute><Name>MessageRetentionPeriod</Name><Value>345600</Value></Attribute><Attribute><Name>ReceiveMessageWaitTimeSeconds</Name><Value>0</Value></Attribute><Attribute><Name>VisibilityTimeout</Name><Value>30</Value></Attribute><Attribute><Name>QueueArn</Name><Value>yrn:ya:sqs:ru-central1:U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25:Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>ecf37d20-6bb78bee-51d5e7c1-71006da6</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-04 12:07:40,187 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,188 - DEBUG - root - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25" AND  QueueName="Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo""
2025-11-04 12:07:40,188 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 43f63fb8-2493-4aff-8588-1570e8d0f604, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:40,189 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 43f63fb8-2493-4aff-8588-1570e8d0f604, ghrun-txp46ju72i.auto.internal:24498): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,192 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 43f63fb8-2493-4aff-8588-1570e8d0f604, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MTEzM2NjZDgtYTQzNGQzNzYtYWU1ODVlMzYtYWQ2OTY1YjE=" } } } }
2025-11-04 12:07:40,201 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 84915f05-1fb0-4967-a3ef-520df2e7f2cc, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:40,202 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 84915f05-1fb0-4967-a3ef-520df2e7f2cc, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=MTEzM2NjZDgtYTQzNGQzNzYtYWU1ODVlMzYtYWQ2OTY1YjE=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25\" AND  QueueName=\"Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,228 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 84915f05-1fb0-4967-a3ef-520df2e7f2cc, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } rows { items { text_value: "U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25" } items { uint64_value: 1762258060024 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: true } items { text_value: "" } items { uint64_value: 0 } items { uint64_value: 8 } items { bytes_value: "f14d32bf-7392b3f-576fa113-5485075b" } items { text_value: "Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo" } items { uint64_value: 3 } items { uint64_value: 1 } items { uint32_value: 1 } items { text_value: "{}" } items { uint64_value: 1 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-04 12:07:40,229 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600 from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: QueueUrl=http%3A%2F%2Fghrun-txp46ju72i.auto.internal%3A13600%2FU_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25%2FQ_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo&Action=DeleteQueue
2025-11-04 12:07:40,263 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST / HTTP/1.1" 200 178
2025-11-04 12:07:40,270 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,271 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<DeleteQueueResponse><ResponseMetadata><RequestId>8b16dea9-36faedc3-82a9d2a5-ddcb0682</RequestId></ResponseMetadata></DeleteQueueResponse>

2025-11-04 12:07:40,271 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,274 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600/private from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: QueueName=Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo&CreatedTimestamp=1762258060&CustomQueueName=&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-04 12:07:40,316 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST /private HTTP/1.1" 200 414
2025-11-04 12:07:40,328 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,328 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-txp46ju72i.auto.internal:13600/U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25/Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>82a2c4dd-80d874d1-92d3e1df-450322f3</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-04 12:07:40,329 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:40,330 - DEBUG - root - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25" AND  QueueName="Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo""
2025-11-04 12:07:40,330 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, fe5abff0-4907-4ffe-8fde-dd8613af15cc, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:40,330 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, fe5abff0-4907-4ffe-8fde-dd8613af15cc, ghrun-txp46ju72i.auto.internal:24498): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,333 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, fe5abff0-4907-4ffe-8fde-dd8613af15cc, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NWNjZDNmM2YtN2M5Yzc5Y2ItOWFkYjM0M2YtN2U2ZTA3Zjg=" } } } }
2025-11-04 12:07:40,333 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 95b20ce9-7894-4b76-b120-937bf523ed0c, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:40,334 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 95b20ce9-7894-4b76-b120-937bf523ed0c, ghrun-txp46ju72i.auto.internal:24498): request = { session_id: "ydb://session/3?node_id=1&id=NWNjZDNmM2YtN2M5Yzc5Y2ItOWFkYjM0M2YtN2U2ZTA3Zjg=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25\" AND  QueueName=\"Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-04 12:07:40,359 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 95b20ce9-7894-4b76-b120-937bf523ed0c, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } rows { items { text_value: "U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25" } items { uint64_value: 1762258060000 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: true } items { text_value: "" } items { uint64_value: 0 } items { uint64_value: 8 } items { bytes_value: "a0be89f4-4baa9028-c682499b-3c977707" } items { text_value: "Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo" } items { uint64_value: 3 } items { uint64_value: 1 } items { uint32_value: 1 } items { text_value: "{}" } items { uint64_value: 2 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-04 12:07:55,364 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:13600 from user U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25 with params: QueueUrl=http%3A%2F%2Fghrun-txp46ju72i.auto.internal%3A13600%2FU_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25%2FQ_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo&AttributeName.1=All&Action=GetQueueAttributes
2025-11-04 12:07:55,381 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:13600 "POST / HTTP/1.1" 200 1304
2025-11-04 12:07:55,423 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:55,424 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<GetQueueAttributesResponse><GetQueueAttributesResult><Attribute><Name>ApproximateNumberOfMessages</Name><Value>0</Value></Attribute><Attribute><Name>ApproximateNumberOfMessagesDelayed</Name><Value>0</Value></Attribute><Attribute><Name>ApproximateNumberOfMessagesNotVisible</Name><Value>0</Value></Attribute><Attribute><Name>ContentBasedDeduplication</Name><Value>false</Value></Attribute><Attribute><Name>CreatedTimestamp</Name><Value>1762258060</Value></Attribute><Attribute><Name>DelaySeconds</Name><Value>0</Value></Attribute><Attribute><Name>FifoQueue</Name><Value>true</Value></Attribute><Attribute><Name>MaximumMessageSize</Name><Value>262144</Value></Attribute><Attribute><Name>MessageRetentionPeriod</Name><Value>345600</Value></Attribute><Attribute><Name>ReceiveMessageWaitTimeSeconds</Name><Value>0</Value></Attribute><Attribute><Name>VisibilityTimeout</Name><Value>30</Value></Attribute><Attribute><Name>QueueArn</Name><Value>yrn:ya:sqs:ru-central1:U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25:Q_private_queue_recreation_dc023617-b976-11f0-bb79-d00dc3df7f25.fifo</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>213ceb34-b6438dd9-4ce2a0e0-4a5c725d</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-04 12:07:55,429 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-04 12:07:55,444 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-04 12:07:55,449 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 3681b400-f8f3-49d5-a7f2-deeec40f2e47, ghrun-txp46ju72i.auto.internal:24498): creating call state
2025-11-04 12:07:55,450 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 3681b400-f8f3-49d5-a7f2-deeec40f2e47, ghrun-txp46ju72i.auto.internal:24498): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/PathSQS/U_private_queue_recreation_dc01869b-b976-11f0-ae51-d00dc3df7f25/Queues" }
2025-11-04 12:07:55,453 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 3681b400-f8f3-49d5-a7f2-deeec40f2e47, ghrun-txp46ju72i.auto.internal:24498): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-04 12:07:55,454 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-04 12:07:55,454 - DEBUG - ydb.topic - close: Close topic client
2025-11-04 12:07:55,454 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-04 12:07:55,454 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:24498
2025-11-04 12:07:55,455 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-txp46ju72i.auto.internal:24498
2025-11-04 12:07:55,456 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-04 12:07:55,456 - DEBUG - root - teardown_method: Test finished: test_private_queue_recreation
