2025-11-26 21:02:20,884 - INFO - ya.test.122521  - pytest_runtest_setup: ####################################################################################################
2025-11-26 21:02:20,885 - INFO - ya.test.122521  - pytest_runtest_setup: test_create_update_delete_one_queue[tables_format_v1-std]
2025-11-26 21:02:20,885 - INFO - ya.test.122521  - pytest_runtest_setup: ####################################################################################################
2025-11-26 21:02:20,885 - INFO - ya.test.122521  - pytest_runtest_setup: Test setup
2025-11-26 21:02:20,886 - DEBUG - root.122521  - setup_method: Test started: test_create_update_delete_one_queue
2025-11-26 21:02:20,886 - DEBUG - root.122521  - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/4rkp/005fdd/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk13/testing_out_stuff/test_yandex_audit.py.TestCloudEvents.test_create_update_delete_one_queue.tables_format_v1-fifo
2025-11-26 21:02:20,887 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4rkp/005fdd/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk13/testing_out_stuff/test_yandex_audit.py.TestCloudEvents.test_create_update_delete_one_queue.tables_format_v1-fifo/cluster/kikimr_configs"
2025-11-26 21:02:20,887 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - __make_run_command: Final command: /home/runner/.ya/build/build_root/4rkp/005fdd/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/005fdd/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk13/testing_out_stuff/test_yandex_audit.py.TestCloudEvents.test_create_update_delete_one_queue.tables_format_v1-fifo/cluster/node_1/logfile_5eugiucr.log --grpc-port=26777 --mon-port=22133 --ic-port=26116 --sqs-port=10900
2025-11-26 21:02:20,887 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - start: Started node localhost:26777/1
2025-11-26 21:02:20,888 - DEBUG - ya.test.122521  - _get_command_output_file: Command out will be placed to ydbd.out.5
2025-11-26 21:02:20,889 - DEBUG - ya.test.122521  - _get_command_output_file: Command err will be placed to ydbd.err.5
2025-11-26 21:02:20,889 - DEBUG - ya.test.122521  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fdd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 21:02:20,896 - DEBUG - ya.test.122521  - execute: Command pid: 137115
2025-11-26 21:02:21,841 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) rc: 0
2025-11-26 21:02:21,842 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) elapsed time (sec): 0.9438984394073486
2025-11-26 21:02:21,842 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) idrss: 0
2025-11-26 21:02:21,842 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) inblock: 0
2025-11-26 21:02:21,843 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) isrss: 0
2025-11-26 21:02:21,843 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) ixrss: 0
2025-11-26 21:02:21,844 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) majflt: 0
2025-11-26 21:02:21,844 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) maxrss: 606976
2025-11-26 21:02:21,844 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) minflt: 45605
2025-11-26 21:02:21,844 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) msgrcv: 0
2025-11-26 21:02:21,845 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) msgsnd: 0
2025-11-26 21:02:21,845 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) nivcsw: 146
2025-11-26 21:02:21,846 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) nsignals: 0
2025-11-26 21:02:21,846 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) nswap: 0
2025-11-26 21:02:21,846 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) nvcsw: 14
2025-11-26 21:02:21,847 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) oublock: 8
2025-11-26 21:02:21,847 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) stime: 0.20376899999999998
2025-11-26 21:02:21,847 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) utime: 0.48966099999999996
2025-11-26 21:02:21,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) wtime: 0.951
2025-11-26 21:02:21,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) 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:02:21,849 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137115) errors:

2025-11-26 21:02:21,849 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - 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:02:21,850 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/4rkp/005fdd/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk13/testing_out_stuff/test_yandex_audit.py.TestCloudEvents.test_create_update_delete_one_queue.tables_format_v1-fifo/cluster/kikimr_configs"
2025-11-26 21:02:21,850 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - __make_run_command: Final command: /home/runner/.ya/build/build_root/4rkp/005fdd/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26777 --tenant=/Root/TenantSQS --log-file-name=/home/runner/.ya/build/build_root/4rkp/005fdd/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk13/testing_out_stuff/test_yandex_audit.py.TestCloudEvents.test_create_update_delete_one_queue.tables_format_v1-fifo/cluster/slot_1/logfile_q45gydu7.log --grpc-port=11409 --mon-port=7440 --ic-port=14338 --sqs-port=11306
2025-11-26 21:02:21,850 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - start: Started node localhost:11409/1
2025-11-26 21:02:21,852 - DEBUG - ya.test.122521  - _get_command_output_file: Command out will be placed to ydbd.out.6
2025-11-26 21:02:21,853 - DEBUG - ya.test.122521  - _get_command_output_file: Command err will be placed to ydbd.err.6
2025-11-26 21:02:21,853 - DEBUG - ya.test.122521  - execute: Executing '['/home/runner/.ya/build/build_root/4rkp/005fdd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-26 21:02:21,858 - DEBUG - ya.test.122521  - execute: Command pid: 137210
2025-11-26 21:02:22,826 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) rc: 0
2025-11-26 21:02:22,827 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) elapsed time (sec): 0.9584922790527344
2025-11-26 21:02:22,827 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) idrss: 0
2025-11-26 21:02:22,827 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) inblock: 0
2025-11-26 21:02:22,828 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) isrss: 0
2025-11-26 21:02:22,828 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) ixrss: 0
2025-11-26 21:02:22,828 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) majflt: 0
2025-11-26 21:02:22,828 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) maxrss: 606976
2025-11-26 21:02:22,829 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) minflt: 45609
2025-11-26 21:02:22,829 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) msgrcv: 0
2025-11-26 21:02:22,829 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) msgsnd: 0
2025-11-26 21:02:22,830 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) nivcsw: 129
2025-11-26 21:02:22,846 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) nsignals: 0
2025-11-26 21:02:22,847 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) nswap: 0
2025-11-26 21:02:22,847 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) nvcsw: 14
2025-11-26 21:02:22,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) oublock: 8
2025-11-26 21:02:22,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) stime: 0.176223
2025-11-26 21:02:22,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) utime: 0.517212
2025-11-26 21:02:22,848 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) wtime: 0.963
2025-11-26 21:02:22,849 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) 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:02:22,849 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137210) errors:

2025-11-26 21:02:22,858 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - 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:02:22,862 - DEBUG - urllib3.connectionpool.122521  - _new_conn: Starting new HTTP connection (1): localhost:7440
2025-11-26 21:02:22,880 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:7440 "GET /tablets/app?TabletID=72057594037968897&node=1&page=SetDown&down=0 HTTP/1.1" 200 33
2025-11-26 21:02:22,882 - DEBUG - root.122521  - _enable_tablets_on_node: Toggle up reply: {"NodeId":1,"Down":false}
2025-11-26 21:02:22,883 - DEBUG - root.122521  - _setup_user: Running curl -v localhost:10900?Action=CreateUser&UserName=U_create_update_delete_one_queue_342b7735-cb0b-11f0-84aa-d00d636e60d4 -H authorization: aaa credential=abacaba/20220830/ec2/aws4_request
2025-11-26 21:02:22,884 - DEBUG - ya.test.122521  - _get_command_output_file: Command out will be placed to curl.out.1
2025-11-26 21:02:22,885 - DEBUG - ya.test.122521  - _get_command_output_file: Command err will be placed to curl.err.1
2025-11-26 21:02:22,885 - DEBUG - ya.test.122521  - execute: Executing '['curl', '-v', 'localhost:10900?Action=CreateUser&UserName=U_create_update_delete_one_queue_342b7735-cb0b-11f0-84aa-d00d636e60d4', '-H', 'authorization: aaa credential=abacaba/20220830/ec2/aws4_request']' in 'None' (waiting)
2025-11-26 21:02:22,918 - DEBUG - ya.test.122521  - execute: Command pid: 137536
2025-11-26 21:02:22,932 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) rc: 0
2025-11-26 21:02:22,933 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) elapsed time (sec): 0.008468151092529297
2025-11-26 21:02:22,933 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) idrss: 0
2025-11-26 21:02:22,933 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) inblock: 0
2025-11-26 21:02:22,933 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) isrss: 0
2025-11-26 21:02:22,934 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) ixrss: 0
2025-11-26 21:02:22,934 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) majflt: 0
2025-11-26 21:02:22,934 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) maxrss: 606976
2025-11-26 21:02:22,935 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) minflt: 590
2025-11-26 21:02:22,935 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) msgrcv: 0
2025-11-26 21:02:22,935 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) msgsnd: 0
2025-11-26 21:02:22,935 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) nivcsw: 1
2025-11-26 21:02:22,936 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) nsignals: 0
2025-11-26 21:02:22,936 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) nswap: 0
2025-11-26 21:02:22,936 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) nvcsw: 2
2025-11-26 21:02:22,937 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) oublock: 16
2025-11-26 21:02:22,937 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) stime: 0.007179
2025-11-26 21:02:22,937 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) utime: 0.0035889999999999997
2025-11-26 21:02:22,938 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) wtime: 0.042
2025-11-26 21:02:22,938 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) output:
<?xml version="1.0" encoding="UTF-8"?>
<ErrorResponse><Error><Message>This action is disabled in YMQ. Request id to report: 6eef6683-4668a4cf-a0aacf4c-85944e91.</Message><Code>InvalidAction</Code></Error><RequestId></RequestId></ErrorResponse>

2025-11-26 21:02:22,938 - DEBUG - ya.test.122521  - _save_outputs: Command (pid 137536) errors:
*   Trying 127.0.0.1:10900...
  % 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 10900 (#0)
> GET /?Action=CreateUser&UserName=U_create_update_delete_one_queue_342b7735-cb0b-11f0-84aa-d00d636e60d4 HTTP/1.1
> Host: localhost:10900
> User-Agent: curl/7.81.0
> Accept: */*
> authorization: aaa credential=abacaba/20220830/ec2/aws4_request
> 
* Mark bundle as not supporting multiuse
< HTTP/1.1 400 Bad request
< Content-Type: application/xml
< Content-Length: 244
< Connection: Keep-Alive
< 
{ [244 bytes data]

100   244  100   244    0     0   107k      0 --:--:-- --:--:-- --:--:--  238k
* Connection #0 to host localhost left intact

2025-11-26 21:02:22,939 - DEBUG - ya.test.122521  - verify_sanitize_errors: 'curl' doesn't belong to '/home/runner/.ya/build/build_root/4rkp/005fdd' - no check for sanitize errors
2025-11-26 21:02:22,940 - INFO - ydb.tests.library.sqs.test_base.122521  - wait_can_list_users: Listing SQS users
2025-11-26 21:02:22,941 - DEBUG - ydb.tests.library.sqs.requests_client.122521  - execute_request: Execute request POST http://localhost:11306 from user U_create_update_delete_one_queue_342b7735-cb0b-11f0-84aa-d00d636e60d4 with params: Action=ListQueues
2025-11-26 21:02:22,943 - DEBUG - urllib3.connectionpool.122521  - _new_conn: Starting new HTTP connection (1): localhost:11306
2025-11-26 21:02:22,953 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:11306 "POST / HTTP/1.1" 400 278
2025-11-26 21:02:22,993 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:22,994 - WARNING - ydb.tests.library.sqs.requests_client.122521  - _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: 37edf9d9-47d877a0-33de667-e8c7c47b.</Message><Code>IncompleteSignature</Code></Error><RequestId></RequestId></ErrorResponse>
'
2025-11-26 21:02:22,995 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:22,996 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:22,997 - INFO - ydb.tests.library.sqs.test_base.122521  - wait_can_list_users: Success. Api is up.
2025-11-26 21:02:22,997 - DEBUG - ydb.connection.122521  - 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:02:23,006 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.122521  - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-26 21:02:23,007 - DEBUG - ydb.connection.122521  - 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:02:23,027 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.122521  - context_resolve: Resolving endpoints for database /Root/TenantSQS
2025-11-26 21:02:23,027 - DEBUG - ydb.connection.122521  - _prepare_call: RpcState(ListEndpoints, e2339c15-559c-433a-b72e-53be48cbb9f8, localhost:11409): creating call state
2025-11-26 21:02:23,028 - DEBUG - ydb.connection.122521  - _log_request: RpcState(ListEndpoints, e2339c15-559c-433a-b72e-53be48cbb9f8, localhost:11409): request = { database: "/Root/TenantSQS" }
2025-11-26 21:02:23,037 - DEBUG - ydb.connection.122521  - _log_response: RpcState(ListEndpoints, e2339c15-559c-433a-b72e-53be48cbb9f8, localhost:11409): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-bs3qzf6rey.auto.internal" port: 11409 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 21:02:23,038 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver.122521  - _add_debug_details: Resolved endpoints for database /Root/TenantSQS: DiscoveryResult <self_location: , endpoints [<Endpoint ghrun-bs3qzf6rey.auto.internal:11409, location , ssl: False>]>
2025-11-26 21:02:23,040 - DEBUG - ydb.connection.122521  - 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:02:23,078 - DEBUG - ydb.connection.122521  - close: Closing channel for endpoint localhost:11409
2025-11-26 21:02:23,079 - INFO - root.122521  - _before_test_start: run test with cloud_id=CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4 folder_id=folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4
2025-11-26 21:02:23,081 - INFO - ya.test.122521  - pytest_runtest_call: Test call (class_name: test_yandex_audit.py::TestCloudEvents, test_name: test_create_update_delete_one_queue[tables_format_v1-std])
2025-11-26 21:02:23,082 - DEBUG - root.122521  - _execute_yql_query: Executing database query: "UPSERT INTO `/Root/TenantSQS/.Settings` (Account, Name, Value)                 VALUES ("CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4", "CreateQueuesWithTabletFormat", "1")"
2025-11-26 21:02:23,091 - DEBUG - ydb.connection.122521  - _prepare_call: RpcState(CreateSession, 9bbed396-21b0-4ddc-813b-67525e6cdf5f, ghrun-bs3qzf6rey.auto.internal:11409): creating call state
2025-11-26 21:02:23,092 - DEBUG - ydb.connection.122521  - _log_request: RpcState(CreateSession, 9bbed396-21b0-4ddc-813b-67525e6cdf5f, ghrun-bs3qzf6rey.auto.internal:11409): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:02:23,103 - DEBUG - ydb.connection.122521  - _log_response: RpcState(CreateSession, 9bbed396-21b0-4ddc-813b-67525e6cdf5f, ghrun-bs3qzf6rey.auto.internal:11409): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NjViMTVjMGMtNWI4MzYwM2MtYzUxNmM4YTctMmYwZjM1N2U=" } } } }
2025-11-26 21:02:23,104 - DEBUG - ydb.connection.122521  - _prepare_call: RpcState(ExecuteDataQuery, 380074d5-5a01-4be4-a2c7-9d19055c80c9, ghrun-bs3qzf6rey.auto.internal:11409): creating call state
2025-11-26 21:02:23,105 - DEBUG - ydb.connection.122521  - _log_request: RpcState(ExecuteDataQuery, 380074d5-5a01-4be4-a2c7-9d19055c80c9, ghrun-bs3qzf6rey.auto.internal:11409): request = { session_id: "ydb://session/3?node_id=50000&id=NjViMTVjMGMtNWI4MzYwM2MtYzUxNmM4YTctMmYwZjM1N2U=" 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_34496b3c-cb0b-11f0-a1f4-d00d636e60d4\", \"CreateQueuesWithTabletFormat\", \"1\")" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-26 21:02:23,317 - DEBUG - ydb.connection.122521  - _log_response: RpcState(ExecuteDataQuery, 380074d5-5a01-4be4-a2c7-9d19055c80c9, ghrun-bs3qzf6rey.auto.internal:11409): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-11-26 21:02:23,318 - DEBUG - ydb.tests.library.sqs.requests_client.122521  - execute_request: Execute request POST http://localhost:11306 from user CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4 with params: QueueName=Q_create_update_delete_one_queue_342b7c34-cb0b-11f0-b2f8-d00d636e60d4&Action=CreateQueue&folderId=folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4
2025-11-26 21:02:23,321 - DEBUG - urllib3.connectionpool.122521  - _new_conn: Starting new HTTP connection (1): localhost:11306
2025-11-26 21:02:23,680 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:11306 "POST / HTTP/1.1" 200 430
2025-11-26 21:02:23,704 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:23,705 - DEBUG - root.122521  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-bs3qzf6rey.auto.internal:11306/CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4/000000000000000300qm/Q_create_update_delete_one_queue_342b7c34-cb0b-11f0-b2f8-d00d636e60d4</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>134811fc-f8e2cbbf-7b13c00f-39fe528f</RequestId></ResponseMetadata></CreateQueueResponse>

2025-11-26 21:02:23,706 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:24,712 - DEBUG - ydb.tests.library.sqs.requests_client.122521  - execute_request: Execute request POST http://localhost:11306 from user CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A11306%2FCLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4%2F000000000000000300qm%2FQ_create_update_delete_one_queue_342b7c34-cb0b-11f0-b2f8-d00d636e60d4&Tag.1.Key=tag_key_1&Tag.1.Value=tag_value_1&Tag.2.Key=tag_key_2&Tag.2.Value=tag_value_2&Action=TagQueue&folderId=folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4
2025-11-26 21:02:24,911 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:11306 "POST / HTTP/1.1" 200 172
2025-11-26 21:02:24,959 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:24,960 - DEBUG - root.122521  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<TagQueueResponse><ResponseMetadata><RequestId>7088d1b2-29b99e3f-d24477d6-e2cd335c</RequestId></ResponseMetadata></TagQueueResponse>

2025-11-26 21:02:24,961 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:25,963 - DEBUG - ydb.tests.library.sqs.requests_client.122521  - execute_request: Execute request POST http://localhost:11306 from user CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A11306%2FCLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4%2F000000000000000300qm%2FQ_create_update_delete_one_queue_342b7c34-cb0b-11f0-b2f8-d00d636e60d4&TagKey.1=tag_key_1&TagKey.2=tag_key_2&Action=UntagQueue&folderId=folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4
2025-11-26 21:02:26,040 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:11306 "POST / HTTP/1.1" 200 176
2025-11-26 21:02:26,070 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:26,079 - DEBUG - root.122521  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<UntagQueueResponse><ResponseMetadata><RequestId>f0950002-e109aa0e-f5d8de83-47f6a475</RequestId></ResponseMetadata></UntagQueueResponse>

2025-11-26 21:02:26,080 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:27,085 - DEBUG - ydb.tests.library.sqs.requests_client.122521  - execute_request: Execute request POST http://localhost:11306 from user CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4 with params: QueueUrl=http%3A%2F%2Fghrun-bs3qzf6rey.auto.internal%3A11306%2FCLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4%2F000000000000000300qm%2FQ_create_update_delete_one_queue_342b7c34-cb0b-11f0-b2f8-d00d636e60d4&Action=DeleteQueue&folderId=folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4
2025-11-26 21:02:27,363 - DEBUG - urllib3.connectionpool.122521  - _make_request: http://localhost:11306 "POST / HTTP/1.1" 200 177
2025-11-26 21:02:27,396 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:27,397 - DEBUG - root.122521  - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<DeleteQueueResponse><ResponseMetadata><RequestId>36196b27-63338664-a871037f-ded6cb5</RequestId></ResponseMetadata></DeleteQueueResponse>

2025-11-26 21:02:27,398 - DEBUG - charset_normalizer.122521  - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-11-26 21:02:37,505 - INFO - ya.test.122521  - pytest_runtest_teardown: Test teardown
2025-11-26 21:02:37,506 - DEBUG - ydb.connection.122521  - _prepare_call: RpcState(DescribePath, 514924d7-dd66-4881-b7b8-18b716de7c63, ghrun-bs3qzf6rey.auto.internal:11409): creating call state
2025-11-26 21:02:37,508 - DEBUG - ydb.connection.122521  - _log_request: RpcState(DescribePath, 514924d7-dd66-4881-b7b8-18b716de7c63, ghrun-bs3qzf6rey.auto.internal:11409): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_34496b3c-cb0b-11f0-a1f4-d00d636e60d4/Queues" }
2025-11-26 21:02:37,530 - DEBUG - ydb.connection.122521  - _log_response: RpcState(DescribePath, 514924d7-dd66-4881-b7b8-18b716de7c63, ghrun-bs3qzf6rey.auto.internal:11409): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-11-26 21:02:37,531 - DEBUG - ydb.tests.library.sqs.test_base.122521  - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-11-26 21:02:37,532 - DEBUG - ydb.topic.122521  - close: Close topic client
2025-11-26 21:02:37,532 - DEBUG - ydb.topic.122521  - close: Topic client was closed
2025-11-26 21:02:37,533 - DEBUG - ydb.connection.122521  - close: Closing channel for endpoint localhost:11409
2025-11-26 21:02:37,534 - DEBUG - ydb.connection.122521  - close: Closing channel for endpoint ghrun-bs3qzf6rey.auto.internal:11409
2025-11-26 21:02:37,536 - INFO - ydb.pool.Discovery.122521  - run: Successfully terminated discovery process
2025-11-26 21:02:37,541 - DEBUG - root.122521  - teardown_method: Test finished: test_create_update_delete_one_queue
2025-11-26 21:02:54,551 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - stop: Stopped node localhost:11409/1
2025-11-26 21:02:54,562 - INFO - ydb.tests.library.harness.kikimr_runner.122521  - stop: Stopped node localhost:26777/1
2025-11-26 21:02:54,564 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11306
2025-11-26 21:02:54,564 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23889
2025-11-26 21:02:54,565 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21713
2025-11-26 21:02:54,565 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14338
2025-11-26 21:02:54,565 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/7440
2025-11-26 21:02:54,566 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/11409
2025-11-26 21:02:54,566 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/10900
2025-11-26 21:02:54,566 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/4380
2025-11-26 21:02:54,567 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/12590
2025-11-26 21:02:54,567 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22133
2025-11-26 21:02:54,567 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26777
2025-11-26 21:02:54,568 - DEBUG - library.python.filelock.122521  - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26116
