2025-11-26 19:18:35,869 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-26 19:18:35,870 - INFO - ya.test - pytest_runtest_setup: test_yc_events_processor[tables_format_v1]
2025-11-26 19:18:35,870 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-26 19:18:35,871 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-26 19:18:35,872 - DEBUG - root - setup_method: Test started: test_yc_events_processor
2025-11-26 19:18:35,872 - DEBUG - root - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/1ucl/0030c9/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk36/testing_out_stuff/test_yandex_cloud_mode.py.TestSqsYandexCloudMode.test_yc_events_processor.tables_format_v0
2025-11-26 19:18:35,875 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/1ucl/0030c9/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk36/testing_out_stuff/test_yandex_cloud_mode.py.TestSqsYandexCloudMode.test_yc_events_processor.tables_format_v0/cluster/kikimr_configs"
2025-11-26 19:18:35,875 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/1ucl/0030c9/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/1ucl/0030c9/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk36/testing_out_stuff/test_yandex_cloud_mode.py.TestSqsYandexCloudMode.test_yc_events_processor.tables_format_v0/cluster/node_1/logfile_1p7_3vfd.log --grpc-port=14562 --mon-port=2579 --ic-port=8834 --sqs-port=8206
2025-11-26 19:18:35,876 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:14562/1
2025-11-26 19:18:35,877 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.5
2025-11-26 19:18:35,878 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.5
2025-11-26 19:18:35,879 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/1ucl/0030c9/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 19:18:35,884 - DEBUG - ya.test - execute: Command pid: 2356141
2025-11-26 19:18:37,005 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) rc: 0
2025-11-26 19:18:37,006 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) elapsed time (sec): 1.1200671195983887
2025-11-26 19:18:37,006 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) idrss: 0
2025-11-26 19:18:37,007 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) inblock: 0
2025-11-26 19:18:37,007 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) isrss: 0
2025-11-26 19:18:37,007 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) ixrss: 0
2025-11-26 19:18:37,008 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) majflt: 0
2025-11-26 19:18:37,008 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) maxrss: 637840
2025-11-26 19:18:37,008 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) minflt: 45296
2025-11-26 19:18:37,008 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) msgrcv: 0
2025-11-26 19:18:37,009 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) msgsnd: 0
2025-11-26 19:18:37,009 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) nivcsw: 185
2025-11-26 19:18:37,009 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) nsignals: 0
2025-11-26 19:18:37,010 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) nswap: 0
2025-11-26 19:18:37,010 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) nvcsw: 14
2025-11-26 19:18:37,010 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) oublock: 8
2025-11-26 19:18:37,011 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) stime: 0.192408
2025-11-26 19:18:37,011 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) utime: 0.5309499999999999
2025-11-26 19:18:37,011 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) wtime: 1.126
2025-11-26 19:18:37,012 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) output:
Git info:
    Commit: c4b53a92ae30b8a0d13cc0b01172780d1acc76db
    Branch: 
    Author: YDBot <ydbot@ydb.tech>
    Summary: Merge 635997bb36d6e8f5ef078e001f417deffc1d6016 into b13fb1787157bd84c547558ae4a02400f2a0c592

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zc6g3iki2u
    Host information: 
        Linux ghrun-zc6g3iki2u 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/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/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-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -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-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -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 19:18:37,012 - DEBUG - ya.test - _save_outputs: Command (pid 2356141) errors:

2025-11-26 19:18:37,013 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: c4b53a92ae30b8a0d13cc0b01172780d1acc76db
    Branch: 
    Author: YDBot <ydbot@ydb.tech>
    Summary: Merge 635997bb36d6e8f5ef078e001f417deffc1d6016 into b13fb1787157bd84c547558ae4a02400f2a0c592
2025-11-26 19:18:37,022 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/1ucl/0030c9/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk36/testing_out_stuff/test_yandex_cloud_mode.py.TestSqsYandexCloudMode.test_yc_events_processor.tables_format_v0/cluster/kikimr_configs"
2025-11-26 19:18:37,022 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/1ucl/0030c9/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:14562 --tenant=/Root/TenantSQS --log-file-name=/home/runner/.ya/build/build_root/1ucl/0030c9/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk36/testing_out_stuff/test_yandex_cloud_mode.py.TestSqsYandexCloudMode.test_yc_events_processor.tables_format_v0/cluster/slot_1/logfile_8p8uzk3d.log --grpc-port=28563 --mon-port=9162 --ic-port=26927 --sqs-port=17457
2025-11-26 19:18:37,023 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28563/1
2025-11-26 19:18:37,024 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.6
2025-11-26 19:18:37,036 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.6
2025-11-26 19:18:37,037 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/1ucl/0030c9/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 19:18:37,050 - DEBUG - ya.test - execute: Command pid: 2356305
2025-11-26 19:18:37,948 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) rc: 0
2025-11-26 19:18:37,948 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) elapsed time (sec): 0.8963115215301514
2025-11-26 19:18:37,949 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) idrss: 0
2025-11-26 19:18:37,949 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) inblock: 0
2025-11-26 19:18:37,949 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) isrss: 0
2025-11-26 19:18:37,950 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) ixrss: 0
2025-11-26 19:18:37,950 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) majflt: 0
2025-11-26 19:18:37,950 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) maxrss: 638416
2025-11-26 19:18:37,950 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) minflt: 45363
2025-11-26 19:18:37,950 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) msgrcv: 0
2025-11-26 19:18:37,951 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) msgsnd: 0
2025-11-26 19:18:37,951 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) nivcsw: 137
2025-11-26 19:18:37,951 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) nsignals: 0
2025-11-26 19:18:37,951 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) nswap: 0
2025-11-26 19:18:37,952 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) nvcsw: 14
2025-11-26 19:18:37,969 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) oublock: 8
2025-11-26 19:18:37,969 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) stime: 0.21099299999999999
2025-11-26 19:18:37,970 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) utime: 0.454495
2025-11-26 19:18:37,970 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) wtime: 0.91
2025-11-26 19:18:37,971 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) output:
Git info:
    Commit: c4b53a92ae30b8a0d13cc0b01172780d1acc76db
    Branch: 
    Author: YDBot <ydbot@ydb.tech>
    Summary: Merge 635997bb36d6e8f5ef078e001f417deffc1d6016 into b13fb1787157bd84c547558ae4a02400f2a0c592

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-zc6g3iki2u
    Host information: 
        Linux ghrun-zc6g3iki2u 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/9695656278/bin/clang++
    Compiler version: 
        clang version 20.1.2
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9695656278/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-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -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-deprecated-literal-operator -Wno-unused-but-set-variable -Wno-unused-private-field -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 19:18:37,971 - DEBUG - ya.test - _save_outputs: Command (pid 2356305) errors:

2025-11-26 19:18:37,972 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: c4b53a92ae30b8a0d13cc0b01172780d1acc76db
    Branch: 
    Author: YDBot <ydbot@ydb.tech>
    Summary: Merge 635997bb36d6e8f5ef078e001f417deffc1d6016 into b13fb1787157bd84c547558ae4a02400f2a0c592
2025-11-26 19:18:37,983 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:9162
2025-11-26 19:18:38,007 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:9162 "GET /tablets/app?TabletID=72057594037968897&node=1&page=SetDown&down=0 HTTP/1.1" 200 33
2025-11-26 19:18:38,009 - DEBUG - root - _enable_tablets_on_node: Toggle up reply: {"NodeId":1,"Down":false}
2025-11-26 19:18:38,015 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Listing SQS users
2025-11-26 19:18:38,016 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:17457 from user U_yc_events_processor_b5db4fa6-cafc-11f0-8e38-d00d1df218d2 with params: Action=ListQueues
2025-11-26 19:18:38,018 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17457
2025-11-26 19:18:38,029 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17457 "POST / HTTP/1.1" 400 279
2025-11-26 19:18:38,047 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:38,047 - WARNING - ydb.tests.library.sqs.requests_client - _process_response: Last request failed with code 400, reason 'Bad request' and text '<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>Credential should be scoped to a valid region, not 'yandex'. Request id to report: 75ee39e1-3842b406-22c0645a-71f554bc.</Message><Code>IncompleteSignature</Code></Error><RequestId></RequestId></ErrorResponse>
'
2025-11-26 19:18:38,048 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:38,050 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:38,050 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Success. Api is up.
2025-11-26 19:18:38,051 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-26 19:18:38,057 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 19:18:38,058 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-26 19:18:38,109 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/TenantSQS
2025-11-26 19:18:38,110 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 980dd7b6-c1de-48a8-8e19-4b61372dde5e, localhost:28563): creating call state
2025-11-26 19:18:38,110 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 980dd7b6-c1de-48a8-8e19-4b61372dde5e, localhost:28563): request = { database: "/Root/TenantSQS" }
2025-11-26 19:18:38,124 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 980dd7b6-c1de-48a8-8e19-4b61372dde5e, localhost:28563): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-zc6g3iki2u.auto.internal" port: 28563 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" node_id: 50000 } } } } }
2025-11-26 19:18:38,125 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/TenantSQS: DiscoveryResult <self_location: , endpoints [<Endpoint ghrun-zc6g3iki2u.auto.internal:28563, location , ssl: False>]>
2025-11-26 19:18:38,126 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-26 19:18:38,140 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28563
2025-11-26 19:18:38,145 - INFO - root - _before_test_start: run test with cloud_id=CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2 folder_id=folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2
2025-11-26 19:18:38,147 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_yandex_cloud_mode.py::TestSqsYandexCloudMode, test_name: test_yc_events_processor[tables_format_v1])
2025-11-26 19:18:38,148 - DEBUG - root - _execute_yql_query: Executing database query: "UPSERT INTO `/Root/TenantSQS/.Settings` (Account, Name, Value)                 VALUES ("CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2", "CreateQueuesWithTabletFormat", "1")"
2025-11-26 19:18:38,148 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, c5733fd4-897c-4016-87fb-283a6dabd648, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:38,149 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, c5733fd4-897c-4016-87fb-283a6dabd648, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 19:18:38,158 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, c5733fd4-897c-4016-87fb-283a6dabd648, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=MTNkM2I4M2EtZTQ4N2E4NTctYWMxYmFiYjAtNGZlMjUzN2I=" } } } }
2025-11-26 19:18:38,159 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, 939d4c66-b0fb-4087-900c-44bfafc70153, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:38,160 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, 939d4c66-b0fb-4087-900c-44bfafc70153, ghrun-zc6g3iki2u.auto.internal:28563): request = { session_id: "ydb://session/3?node_id=50000&id=MTNkM2I4M2EtZTQ4N2E4NTctYWMxYmFiYjAtNGZlMjUzN2I=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "UPSERT INTO `/Root/TenantSQS/.Settings` (Account, Name, Value)                 VALUES (\"CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2\", \"CreateQueuesWithTabletFormat\", \"1\")" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 19:18:38,330 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, 939d4c66-b0fb-4087-900c-44bfafc70153, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 19:18:38,332 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:17457/private from user CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2 with params: QueueName=queue1&Action=CreateQueue&folderId=folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2
2025-11-26 19:18:38,335 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17457
2025-11-26 19:18:38,719 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17457 "POST /private HTTP/1.1" 200 367
2025-11-26 19:18:38,738 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:38,738 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-zc6g3iki2u.auto.internal:17457/CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2/0000000000000005040j/queue1</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>7407716a-25d0c743-c1fe6580-6ce40134</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 19:18:38,739 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:38,741 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:17457/private from user CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2 with params: QueueName=queue2&Action=CreateQueue&folderId=folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2
2025-11-26 19:18:39,025 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17457 "POST /private HTTP/1.1" 200 367
2025-11-26 19:18:39,050 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:39,051 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-zc6g3iki2u.auto.internal:17457/CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2/0000000000000007040j/queue2</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>511aaccc-c3c862fc-a15b2c2b-15736e60</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 19:18:39,052 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 19:18:39,054 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-26 19:18:39,055 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 44af9276-90aa-4d21-b4bb-56fb4ceea935, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,056 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 44af9276-90aa-4d21-b4bb-56fb4ceea935, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS" }
2025-11-26 19:18:39,072 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 44af9276-90aa-4d21-b4bb-56fb4ceea935, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "Root/TenantSQS" owner: "root@builtin" type: DATABASE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } size_bytes: 12112 created_at { tx_id: 1 } } children { name: ".AtomicCounter" owner: "root@builtin" type: TABLE created_at { plan_step: 1764184649400 tx_id: 281474976720657 } } children { name: ".Events" owner: "root@builtin" type: TABLE created_at { plan_step: 1764184650360 tx_id: 281474976720662 } } children { name: ".FIFO" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1764184653250 tx_id: 281474976720673 } } children { name: ".Queues" owner: "root@builtin" type: TABLE created_at { plan_step: 1764184650210 tx_id: 281474976720661 } } children { name: ".RemovedQueues" owner: "root@builtin" type: TABLE created_at { plan_step: 1764184650630 tx_id: 281474976720664 } } children { name: ".STD" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1764184650930 tx_id: 281474976720665 } } children { name: ".Settings" owner: "root@builtin" type: TABLE created_at { plan_step: 1764184650480 tx_id: 281474976720663 } } children { name: "CLOUD_FOR_folder_acc_930ddfa9-cafc-11f0-aaf3-d00d1df218d2" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1764184660040 tx_id: 281474976720691 } } children { name: "CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1764184718430 tx_id: 281474976720809 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-11-26 19:18:39,074 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, ef467876-76b3-4e51-8ee7-bfc9164b18d2, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,075 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, ef467876-76b3-4e51-8ee7-bfc9164b18d2, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.Events/Queues" }
2025-11-26 19:18:39,080 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, ef467876-76b3-4e51-8ee7-bfc9164b18d2, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,081 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,082 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 38c8e41f-a3e4-4c18-8897-ceb75293edc4, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,083 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 38c8e41f-a3e4-4c18-8897-ceb75293edc4, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.FIFO/Queues" }
2025-11-26 19:18:39,089 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 38c8e41f-a3e4-4c18-8897-ceb75293edc4, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,090 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,091 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, fcfc4086-94db-40de-8da5-dfd87f40d8c1, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,091 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, fcfc4086-94db-40de-8da5-dfd87f40d8c1, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.RemovedQueues/Queues" }
2025-11-26 19:18:39,103 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, fcfc4086-94db-40de-8da5-dfd87f40d8c1, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,104 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,104 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, ec43e850-830f-4569-ae0f-38b0bb4ab4d7, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,114 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, ec43e850-830f-4569-ae0f-38b0bb4ab4d7, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.STD/Queues" }
2025-11-26 19:18:39,121 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, ec43e850-830f-4569-ae0f-38b0bb4ab4d7, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,122 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,122 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 6bfc871a-3d29-41c4-9202-49e2c66412c1, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,123 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 6bfc871a-3d29-41c4-9202-49e2c66412c1, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_930ddfa9-cafc-11f0-aaf3-d00d1df218d2/Queues" }
2025-11-26 19:18:39,138 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 6bfc871a-3d29-41c4-9202-49e2c66412c1, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,139 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,140 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 012361ed-5053-42f1-851e-ba34295c6853, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,140 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 012361ed-5053-42f1-851e-ba34295c6853, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2/Queues" }
2025-11-26 19:18:39,159 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 012361ed-5053-42f1-851e-ba34295c6853, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,160 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,161 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 96d7f2e6-78b1-4b93-b314-74e4dd0d56bb, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,162 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 96d7f2e6-78b1-4b93-b314-74e4dd0d56bb, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.sys/Queues" }
2025-11-26 19:18:39,168 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 96d7f2e6-78b1-4b93-b314-74e4dd0d56bb, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,169 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,170 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, f313f3e7-82e1-426d-8e85-7307544bcc5f, ghrun-zc6g3iki2u.auto.internal:28563): creating call state
2025-11-26 19:18:39,170 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, f313f3e7-82e1-426d-8e85-7307544bcc5f, ghrun-zc6g3iki2u.auto.internal:28563): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_b5efe9da-cafc-11f0-8b06-d00d1df218d2/Queues" }
2025-11-26 19:18:39,181 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, f313f3e7-82e1-426d-8e85-7307544bcc5f, ghrun-zc6g3iki2u.auto.internal:28563): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 19:18:39,182 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 19:18:39,183 - DEBUG - ydb.topic - close: Close topic client
2025-11-26 19:18:39,183 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-26 19:18:39,183 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28563
2025-11-26 19:18:39,184 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-zc6g3iki2u.auto.internal:28563
2025-11-26 19:18:39,186 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-26 19:18:39,187 - DEBUG - root - teardown_method: Test finished: test_yc_events_processor
2025-11-26 19:18:56,193 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:28563/1
2025-11-26 19:19:01,197 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:14562/1
2025-11-26 19:19:01,199 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17457
2025-11-26 19:19:01,200 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/62041
2025-11-26 19:19:01,200 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12815
2025-11-26 19:19:01,200 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26927
2025-11-26 19:19:01,200 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9162
2025-11-26 19:19:01,201 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28563
2025-11-26 19:19:01,201 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8206
2025-11-26 19:19:01,201 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/20840
2025-11-26 19:19:01,202 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/17621
2025-11-26 19:19:01,202 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/2579
2025-11-26 19:19:01,202 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14562
2025-11-26 19:19:01,203 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/8834
