2025-11-26 18:28:53,745 - INFO - ya.test.1949042  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:28:53,745 - INFO - ya.test.1949042  - pytest_runtest_setup: test_private_queue_recreation[tables_format_v0-std]
2025-11-26 18:28:53,746 - INFO - ya.test.1949042  - pytest_runtest_setup: ####################################################################################################
2025-11-26 18:28:53,746 - INFO - ya.test.1949042  - pytest_runtest_setup: Test setup
2025-11-26 18:28:53,747 - DEBUG - root.1949042  - setup_method: Test started: test_private_queue_recreation
2025-11-26 18:28:53,747 - DEBUG - root.1949042  - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/ndq1/004284/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v0-fifo
2025-11-26 18:28:53,748 - INFO - ydb.tests.library.harness.kikimr_runner.1949042  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ndq1/004284/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v0-fifo/cluster/kikimr_configs"
2025-11-26 18:28:53,748 - INFO - ydb.tests.library.harness.kikimr_runner.1949042  - __make_run_command: Final command: /home/runner/.ya/build/build_root/ndq1/004284/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/ndq1/004284/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk6/testing_out_stuff/test_common.py.TestCommonYandexWithPath.test_private_queue_recreation.tables_format_v0-fifo/cluster/node_1/logfile_7tmbigmw.log --grpc-port=5179 --mon-port=1963 --ic-port=30170 --sqs-port=5828
2025-11-26 18:28:53,748 - INFO - ydb.tests.library.harness.kikimr_runner.1949042  - start: Started node localhost:5179/1
2025-11-26 18:28:53,749 - DEBUG - ya.test.1949042  - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-11-26 18:28:53,750 - DEBUG - ya.test.1949042  - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-11-26 18:28:53,750 - DEBUG - ya.test.1949042  - execute: Executing '['/home/runner/.ya/build/build_root/ndq1/004284/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 18:28:53,751 - DEBUG - ya.test.1949042  - execute: Command pid: 1966050
2025-11-26 18:28:55,087 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) rc: 0
2025-11-26 18:28:55,088 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) elapsed time (sec): 1.3355872631072998
2025-11-26 18:28:55,088 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) idrss: 0
2025-11-26 18:28:55,088 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) inblock: 0
2025-11-26 18:28:55,088 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) isrss: 0
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) ixrss: 0
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) majflt: 0
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) maxrss: 545708
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) minflt: 16250
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) msgrcv: 0
2025-11-26 18:28:55,089 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) msgsnd: 0
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) nivcsw: 162
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) nsignals: 0
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) nswap: 0
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) nvcsw: 15
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) oublock: 8
2025-11-26 18:28:55,090 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) stime: 1.137133
2025-11-26 18:28:55,095 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) utime: 0.124525
2025-11-26 18:28:55,095 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) wtime: 1.337
2025-11-26 18:28:55,095 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) output:
Git info:
    Commit: 94a99ec3cc48e314e4c70283a55e969fc4529253
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 36624a59d840d94118051a381aa20c4c4c5969e9 into f11c39b51dba8429a3b2ec506264246192252ec7
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ihttfokzrq    Host information: 
        Linux ghrun-ihttfokzrq 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 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -UNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-11-26 18:28:55,095 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1966050) errors:

2025-11-26 18:28:55,096 - INFO - ydb.tests.library.harness.kikimr_runner.1949042  - start: Node 1 version:
Git info:
    Commit: 94a99ec3cc48e314e4c70283a55e969fc4529253
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 36624a59d840d94118051a381aa20c4c4c5969e9 into f11c39b51dba8429a3b2ec506264246192252ec7
Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-ihttfokzrq    Host information: 
        Linux ghrun-ihttfokzrq 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64
2025-11-26 18:28:55,096 - DEBUG - root.1949042  - _setup_user: Running curl -v localhost:5828?Action=CreateUser&UserName=U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe -H authorization: aaa credential=abacaba/20220830/ec2/aws4_request
2025-11-26 18:28:55,097 - DEBUG - ya.test.1949042  - _get_command_output_file: Command out will be placed to curl.out.1
2025-11-26 18:28:55,097 - DEBUG - ya.test.1949042  - _get_command_output_file: Command err will be placed to curl.err.1
2025-11-26 18:28:55,098 - DEBUG - ya.test.1949042  - execute: Executing '['curl', '-v', 'localhost:5828?Action=CreateUser&UserName=U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-26 18:28:55,100 - DEBUG - ya.test.1949042  - execute: Command pid: 1967270
2025-11-26 18:28:55,118 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) rc: 0
2025-11-26 18:28:55,119 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) elapsed time (sec): 0.01814126968383789
2025-11-26 18:28:55,119 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) idrss: 0
2025-11-26 18:28:55,119 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) inblock: 0
2025-11-26 18:28:55,119 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) isrss: 0
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) ixrss: 0
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) majflt: 0
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) maxrss: 169052
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) minflt: 594
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) msgrcv: 0
2025-11-26 18:28:55,120 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) msgsnd: 0
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) nivcsw: 3
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) nsignals: 0
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) nswap: 0
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) nvcsw: 2
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) oublock: 16
2025-11-26 18:28:55,121 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) stime: 0.0
2025-11-26 18:28:55,122 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) utime: 0.011975999999999999
2025-11-26 18:28:55,122 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) wtime: 0.02
2025-11-26 18:28:55,122 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) output:
<?xml version="1.0" encoding="UTF-8"?>
<CreateUserResponse><ResponseMetadata><RequestId>2640fa3d-6f73ba4a-896ba6f1-f7a1a193</RequestId></ResponseMetadata></CreateUserResponse>

2025-11-26 18:28:55,122 - DEBUG - ya.test.1949042  - _save_outputs: Command (pid 1967270) errors:
*   Trying 127.0.0.1:5828...
  % 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 5828 (#0)
> GET /?Action=CreateUser&UserName=U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe HTTP/1.1
> Host: localhost:5828
> 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  21874      0 --:--:-- --:--:-- --:--:-- 25142
* Connection #0 to host localhost left intact

2025-11-26 18:28:55,123 - INFO - ydb.tests.library.sqs.test_base.1949042  - wait_can_list_users: Listing SQS users
2025-11-26 18:28:55,124 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828 from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: Action=ListQueues
2025-11-26 18:28:55,126 - DEBUG - urllib3.connectionpool.1949042  - _new_conn: Starting new HTTP connection (1): localhost:5828
2025-11-26 18:28:55,133 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST / HTTP/1.1" 200 195
2025-11-26 18:28:55,143 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,143 - DEBUG - root.1949042  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<ListQueuesResponse><ListQueuesResult/><ResponseMetadata><RequestId>38136eec-bd5d7257-5e82cdfb-af91f816</RequestId></ResponseMetadata></ListQueuesResponse>

2025-11-26 18:28:55,144 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,144 - ERROR - ydb.tests.library.sqs.requests_client.1949042  - _process_response: Could not process response from SQS: {'ListQueuesResponse': {'ListQueuesResult': None, 'ResponseMetadata': {'RequestId': '38136eec-bd5d7257-5e82cdfb-af91f816'}}}. <class 'TypeError'>: 'NoneType' object is not subscriptable
2025-11-26 18:28:55,145 - INFO - ydb.tests.library.sqs.test_base.1949042  - wait_can_list_users: Success. Api is up.
2025-11-26 18:28:55,145 - DEBUG - ydb.connection.1949042  - 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 18:28:55,147 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1949042  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 18:28:55,148 - DEBUG - ydb.connection.1949042  - 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 18:28:55,155 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1949042  - context_resolve: Resolving endpoints for database /Root
2025-11-26 18:28:55,156 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(ListEndpoints, 97ccf6e7-26c8-41a1-953e-53ccdb9a979f, localhost:5179): creating call state
2025-11-26 18:28:55,156 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(ListEndpoints, 97ccf6e7-26c8-41a1-953e-53ccdb9a979f, localhost:5179): request = { database: "/Root" }
2025-11-26 18:28:55,160 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(ListEndpoints, 97ccf6e7-26c8-41a1-953e-53ccdb9a979f, localhost:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-ihttfokzrq.auto.internal" port: 5179 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 18:28:55,161 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.1949042  - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-ihttfokzrq.auto.internal:5179, location 1, ssl: False>]>
2025-11-26 18:28:55,161 - DEBUG - ydb.connection.1949042  - 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 18:28:55,171 - INFO - ya.test.1949042  - pytest_runtest_call: Test call (class_name: test_common.py::TestCommonYandexWithPath, test_name: test_private_queue_recreation[tables_format_v0-std])
2025-11-26 18:28:55,171 - DEBUG - root.1949042  - _execute_yql_query: Executing database query: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES ("U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe", "CreateQueuesWithTabletFormat", "0")"
2025-11-26 18:28:55,172 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(CreateSession, 6a3b3762-ef7b-454d-8139-41c1e5a7e8cd, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:55,172 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(CreateSession, 6a3b3762-ef7b-454d-8139-41c1e5a7e8cd, ghrun-ihttfokzrq.auto.internal:5179): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:55,175 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(CreateSession, 6a3b3762-ef7b-454d-8139-41c1e5a7e8cd, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZjRiNDM1YjYtZTdmNGRmNzktZTkwMTA3M2QtZTZmNDBiZDk=" } } } }
2025-11-26 18:28:55,176 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(ExecuteDataQuery, 343ac8db-7911-424d-ac51-6c10bdfe8547, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:55,177 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(ExecuteDataQuery, 343ac8db-7911-424d-ac51-6c10bdfe8547, ghrun-ihttfokzrq.auto.internal:5179): request = { session_id: "ydb://session/3?node_id=1&id=ZjRiNDM1YjYtZTdmNGRmNzktZTkwMTA3M2QtZTZmNDBiZDk=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "UPSERT INTO `/Root/PathSQS/.Settings` (Account, Name, Value)                 VALUES (\"U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe\", \"CreateQueuesWithTabletFormat\", \"0\")" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:55,198 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(ExecuteDataQuery, 343ac8db-7911-424d-ac51-6c10bdfe8547, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 18:28:55,199 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828 from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: QueueName=Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe&Action=CreateQueue
2025-11-26 18:28:55,402 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST / HTTP/1.1" 200 408
2025-11-26 18:28:55,415 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,415 - DEBUG - root.1949042  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-ihttfokzrq.auto.internal:5828/U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe/Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>a29ed2ab-1f97c180-f3e37bd6-d77b58d5</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 18:28:55,416 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,417 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828 from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: QueueUrl=http%3A%2F%2Fghrun-ihttfokzrq.auto.internal%3A5828%2FU_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe%2FQ_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe&AttributeName.1=All&Action=GetQueueAttributes
2025-11-26 18:28:55,443 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST / HTTP/1.1" 200 1154
2025-11-26 18:28:55,468 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,469 - DEBUG - root.1949042  - _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>CreatedTimestamp</Name><Value>1764181735</Value></Attribute><Attribute><Name>DelaySeconds</Name><Value>0</Value></Attribute><Attribute><Name>MaximumMessageSize</Name><Value>262144</Value></Attribute><Attribute><Name>MessageRetentionPeriod</Name><Value>345600</Value></Attribute><Attribute><Name>ReceiveMessageWaitTimeSeconds</Name><Value>0</Value></Attribute><Attribute><Name>VisibilityTimeout</Name><Value>30</Value></Attribute><Attribute><Name>QueueArn</Name><Value>yrn:ya:sqs:ru-central1:U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe:Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>686115d1-c32f048b-498c0bac-ed6b717c</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-26 18:28:55,469 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,470 - DEBUG - root.1949042  - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe" AND  QueueName="Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe""
2025-11-26 18:28:55,471 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(CreateSession, 3a187e12-261f-4be6-8e5c-ac12445a8715, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:55,471 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(CreateSession, 3a187e12-261f-4be6-8e5c-ac12445a8715, ghrun-ihttfokzrq.auto.internal:5179): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:55,473 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(CreateSession, 3a187e12-261f-4be6-8e5c-ac12445a8715, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZTQ3NGM2YzQtM2EzMzllNzMtOGI3YThkMWYtYzFlMmFkNjg=" } } } }
2025-11-26 18:28:55,474 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(ExecuteDataQuery, 39a8e02e-1b9f-4176-a772-d2e399c66751, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:55,474 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(ExecuteDataQuery, 39a8e02e-1b9f-4176-a772-d2e399c66751, ghrun-ihttfokzrq.auto.internal:5179): request = { session_id: "ydb://session/3?node_id=1&id=ZTQ3NGM2YzQtM2EzMzllNzMtOGI3YThkMWYtYzFlMmFkNjg=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe\" AND  QueueName=\"Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:55,497 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(ExecuteDataQuery, 39a8e02e-1b9f-4176-a772-d2e399c66751, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } rows { items { text_value: "U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe" } items { uint64_value: 1764181735201 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { uint64_value: 72075186224038087 } items { uint64_value: 8 } items { bytes_value: "ebae99a1-cce5beee-a0817430-44004598" } items { text_value: "Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe" } items { uint64_value: 3 } items { uint64_value: 4 } items { uint32_value: 0 } items { text_value: "{}" } items { uint64_value: 3 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-26 18:28:55,498 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828 from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: QueueUrl=http%3A%2F%2Fghrun-ihttfokzrq.auto.internal%3A5828%2FU_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe%2FQ_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe&Action=DeleteQueue
2025-11-26 18:28:55,833 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST / HTTP/1.1" 200 178
2025-11-26 18:28:55,842 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,842 - DEBUG - root.1949042  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<DeleteQueueResponse><ResponseMetadata><RequestId>7275237a-fbd1f894-16a0a363-1e297895</RequestId></ResponseMetadata></DeleteQueueResponse>

2025-11-26 18:28:55,843 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:55,844 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828/private from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: QueueName=Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe&CreatedTimestamp=1764181735&CustomQueueName=&Action=CreateQueue
2025-11-26 18:28:56,012 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST /private HTTP/1.1" 200 408
2025-11-26 18:28:56,024 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:56,025 - DEBUG - root.1949042  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-ihttfokzrq.auto.internal:5828/U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe/Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>9d5a32a3-a33312f1-eda9e1ed-84364846</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 18:28:56,026 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:28:56,026 - DEBUG - root.1949042  - _execute_yql_query: Executing database query: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account="U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe" AND  QueueName="Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe""
2025-11-26 18:28:56,027 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(CreateSession, ccb375b8-a5d6-457a-9d90-c95ae13156f1, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:56,028 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(CreateSession, ccb375b8-a5d6-457a-9d90-c95ae13156f1, ghrun-ihttfokzrq.auto.internal:5179): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:56,031 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(CreateSession, ccb375b8-a5d6-457a-9d90-c95ae13156f1, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=1&id=ZTY2ODE0MWQtNjZjOTAyYzUtZGI0YjQ2NTQtZDJiZWUzNQ==" } } } }
2025-11-26 18:28:56,032 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(ExecuteDataQuery, ead6eb1f-e3d6-47f5-aa32-6bef20b19158, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:28:56,033 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(ExecuteDataQuery, ead6eb1f-e3d6-47f5-aa32-6bef20b19158, ghrun-ihttfokzrq.auto.internal:5179): request = { session_id: "ydb://session/3?node_id=1&id=ZTY2ODE0MWQtNjZjOTAyYzUtZGI0YjQ2NTQtZDJiZWUzNQ==" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "SELECT * FROM `/Root/PathSQS/.Queues` WHERE Account=\"U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe\" AND  QueueName=\"Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe\"" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 18:28:56,062 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(ExecuteDataQuery, ead6eb1f-e3d6-47f5-aa32-6bef20b19158, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { result_sets { columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } rows { items { text_value: "U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe" } items { uint64_value: 1764181735000 } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { bool_value: false } items { text_value: "" } items { uint64_value: 72075186224038136 } items { uint64_value: 8 } items { bytes_value: "c0803113-1ef2ffa1-5deb5c28-4e067bb2" } items { text_value: "Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe" } items { uint64_value: 3 } items { uint64_value: 4 } items { uint32_value: 0 } items { text_value: "{}" } items { uint64_value: 4 } } format: FORMAT_VALUE } tx_meta { } } } } }
2025-11-26 18:29:11,063 - DEBUG - ydb.tests.library.sqs.requests_client.1949042  - execute_request: Execute request POST http://localhost:5828 from user U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe with params: QueueUrl=http%3A%2F%2Fghrun-ihttfokzrq.auto.internal%3A5828%2FU_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe%2FQ_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe&AttributeName.1=All&Action=GetQueueAttributes
2025-11-26 18:29:11,076 - DEBUG - urllib3.connectionpool.1949042  - _make_request: http://localhost:5828 "POST / HTTP/1.1" 200 1153
2025-11-26 18:29:11,101 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:29:11,102 - DEBUG - root.1949042  - _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>CreatedTimestamp</Name><Value>1764181735</Value></Attribute><Attribute><Name>DelaySeconds</Name><Value>0</Value></Attribute><Attribute><Name>MaximumMessageSize</Name><Value>262144</Value></Attribute><Attribute><Name>MessageRetentionPeriod</Name><Value>345600</Value></Attribute><Attribute><Name>ReceiveMessageWaitTimeSeconds</Name><Value>0</Value></Attribute><Attribute><Name>VisibilityTimeout</Name><Value>30</Value></Attribute><Attribute><Name>QueueArn</Name><Value>yrn:ya:sqs:ru-central1:U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe:Q_private_queue_recreation_c3e6c5a1-caf5-11f0-965f-d00d1d9ababe</Value></Attribute></GetQueueAttributesResult><ResponseMetadata><RequestId>9ecf7e55-69f9ba9e-c00370b-59985dc9</RequestId></ResponseMetadata></GetQueueAttributesResponse>

2025-11-26 18:29:11,103 - DEBUG - charset_normalizer.1949042  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 18:29:11,105 - INFO - ya.test.1949042  - pytest_runtest_teardown: Test teardown
2025-11-26 18:29:11,106 - DEBUG - ydb.connection.1949042  - _prepare_call: RpcState(DescribePath, 2f284409-ffd5-4b7a-acc1-db54d8c4e17c, ghrun-ihttfokzrq.auto.internal:5179): creating call state
2025-11-26 18:29:11,107 - DEBUG - ydb.connection.1949042  - _log_request: RpcState(DescribePath, 2f284409-ffd5-4b7a-acc1-db54d8c4e17c, ghrun-ihttfokzrq.auto.internal:5179): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/PathSQS/U_private_queue_recreation_c3e6c2b3-caf5-11f0-a48a-d00d1d9ababe/Queues" }
2025-11-26 18:29:11,110 - DEBUG - ydb.connection.1949042  - _log_response: RpcState(DescribePath, 2f284409-ffd5-4b7a-acc1-db54d8c4e17c, ghrun-ihttfokzrq.auto.internal:5179): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 18:29:11,111 - DEBUG - ydb.tests.library.sqs.test_base.1949042  - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 18:29:11,111 - DEBUG - ydb.topic.1949042  - close: Close topic client
2025-11-26 18:29:11,111 - DEBUG - ydb.topic.1949042  - close: Topic client was closed
2025-11-26 18:29:11,111 - DEBUG - ydb.connection.1949042  - close: Closing channel for endpoint localhost:5179
2025-11-26 18:29:11,112 - DEBUG - ydb.connection.1949042  - close: Closing channel for endpoint ghrun-ihttfokzrq.auto.internal:5179
2025-11-26 18:29:11,113 - INFO - ydb.pool.Discovery.1949042  - run: Successfully terminated discovery process
2025-11-26 18:29:11,113 - DEBUG - root.1949042  - teardown_method: Test finished: test_private_queue_recreation
2025-11-26 18:29:28,116 - INFO - ydb.tests.library.harness.kikimr_runner.1949042  - stop: Stopped node localhost:5179/1
2025-11-26 18:29:28,117 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5828
2025-11-26 18:29:28,117 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/61544
2025-11-26 18:29:28,117 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3102
2025-11-26 18:29:28,118 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1963
2025-11-26 18:29:28,118 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5179
2025-11-26 18:29:28,118 - DEBUG - library.python.filelock.1949042  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/30170
