2025-11-26 21:26:55,558 - INFO - ya.test.587900  - pytest_runtest_setup: ####################################################################################################
2025-11-26 21:26:55,558 - INFO - ya.test.587900  - pytest_runtest_setup: test_private_create_queue[tables_format_v0-fifo]
2025-11-26 21:26:55,558 - INFO - ya.test.587900  - pytest_runtest_setup: ####################################################################################################
2025-11-26 21:26:55,559 - INFO - ya.test.587900  - pytest_runtest_setup: Test setup
2025-11-26 21:26:55,670 - DEBUG - ya.test.587900  - get_binary: Binary was found by /home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd
2025-11-26 21:26:55,672 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19525
2025-11-26 21:26:55,672 - DEBUG - library.python.filelock.587900  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19525
2025-11-26 21:26:55,673 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19526
2025-11-26 21:26:55,681 - DEBUG - ydb.tests.library.harness.kikimr_runner.587900  - start: Working directory: /home/runner/.ya/build/build_root/4rkp/005fbe/r3tmp/kikimr_cluster_wj6pmuuk
2025-11-26 21:26:55,736 - DEBUG - ya.test.587900  - get_binary: Binary was found by /home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd
2025-11-26 21:26:55,737 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/31131
2025-11-26 21:26:55,738 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18983
2025-11-26 21:26:55,738 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30288
2025-11-26 21:26:55,739 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/64943
2025-11-26 21:26:55,739 - DEBUG - library.python.filelock.587900  - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13221
2025-11-26 21:26:55,740 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/kikimr_configs"
2025-11-26 21:26:55,740 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: Final command: /home/runner/.ya/build/build_root/4rkp/005fbe/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/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/node_1/logfile_t3bghmr6.log --grpc-port=31131 --mon-port=18983 --ic-port=19526 --sqs-port=13221
2025-11-26 21:26:55,741 - DEBUG - ydb.tests.library.harness.kikimr_runner.587900  - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:31131/1, disk_size 68719476736
2025-11-26 21:26:55,741 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/kikimr_configs"
2025-11-26 21:26:55,742 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: Final command: /home/runner/.ya/build/build_root/4rkp/005fbe/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/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/node_1/logfile_t3bghmr6.log --grpc-port=31131 --mon-port=18983 --ic-port=19526 --sqs-port=13221
2025-11-26 21:26:55,743 - DEBUG - ya.test.587900  - execute: Executing '('/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/node_1/logfile_t3bghmr6.log', '--grpc-port=31131', '--mon-port=18983', '--ic-port=19526', '--sqs-port=13221')' in '/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/node_1' (no wait)
2025-11-26 21:26:55,746 - DEBUG - ya.test.587900  - execute: Command pid: 589005
2025-11-26 21:26:55,747 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - start: Started node localhost:31131/1
2025-11-26 21:26:55,748 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-26 21:26:55,749 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-26 21:26:55,749 - DEBUG - ya.test.587900  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 21:26:55,751 - DEBUG - ya.test.587900  - execute: Command pid: 589006
2025-11-26 21:26:56,445 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) rc: 0
2025-11-26 21:26:56,445 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) elapsed time (sec): 0.6931447982788086
2025-11-26 21:26:56,445 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) idrss: 0
2025-11-26 21:26:56,446 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) inblock: 0
2025-11-26 21:26:56,446 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) isrss: 0
2025-11-26 21:26:56,446 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) ixrss: 0
2025-11-26 21:26:56,446 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) majflt: 0
2025-11-26 21:26:56,447 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) maxrss: 522016
2025-11-26 21:26:56,447 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) minflt: 45673
2025-11-26 21:26:56,447 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) msgrcv: 0
2025-11-26 21:26:56,447 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) msgsnd: 0
2025-11-26 21:26:56,448 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) nivcsw: 9
2025-11-26 21:26:56,448 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) nsignals: 0
2025-11-26 21:26:56,448 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) nswap: 0
2025-11-26 21:26:56,448 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) nvcsw: 15
2025-11-26 21:26:56,449 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) oublock: 8
2025-11-26 21:26:56,449 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) stime: 0.215033
2025-11-26 21:26:56,449 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) utime: 0.433149
2025-11-26 21:26:56,449 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) wtime: 0.695
2025-11-26 21:26:56,449 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) output:
Git info:
    Commit: 3a6281fc005e388432251060760d06ea70ac2e39
    Branch: 
    Author: Dmitry Kardymon <kardymon.d@gmail.com>
    Summary: Merge 16b5589081a24ad71272f6e0a48c73699fb876ec into fe49740846bccb57d40855c09ec9f41405fc180e
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-bs3qzf6rey    Host information: 
        Linux ghrun-bs3qzf6rey 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-26 21:26:56,450 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 589006) errors:

2025-11-26 21:26:56,450 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - start: Node 1 version:
Git info:
    Commit: 3a6281fc005e388432251060760d06ea70ac2e39
    Branch: 
    Author: Dmitry Kardymon <kardymon.d@gmail.com>
    Summary: Merge 16b5589081a24ad71272f6e0a48c73699fb876ec into fe49740846bccb57d40855c09ec9f41405fc180e
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-bs3qzf6rey    Host information: 
        Linux ghrun-bs3qzf6rey 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-26 21:26:59,012 - DEBUG - ya.test.587900  - get_binary: Binary was found by /home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd
2025-11-26 21:26:59,012 - DEBUG - ydb.tests.library.harness.kikimr_runner.587900  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:31131', '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: 19526\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-26 21:26:59,014 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-26 21:26:59,014 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-26 21:26:59,015 - DEBUG - ya.test.587900  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:31131', '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: 19526\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-26 21:26:59,016 - DEBUG - ya.test.587900  - execute: Command pid: 590179
2025-11-26 21:26:59,933 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) rc: 0
2025-11-26 21:26:59,933 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) elapsed time (sec): 0.9160726070404053
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) idrss: 0
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) inblock: 0
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) isrss: 0
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) ixrss: 0
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) majflt: 0
2025-11-26 21:26:59,934 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) maxrss: 573140
2025-11-26 21:26:59,935 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) minflt: 52071
2025-11-26 21:26:59,935 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) msgrcv: 0
2025-11-26 21:26:59,935 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) msgsnd: 0
2025-11-26 21:26:59,935 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) nivcsw: 60
2025-11-26 21:26:59,935 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) nsignals: 0
2025-11-26 21:26:59,936 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) nswap: 0
2025-11-26 21:26:59,936 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) nvcsw: 529
2025-11-26 21:26:59,936 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) oublock: 8
2025-11-26 21:26:59,936 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) stime: 0.320984
2025-11-26 21:26:59,936 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) utime: 0.527006
2025-11-26 21:26:59,937 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) wtime: 0.918
2025-11-26 21:26:59,937 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-26 21:26:59,937 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590179) errors:

2025-11-26 21:26:59,943 - DEBUG - ya.test.587900  - get_binary: Binary was found by /home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd
2025-11-26 21:26:59,943 - DEBUG - ydb.tests.library.harness.kikimr_runner.587900  - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:31131', '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-26 21:26:59,945 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-26 21:26:59,946 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-26 21:26:59,947 - DEBUG - ya.test.587900  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:31131', '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-26 21:26:59,949 - DEBUG - ya.test.587900  - execute: Command pid: 590436
2025-11-26 21:27:00,872 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) rc: 0
2025-11-26 21:27:00,873 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) elapsed time (sec): 0.9226000308990479
2025-11-26 21:27:00,873 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) idrss: 0
2025-11-26 21:27:00,873 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) inblock: 0
2025-11-26 21:27:00,873 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) isrss: 0
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) ixrss: 0
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) majflt: 0
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) maxrss: 573140
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) minflt: 52131
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) msgrcv: 0
2025-11-26 21:27:00,874 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) msgsnd: 0
2025-11-26 21:27:00,875 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) nivcsw: 252
2025-11-26 21:27:00,875 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) nsignals: 0
2025-11-26 21:27:00,875 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) nswap: 0
2025-11-26 21:27:00,875 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) nvcsw: 574
2025-11-26 21:27:00,875 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) oublock: 8
2025-11-26 21:27:00,876 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) stime: 0.286954
2025-11-26 21:27:00,876 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) utime: 0.5615399999999999
2025-11-26 21:27:00,876 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) wtime: 0.924
2025-11-26 21:27:00,876 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-26 21:27:00,877 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 590436) errors:

2025-11-26 21:27:00,877 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-26 21:27:00,981 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __run: Cluster started and initialized
2025-11-26 21:27:01,017 - DEBUG - ydb.connection.587900  - 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-26 21:27:01,021 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 21:27:01,024 - DEBUG - ydb.connection.587900  - 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-26 21:27:01,042 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - context_resolve: Resolving endpoints for database /Root
2025-11-26 21:27:01,044 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ListEndpoints, 07da5997-dc0d-489c-829a-2318b5fadaa9, localhost:31131): creating call state
2025-11-26 21:27:01,045 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ListEndpoints, 07da5997-dc0d-489c-829a-2318b5fadaa9, localhost:31131): request = { database: "/Root" }
2025-11-26 21:27:01,056 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ListEndpoints, 07da5997-dc0d-489c-829a-2318b5fadaa9, localhost:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-bs3qzf6rey.auto.internal" port: 31131 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-26 21:27:01,057 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-bs3qzf6rey.auto.internal:31131, location 1, ssl: False>]>
2025-11-26 21:27:01,058 - DEBUG - ydb.connection.587900  - 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-26 21:27:01,076 - DEBUG - ydb.connection.587900  - close: Closing channel for endpoint localhost:31131
2025-11-26 21:27:01,079 - DEBUG - ydb.table.SessionPool.587900  - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-26 21:27:01,079 - DEBUG - ydb.table.SessionPool.587900  - subscribe: Subscribe waiter <Future at 0x7bf0ab251af0 state=pending>
2025-11-26 21:27:01,080 - DEBUG - ydb.table.SessionPool.587900  - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-11-26 21:27:01,081 - DEBUG - ydb.table.SessionPool.587900  - _create: Created session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:01,081 - DEBUG - ydb.table.SessionPool.587900  - _prepare: Preparing session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:01,084 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateSession, 783266e3-d5f2-4a35-b1d7-8edd3f19d017, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,085 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateSession, 783266e3-d5f2-4a35-b1d7-8edd3f19d017, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-26 21:27:01,099 - DEBUG - ydb.connection.587900  - _on_response_callback: RpcState(CreateSession, 783266e3-d5f2-4a35-b1d7-8edd3f19d017, ghrun-bs3qzf6rey.auto.internal:31131): on response callback started
2025-11-26 21:27:01,100 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateSession, 783266e3-d5f2-4a35-b1d7-8edd3f19d017, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" } } } }
2025-11-26 21:27:01,101 - DEBUG - ydb.table.SessionPool.587900  - put: Put on session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:01,101 - DEBUG - ydb.table.SessionPool.587900  - put: Replying to waiter with a session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:01,102 - DEBUG - ydb.connection.587900  - _on_response_callback: RpcState(CreateSession, 783266e3-d5f2-4a35-b1d7-8edd3f19d017, ghrun-bs3qzf6rey.auto.internal:31131): on response callback success
2025-11-26 21:27:01,108 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 0eb6ca0f-411c-463a-b4be-d5373a679746, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,111 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 0eb6ca0f-411c-463a-b4be-d5373a679746, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,357 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 0eb6ca0f-411c-463a-b4be-d5373a679746, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:01,373 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ExecuteDataQuery, 867f4e69-3736-467e-b561-8a7ed90a8d90, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,374 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ExecuteDataQuery, 867f4e69-3736-467e-b561-8a7ed90a8d90, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,510 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ExecuteDataQuery, 867f4e69-3736-467e-b561-8a7ed90a8d90, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 21:27:01,512 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 7ebcf92c-f07d-4746-92f4-b75bd3ccdffa, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,515 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 7ebcf92c-f07d-4746-92f4-b75bd3ccdffa, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,599 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 7ebcf92c-f07d-4746-92f4-b75bd3ccdffa, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:01,601 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 5165a238-fe5b-4080-b4b6-7520c595f76b, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,604 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 5165a238-fe5b-4080-b4b6-7520c595f76b, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,678 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 5165a238-fe5b-4080-b4b6-7520c595f76b, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:01,680 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 731346c0-2dfc-4b8b-9414-0c9d07e34de9, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,681 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 731346c0-2dfc-4b8b-9414-0c9d07e34de9, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,765 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 731346c0-2dfc-4b8b-9414-0c9d07e34de9, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:01,767 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 8d053e88-417d-4689-b732-00c68ae5bf7c, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,769 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 8d053e88-417d-4689-b732-00c68ae5bf7c, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:01,857 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 8d053e88-417d-4689-b732-00c68ae5bf7c, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:01,859 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 22589f7c-be9e-4e45-a72c-2bd17d597d91, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:01,861 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 22589f7c-be9e-4e45-a72c-2bd17d597d91, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,020 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 22589f7c-be9e-4e45-a72c-2bd17d597d91, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,022 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 8b55e8b4-a0dd-4055-b1bb-48a700ca0050, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,025 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 8b55e8b4-a0dd-4055-b1bb-48a700ca0050, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,146 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 8b55e8b4-a0dd-4055-b1bb-48a700ca0050, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,148 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, dd1ed62d-ad3a-4859-91e4-8b83c4c3f567, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,150 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, dd1ed62d-ad3a-4859-91e4-8b83c4c3f567, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,309 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, dd1ed62d-ad3a-4859-91e4-8b83c4c3f567, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,311 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, b5a3d15f-7e22-4813-8e78-6a02814896b4, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,314 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, b5a3d15f-7e22-4813-8e78-6a02814896b4, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,467 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, b5a3d15f-7e22-4813-8e78-6a02814896b4, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,469 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, a3b60798-4979-47e9-86f1-035ae3bd0dd3, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,471 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, a3b60798-4979-47e9-86f1-035ae3bd0dd3, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,593 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, a3b60798-4979-47e9-86f1-035ae3bd0dd3, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,595 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 3e643e1a-24b3-4e53-8055-3e2b433d9104, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,600 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 3e643e1a-24b3-4e53-8055-3e2b433d9104, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,746 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 3e643e1a-24b3-4e53-8055-3e2b433d9104, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,748 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, e74810a5-7e02-46c6-b394-6241fd438dd1, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,750 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, e74810a5-7e02-46c6-b394-6241fd438dd1, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:02,919 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, e74810a5-7e02-46c6-b394-6241fd438dd1, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:02,921 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, b67b4791-9301-4cc0-94b4-d7fd6b31ea7d, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:02,924 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, b67b4791-9301-4cc0-94b4-d7fd6b31ea7d, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,085 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, b67b4791-9301-4cc0-94b4-d7fd6b31ea7d, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,087 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 86371512-d766-4fc0-a341-04611be2c27c, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,089 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 86371512-d766-4fc0-a341-04611be2c27c, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,245 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 86371512-d766-4fc0-a341-04611be2c27c, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,247 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 4bacd2cc-6ab6-4082-9e36-b59b6737c0b8, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,249 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 4bacd2cc-6ab6-4082-9e36-b59b6737c0b8, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,403 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 4bacd2cc-6ab6-4082-9e36-b59b6737c0b8, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,405 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 4c033791-68db-4382-92de-f308b5f9196a, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,407 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 4c033791-68db-4382-92de-f308b5f9196a, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,566 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 4c033791-68db-4382-92de-f308b5f9196a, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,568 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, a0d7c788-099e-4eee-a6f4-e697b300aa42, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,570 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, a0d7c788-099e-4eee-a6f4-e697b300aa42, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,727 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, a0d7c788-099e-4eee-a6f4-e697b300aa42, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,729 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, 07f32471-8a89-4aaf-b04a-a1561f17c529, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,730 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, 07f32471-8a89-4aaf-b04a-a1561f17c529, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:03,864 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, 07f32471-8a89-4aaf-b04a-a1561f17c529, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:03,866 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateTable, d52a09aa-2027-4820-870b-5443b088cb52, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:03,869 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateTable, d52a09aa-2027-4820-870b-5443b088cb52, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" 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-26 21:27:04,005 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateTable, d52a09aa-2027-4820-870b-5443b088cb52, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:04,006 - DEBUG - ydb.table.SessionPool.587900  - put: Put on session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:04,006 - DEBUG - ydb.table.SessionPool.587900  - stop: Requested session pool stop.
2025-11-26 21:27:04,007 - DEBUG - ydb.table.SessionPool.587900  - stop: Session pool is under stop, cancelling all in flight waiters.
2025-11-26 21:27:04,007 - DEBUG - ydb.table.SessionPool.587900  - stop: Destroying sessions in active queue
2025-11-26 21:27:04,007 - DEBUG - ydb.table.SessionPool.587900  - _destroy: Requested session destroy: <ydb.table.Session object at 0x7bf0ab255430>, reason: session-pool-terminated
2025-11-26 21:27:04,007 - DEBUG - ydb.table.SessionPool.587900  - _destroy: Session <ydb.table.Session object at 0x7bf0ab255430> is no longer active. Current active count 0.
2025-11-26 21:27:04,008 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(DeleteSession, 6d8bf64a-3a2f-4dba-b1a1-d52935874f26, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:04,008 - DEBUG - ydb.connection.587900  - _log_request: RpcState(DeleteSession, 6d8bf64a-3a2f-4dba-b1a1-d52935874f26, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=Yzg1OTkzMmEtNDc5YjE4YzUtZjk3YWYwMGYtOGY1Nzc5NjA=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-26 21:27:04,010 - DEBUG - ydb.table.SessionPool.587900  - _terminate_event: Terminated session pool.
2025-11-26 21:27:04,015 - DEBUG - ydb.table.SessionPool.587900  - _destroy: Sent delete on session <ydb.table.Session object at 0x7bf0ab255430>
2025-11-26 21:27:04,016 - DEBUG - ydb.table.SessionPool.587900  - stop: Destroyed active sessions
2025-11-26 21:27:04,016 - DEBUG - ydb.topic.587900  - close: Close topic client
2025-11-26 21:27:04,016 - DEBUG - ydb.topic.587900  - close: Topic client was closed
2025-11-26 21:27:04,015 - DEBUG - ydb.connection.587900  - _on_response_callback: RpcState(DeleteSession, 6d8bf64a-3a2f-4dba-b1a1-d52935874f26, ghrun-bs3qzf6rey.auto.internal:31131): on response callback started
2025-11-26 21:27:04,017 - DEBUG - ydb.connection.587900  - close: Closing channel for endpoint localhost:31131
2025-11-26 21:27:04,017 - DEBUG - ydb.connection.587900  - close: Closing channel for endpoint ghrun-bs3qzf6rey.auto.internal:31131
2025-11-26 21:27:04,018 - DEBUG - ydb.connection.587900  - _log_response: RpcState(DeleteSession, 6d8bf64a-3a2f-4dba-b1a1-d52935874f26, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS } }
2025-11-26 21:27:04,020 - DEBUG - ydb.connection.587900  - _on_response_callback: RpcState(DeleteSession, 6d8bf64a-3a2f-4dba-b1a1-d52935874f26, ghrun-bs3qzf6rey.auto.internal:31131): on response callback success
2025-11-26 21:27:04,020 - INFO - ydb.pool.Discovery.587900  - run: Successfully terminated discovery process
2025-11-26 21:27:04,031 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to curl.out
2025-11-26 21:27:04,033 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to curl.err
2025-11-26 21:27:04,033 - DEBUG - ya.test.587900  - execute: Executing '['curl', '-v', 'localhost:13221?Action=CreateUser&UserName=metauser', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-26 21:27:04,039 - DEBUG - ya.test.587900  - execute: Command pid: 592008
2025-11-26 21:27:04,086 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) rc: 0
2025-11-26 21:27:04,087 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) elapsed time (sec): 0.04616189002990723
2025-11-26 21:27:04,088 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) idrss: 0
2025-11-26 21:27:04,088 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) inblock: 0
2025-11-26 21:27:04,088 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) isrss: 0
2025-11-26 21:27:04,088 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) ixrss: 0
2025-11-26 21:27:04,089 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) majflt: 0
2025-11-26 21:27:04,089 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) maxrss: 584528
2025-11-26 21:27:04,089 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) minflt: 590
2025-11-26 21:27:04,090 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) msgrcv: 0
2025-11-26 21:27:04,090 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) msgsnd: 0
2025-11-26 21:27:04,090 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) nivcsw: 2
2025-11-26 21:27:04,091 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) nsignals: 0
2025-11-26 21:27:04,091 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) nswap: 0
2025-11-26 21:27:04,091 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) nvcsw: 2
2025-11-26 21:27:04,092 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) oublock: 16
2025-11-26 21:27:04,092 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) stime: 0.005562999999999999
2025-11-26 21:27:04,092 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) utime: 0.005562999999999999
2025-11-26 21:27:04,093 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) wtime: 0.053
2025-11-26 21:27:04,093 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) output:
<?xml version="1.0" encoding="UTF-8"?>
<CreateUserResponse><ResponseMetadata><RequestId>8a40b7c4-674a0fd9-650de91f-cb8e53cf</RequestId></ResponseMetadata></CreateUserResponse>

2025-11-26 21:27:04,093 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592008) errors:
*   Trying 127.0.0.1:13221...
  % 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 13221 (#0)
> GET /?Action=CreateUser&UserName=metauser HTTP/1.1
> Host: localhost:13221
> 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   4486      0 --:--:-- --:--:-- --:--:--  4631
* Connection #0 to host localhost left intact

2025-11-26 21:27:04,094 - DEBUG - ya.test.587900  - verify_sanitize_errors: 'curl' doesn't belong to '/home/runner/.ya/build/build_root/4rkp/005fbe' - no check for sanitize errors
2025-11-26 21:27:04,096 - DEBUG - root.587900  - setup_method: Test started: test_private_create_queue
2025-11-26 21:27:04,096 - DEBUG - root.587900  - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo
2025-11-26 21:27:04,097 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/kikimr_configs"
2025-11-26 21:27:04,097 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - __make_run_command: Final command: /home/runner/.ya/build/build_root/4rkp/005fbe/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/4rkp/005fbe/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk4/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_create_queue.tables_format_v0-fifo/cluster/node_1/logfile_t3bghmr6.log --grpc-port=31131 --mon-port=18983 --ic-port=19526 --sqs-port=13221
2025-11-26 21:27:04,098 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - start: Started node localhost:31131/1
2025-11-26 21:27:04,099 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-26 21:27:04,100 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-26 21:27:04,101 - DEBUG - ya.test.587900  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fbe/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 21:27:04,103 - DEBUG - ya.test.587900  - execute: Command pid: 592036
2025-11-26 21:27:04,849 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) rc: 0
2025-11-26 21:27:04,849 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) elapsed time (sec): 0.745136022567749
2025-11-26 21:27:04,850 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) idrss: 0
2025-11-26 21:27:04,850 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) inblock: 0
2025-11-26 21:27:04,850 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) isrss: 0
2025-11-26 21:27:04,851 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) ixrss: 0
2025-11-26 21:27:04,851 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) majflt: 0
2025-11-26 21:27:04,851 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) maxrss: 584528
2025-11-26 21:27:04,851 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) minflt: 45595
2025-11-26 21:27:04,852 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) msgrcv: 0
2025-11-26 21:27:04,852 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) msgsnd: 0
2025-11-26 21:27:04,852 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) nivcsw: 44
2025-11-26 21:27:04,852 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) nsignals: 0
2025-11-26 21:27:04,853 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) nswap: 0
2025-11-26 21:27:04,853 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) nvcsw: 14
2025-11-26 21:27:04,853 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) oublock: 8
2025-11-26 21:27:04,853 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) stime: 0.214336
2025-11-26 21:27:04,854 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) utime: 0.47360599999999997
2025-11-26 21:27:04,854 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) wtime: 0.747
2025-11-26 21:27:04,854 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) output:
Git info:
    Commit: 3a6281fc005e388432251060760d06ea70ac2e39
    Branch: 
    Author: Dmitry Kardymon <kardymon.d@gmail.com>
    Summary: Merge 16b5589081a24ad71272f6e0a48c73699fb876ec into fe49740846bccb57d40855c09ec9f41405fc180e
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-bs3qzf6rey    Host information: 
        Linux ghrun-bs3qzf6rey 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/10302026024/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/10302026024/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-26 21:27:04,855 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592036) errors:

2025-11-26 21:27:04,855 - INFO - ydb.tests.library.harness.kikimr_runner.587900  - start: Node 1 version:
Git info:
    Commit: 3a6281fc005e388432251060760d06ea70ac2e39
    Branch: 
    Author: Dmitry Kardymon <kardymon.d@gmail.com>
    Summary: Merge 16b5589081a24ad71272f6e0a48c73699fb876ec into fe49740846bccb57d40855c09ec9f41405fc180e
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-bs3qzf6rey    Host information: 
        Linux ghrun-bs3qzf6rey 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-26 21:27:04,861 - DEBUG - root.587900  - _setup_user: Running curl -v localhost:13221?Action=CreateUser&UserName=U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 -H authorization: aaa credential=abacaba/20220830/ec2/aws4_request
2025-11-26 21:27:04,862 - DEBUG - ya.test.587900  - _get_command_output_file: Command out will be placed to curl.out.0
2025-11-26 21:27:04,863 - DEBUG - ya.test.587900  - _get_command_output_file: Command err will be placed to curl.err.0
2025-11-26 21:27:04,863 - DEBUG - ya.test.587900  - execute: Executing '['curl', '-v', 'localhost:13221?Action=CreateUser&UserName=U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-26 21:27:04,865 - DEBUG - ya.test.587900  - execute: Command pid: 592451
2025-11-26 21:27:04,895 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) rc: 0
2025-11-26 21:27:04,896 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) elapsed time (sec): 0.029177427291870117
2025-11-26 21:27:04,896 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) idrss: 0
2025-11-26 21:27:04,896 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) inblock: 0
2025-11-26 21:27:04,897 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) isrss: 0
2025-11-26 21:27:04,897 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) ixrss: 0
2025-11-26 21:27:04,897 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) majflt: 0
2025-11-26 21:27:04,897 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) maxrss: 584528
2025-11-26 21:27:04,897 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) minflt: 593
2025-11-26 21:27:04,898 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) msgrcv: 0
2025-11-26 21:27:04,898 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) msgsnd: 0
2025-11-26 21:27:04,898 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) nivcsw: 0
2025-11-26 21:27:04,898 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) nsignals: 0
2025-11-26 21:27:04,898 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) nswap: 0
2025-11-26 21:27:04,899 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) nvcsw: 2
2025-11-26 21:27:04,899 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) oublock: 16
2025-11-26 21:27:04,899 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) stime: 0.0063019999999999994
2025-11-26 21:27:04,899 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) utime: 0.0031509999999999997
2025-11-26 21:27:04,900 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) wtime: 0.032
2025-11-26 21:27:04,900 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) output:
<?xml version="1.0" encoding="UTF-8"?>
<CreateUserResponse><ResponseMetadata><RequestId>e0c3ecbe-6bbfdba6-7184d31d-d5387d0c</RequestId></ResponseMetadata></CreateUserResponse>

2025-11-26 21:27:04,900 - DEBUG - ya.test.587900  - _save_outputs: Command (pid 592451) errors:
*   Trying 127.0.0.1:13221...
  % 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 13221 (#0)
> GET /?Action=CreateUser&UserName=U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 HTTP/1.1
> Host: localhost:13221
> 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   8173      0 --:--:-- --:--:-- --:--:--  8000
100   176  100   176    0     0   8120      0 --:--:-- --:--:-- --:--:--  8000
* Connection #0 to host localhost left intact

2025-11-26 21:27:04,900 - DEBUG - ya.test.587900  - verify_sanitize_errors: 'curl' doesn't belong to '/home/runner/.ya/build/build_root/4rkp/005fbe' - no check for sanitize errors
2025-11-26 21:27:04,902 - INFO - ydb.tests.library.sqs.test_base.587900  - wait_can_list_users: Listing SQS users
2025-11-26 21:27:04,902 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: Action=ListQueues
2025-11-26 21:27:04,905 - DEBUG - urllib3.connectionpool.587900  - _new_conn: Starting new HTTP connection (1): localhost:13221
2025-11-26 21:27:04,926 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 200 195
2025-11-26 21:27:04,956 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:04,957 - DEBUG - root.587900  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<ListQueuesResponse><ListQueuesResult/><ResponseMetadata><RequestId>29a4a094-75c5e75b-55e9b909-1598480f</RequestId></ResponseMetadata></ListQueuesResponse>

2025-11-26 21:27:04,958 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:04,962 - ERROR - ydb.tests.library.sqs.requests_client.587900  - _process_response: Could not process response from SQS: {'ListQueuesResponse': {'ListQueuesResult': None, 'ResponseMetadata': {'RequestId': '29a4a094-75c5e75b-55e9b909-1598480f'}}}. <class 'TypeError'>: 'NoneType' object is not subscriptable
2025-11-26 21:27:04,962 - INFO - ydb.tests.library.sqs.test_base.587900  - wait_can_list_users: Success. Api is up.
2025-11-26 21:27:04,963 - DEBUG - ydb.connection.587900  - 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-26 21:27:04,966 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 21:27:04,966 - DEBUG - ydb.connection.587900  - 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-26 21:27:04,974 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - context_resolve: Resolving endpoints for database /Root
2025-11-26 21:27:04,975 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ListEndpoints, 7f0724c7-7aed-434e-9012-d6dff80f2e25, localhost:31131): creating call state
2025-11-26 21:27:04,976 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ListEndpoints, 7f0724c7-7aed-434e-9012-d6dff80f2e25, localhost:31131): request = { database: "/Root" }
2025-11-26 21:27:04,980 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ListEndpoints, 7f0724c7-7aed-434e-9012-d6dff80f2e25, localhost:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-bs3qzf6rey.auto.internal" port: 31131 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-26 21:27:04,981 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.587900  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-bs3qzf6rey.auto.internal:31131, location 1, ssl: False>]>
2025-11-26 21:27:04,981 - DEBUG - ydb.connection.587900  - 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-26 21:27:04,994 - INFO - ya.test.587900  - pytest_runtest_call: Test call (class_name: test_common.py::TestCommonYandexWithPath, test_name: test_private_create_queue[tables_format_v0-fifo])
2025-11-26 21:27:04,995 - DEBUG - root.587900  - _execute_yql_query: Executing database query: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES ("U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4", "CreateQueuesWithTabletFormat", "0")"
2025-11-26 21:27:04,995 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateSession, eb60235b-a0b9-44b4-949a-e41fecb5f129, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:04,996 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateSession, eb60235b-a0b9-44b4-949a-e41fecb5f129, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:05,001 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateSession, eb60235b-a0b9-44b4-949a-e41fecb5f129, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=NTBlYTdlZWYtNjNmOWY0ZjItNDQ3YjBmZTctNmJkNDRiZTQ=" } } } }
2025-11-26 21:27:05,003 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ExecuteDataQuery, 1d73a09a-f4e0-45f5-9cda-3b207f95216c, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:05,003 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ExecuteDataQuery, 1d73a09a-f4e0-45f5-9cda-3b207f95216c, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=NTBlYTdlZWYtNjNmOWY0ZjItNDQ3YjBmZTctNmJkNDRiZTQ=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES (\"U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4\", \"CreateQueuesWithTabletFormat\", \"0\")" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:05,102 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ExecuteDataQuery, 1d73a09a-f4e0-45f5-9cda-3b207f95216c, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 21:27:05,104 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:05,513 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 200 413
2025-11-26 21:27:05,533 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,533 - DEBUG - root.587900  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-bs3qzf6rey.auto.internal:13221/U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4/queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>5122da9-73692fad-1fb6f9e0-4c80ffd6</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 21:27:05,534 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,536 - DEBUG - root.587900  - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" AND  QueueName="queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo""
2025-11-26 21:27:05,536 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateSession, ba138ad9-42c0-411e-a9e5-05a8683942f0, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:05,537 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateSession, ba138ad9-42c0-411e-a9e5-05a8683942f0, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:05,543 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateSession, ba138ad9-42c0-411e-a9e5-05a8683942f0, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=MjVmNjVhMGYtMmE0ZmI4YTItYTg4YjI3M2ItZTA2NDgzOQ==" } } } }
2025-11-26 21:27:05,545 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ExecuteDataQuery, 63dfe768-15f2-48d0-9296-47f9f452125f, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:05,546 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ExecuteDataQuery, 63dfe768-15f2-48d0-9296-47f9f452125f, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=MjVmNjVhMGYtMmE0ZmI4YTItYTg4YjI3M2ItZTA2NDgzOQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4\" AND  QueueName=\"queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:05,682 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ExecuteDataQuery, 63dfe768-15f2-48d0-9296-47f9f452125f, ghrun-bs3qzf6rey.auto.internal:31131): 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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" } items { uint64_value: 1764192425109 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: true } items { text_value: "" } items { uint64_value: 72075186224038037 } items { uint64_value: 8 } items { bytes_value: "a3ddde68-9c73d5c7-88034650-7fb52a6c" } items { text_value: "queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo" } items { uint64_value: 3 } items { uint64_value: 1 } items { uint32_value: 0 } items { text_value: "{}" } items { uint64_value: 1 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-26 21:27:05,685 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A13221%2FU_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4%2Fqueue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&AttributeName.1=All&Action=GetQueueAttributes
2025-11-26 21:27:05,779 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 200 1304
2025-11-26 21:27:05,820 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,821 - DEBUG - root.587900  - _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>1764192425</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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4:queue_0_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>11ca3c44-bc525d8f-7032e856-4535654c</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-26 21:27:05,822 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,825 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_1_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=123&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:05,831 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 276
2025-11-26 21:27:05,851 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,852 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>801a6eab-5fdd2eb-857308ee-605806bd</RequestId></ErrorResponse>
'
2025-11-26 21:27:05,853 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,854 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,855 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_2_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=custom_name_1.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:05,862 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 277
2025-11-26 21:27:05,882 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,883 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>f4eeabfc-f952c158-b09fc18c-23b5b477</RequestId></ErrorResponse>
'
2025-11-26 21:27:05,884 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,885 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,886 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_3_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:05,891 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 276
2025-11-26 21:27:05,911 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,912 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>825609e-95b687e6-b3c17ffa-a2552b19</RequestId></ErrorResponse>
'
2025-11-26 21:27:05,913 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,915 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,915 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_4_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=1234&CustomQueueName=custom_name_2&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:05,921 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 276
2025-11-26 21:27:05,940 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,941 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>b7bd19f5-7df31775-acf15e34-eabcb9b</RequestId></ErrorResponse>
'
2025-11-26 21:27:05,942 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,943 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:05,944 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:06,443 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 200 414
2025-11-26 21:27:06,463 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:06,463 - DEBUG - root.587900  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-bs3qzf6rey.auto.internal:13221/U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4/queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>51c81108-fd987db3-587fd03c-79c09354</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 21:27:06,465 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:06,466 - DEBUG - root.587900  - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" AND  QueueName="queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo""
2025-11-26 21:27:06,466 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateSession, b66ff0b8-4016-4849-b12c-c2c8d24841a7, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:06,467 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateSession, b66ff0b8-4016-4849-b12c-c2c8d24841a7, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:06,474 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateSession, b66ff0b8-4016-4849-b12c-c2c8d24841a7, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=YTIzOTkxN2QtNTMzY2E5NTAtOWQyMzVjMTUtNGI3YmQwNmY=" } } } }
2025-11-26 21:27:06,475 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ExecuteDataQuery, f9e84be9-0675-42c7-b161-b79dc906d4f9, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:06,476 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ExecuteDataQuery, f9e84be9-0675-42c7-b161-b79dc906d4f9, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=YTIzOTkxN2QtNTMzY2E5NTAtOWQyMzVjMTUtNGI3YmQwNmY=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4\" AND  QueueName=\"queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:06,613 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ExecuteDataQuery, f9e84be9-0675-42c7-b161-b79dc906d4f9, ghrun-bs3qzf6rey.auto.internal:31131): 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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" } items { uint64_value: 1764192425948 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: true } items { text_value: "" } items { uint64_value: 72075186224038062 } items { uint64_value: 8 } items { bytes_value: "7165f5f6-c0345aaa-49973bd3-accdd99a" } items { text_value: "queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo" } items { uint64_value: 3 } items { uint64_value: 1 } items { uint32_value: 0 } items { text_value: "{}" } items { uint64_value: 2 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-26 21:27:06,616 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A13221%2FU_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4%2Fqueue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&AttributeName.1=All&Action=GetQueueAttributes
2025-11-26 21:27:06,683 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 200 1304
2025-11-26 21:27:06,730 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:06,731 - DEBUG - root.587900  - _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>1764192425</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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4:queue_5_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>fec5987b-adff8441-20f8788a-3acd1b9b</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-26 21:27:06,732 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:06,735 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=12345&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,210 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 200 414
2025-11-26 21:27:07,233 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,233 - DEBUG - root.587900  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-bs3qzf6rey.auto.internal:13221/U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4/queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>c2621f28-6d548fbf-44daf0e6-acffc71b</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 21:27:07,235 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,236 - DEBUG - root.587900  - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" AND  QueueName="queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo""
2025-11-26 21:27:07,236 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(CreateSession, 12723ff1-412d-4a5d-bb47-d68b69e4fb9c, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:07,237 - DEBUG - ydb.connection.587900  - _log_request: RpcState(CreateSession, 12723ff1-412d-4a5d-bb47-d68b69e4fb9c, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:07,245 - DEBUG - ydb.connection.587900  - _log_response: RpcState(CreateSession, 12723ff1-412d-4a5d-bb47-d68b69e4fb9c, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZWQ1OTIxYjEtZThiZjQ2NjAtZjcyM2VhNjEtMzFkZmViM2I=" } } } }
2025-11-26 21:27:07,246 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(ExecuteDataQuery, 8c55860a-e7e2-44b6-a785-15bb8b37925c, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:07,247 - DEBUG - ydb.connection.587900  - _log_request: RpcState(ExecuteDataQuery, 8c55860a-e7e2-44b6-a785-15bb8b37925c, ghrun-bs3qzf6rey.auto.internal:31131): request = { session_id: "ydb://session/3?node_id=1&id=ZWQ1OTIxYjEtZThiZjQ2NjAtZjcyM2VhNjEtMzFkZmViM2I=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4\" AND  QueueName=\"queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:27:07,388 - DEBUG - ydb.connection.587900  - _log_response: RpcState(ExecuteDataQuery, 8c55860a-e7e2-44b6-a785-15bb8b37925c, ghrun-bs3qzf6rey.auto.internal:31131): 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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4" } items { uint64_value: 12345000 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: true } items { text_value: "" } items { uint64_value: 72075186224038087 } items { uint64_value: 8 } items { bytes_value: "3c2126e3-da0a1006-9aad426a-8ec6fad0" } items { text_value: "queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo" } items { uint64_value: 3 } items { uint64_value: 1 } items { uint32_value: 0 } items { text_value: "{}" } items { uint64_value: 3 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-26 21:27:07,390 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A13221%2FU_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4%2Fqueue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&AttributeName.1=All&Action=GetQueueAttributes
2025-11-26 21:27:07,455 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 200 1299
2025-11-26 21:27:07,502 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,503 - DEBUG - root.587900  - _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>12345</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_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4:queue_6_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>b3458c71-6d04367c-d71b4668-6b5057e4</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-26 21:27:07,504 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,506 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_7_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=custom_name_3.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,511 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 238
2025-11-26 21:27:07,526 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,527 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Custom queue name must be empty or unset.</Message><Code>InvalidParameterValue</Code></Error><RequestId>ddf48d1e-1af20238-4c02226a-2af62539</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,528 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,529 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,530 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_8_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=123456&CustomQueueName=custom_name_4.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,536 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 238
2025-11-26 21:27:07,550 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,551 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Custom queue name must be empty or unset.</Message><Code>InvalidParameterValue</Code></Error><RequestId>8bb106c6-72bede15-d9369541-ea566ae4</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,552 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,553 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,553 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_9_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=1764192487&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,562 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 223
2025-11-26 21:27:07,580 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,581 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Invalid created timestamp.</Message><Code>InvalidParameterValue</Code></Error><RequestId>66329b75-d0a587be-95ff221f-65a8a3e0</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,581 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,582 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,583 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_10_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=some+incorrect+name5.fifo&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,588 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 238
2025-11-26 21:27:07,600 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,600 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Custom queue name must be empty or unset.</Message><Code>InvalidParameterValue</Code></Error><RequestId>a771823a-7e96054b-5e2fcd88-f9850361</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,601 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,602 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,603 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_11_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=custom_name_6&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,607 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 277
2025-11-26 21:27:07,621 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,622 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>857e45d6-db76e38e-cdf3e84e-a4d18550</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,623 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,624 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,624 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221 from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_12_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=1234567&CustomQueueName=custom_name_7&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,628 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST / HTTP/1.1" 400 277
2025-11-26 21:27:07,641 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,642 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>The action or operation requested is invalid. Verify that the action is typed correctly.</Message><Code>InvalidAction</Code></Error><RequestId>d5c2dc46-7d5d99ae-1b117a50-6e4082b4</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,643 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,644 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,645 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_13_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CustomQueueName=custom_name_8&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,650 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 250
2025-11-26 21:27:07,664 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,665 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Name of FIFO queue should end with &quot;.fifo&quot;.</Message><Code>InvalidParameterValue</Code></Error><RequestId>c54ca90f-fe7b77d7-a66d4205-4e3a5750</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,666 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,667 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,667 - DEBUG - ydb.tests.library.sqs.requests_client.587900  - execute_request: Execute request POST http://localhost:13221/private from user U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4 with params: QueueName=queue_14_Q_private_create_queue_a77f6c63-cb0e-11f0-8f6a-d00d636e60d4.fifo&CreatedTimestamp=12345678&CustomQueueName=custom_name_9&Attribute.1.Name=FifoQueue&Attribute.1.Value=true&Action=CreateQueue
2025-11-26 21:27:07,671 - DEBUG - urllib3.connectionpool.587900  - _make_request: http://localhost:13221 "POST /private HTTP/1.1" 400 250
2025-11-26 21:27:07,696 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,696 - WARNING - ydb.tests.library.sqs.requests_client.587900  - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Name of FIFO queue should end with &quot;.fifo&quot;.</Message><Code>InvalidParameterValue</Code></Error><RequestId>77a061fa-14243edd-b8837bc5-86d23aa3</RequestId></ErrorResponse>
'
2025-11-26 21:27:07,697 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,698 - DEBUG - charset_normalizer.587900  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:27:07,700 - INFO - ya.test.587900  - pytest_runtest_teardown: Test teardown
2025-11-26 21:27:07,701 - DEBUG - ydb.connection.587900  - _prepare_call: RpcState(DescribePath, e97de124-1af0-4149-9760-0752a2a21ffc, ghrun-bs3qzf6rey.auto.internal:31131): creating call state
2025-11-26 21:27:07,702 - DEBUG - ydb.connection.587900  - _log_request: RpcState(DescribePath, e97de124-1af0-4149-9760-0752a2a21ffc, ghrun-bs3qzf6rey.auto.internal:31131): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/PathSQS/U_private_create_queue_a77ea128-cb0e-11f0-8770-d00d636e60d4/Queues" }
2025-11-26 21:27:07,710 - DEBUG - ydb.connection.587900  - _log_response: RpcState(DescribePath, e97de124-1af0-4149-9760-0752a2a21ffc, ghrun-bs3qzf6rey.auto.internal:31131): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 21:27:07,711 - DEBUG - ydb.tests.library.sqs.test_base.587900  - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 21:27:07,711 - DEBUG - ydb.topic.587900  - close: Close topic client
2025-11-26 21:27:07,712 - DEBUG - ydb.topic.587900  - close: Topic client was closed
2025-11-26 21:27:07,712 - DEBUG - ydb.connection.587900  - close: Closing channel for endpoint localhost:31131
2025-11-26 21:27:07,713 - DEBUG - ydb.connection.587900  - close: Closing channel for endpoint ghrun-bs3qzf6rey.auto.internal:31131
2025-11-26 21:27:07,714 - INFO - ydb.pool.Discovery.587900  - run: Successfully terminated discovery process
2025-11-26 21:27:07,716 - DEBUG - root.587900  - teardown_method: Test finished: test_private_create_queue
