2025-10-26 15:13:35,273 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:13:35,274 - INFO - ya.test - pytest_runtest_setup: test_counters_when_reading_from_empty_queue
2025-10-26 15:13:35,274 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 15:13:35,274 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 15:13:35,419 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd
2025-10-26 15:13:35,420 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23343
2025-10-26 15:13:35,422 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/xrv6/0029a5/r3tmp/kikimr_cluster_v6eie8hy
2025-10-26 15:13:35,467 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd
2025-10-26 15:13:35,468 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28240
2025-10-26 15:13:35,468 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13820
2025-10-26 15:13:35,469 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27231
2025-10-26 15:13:35,469 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6948
2025-10-26 15:13:35,470 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21574
2025-10-26 15:13:35,471 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:13:35,471 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/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/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/node_1/logfile_8zkj9775.log --grpc-port=28240 --mon-port=13820 --ic-port=23343 --sqs-port=21574 --module=1
2025-10-26 15:13:35,472 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:28240/1, disk_size 68719476736
2025-10-26 15:13:35,472 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:13:35,473 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/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/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/node_1/logfile_8zkj9775.log --grpc-port=28240 --mon-port=13820 --ic-port=23343 --sqs-port=21574 --module=1
2025-10-26 15:13:35,474 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/node_1/logfile_8zkj9775.log', '--grpc-port=28240', '--mon-port=13820', '--ic-port=23343', '--sqs-port=21574', '--module=1')' in '/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/node_1' (no wait)
2025-10-26 15:13:35,482 - DEBUG - ya.test - execute: Command pid: 296952
2025-10-26 15:13:35,483 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28240/1
2025-10-26 15:13:35,485 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.5
2025-10-26 15:13:35,486 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.5
2025-10-26 15:13:35,487 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:13:35,494 - DEBUG - ya.test - execute: Command pid: 296953
2025-10-26 15:13:36,346 - DEBUG - ya.test - _save_outputs: Command (pid 296953) rc: 0
2025-10-26 15:13:36,347 - DEBUG - ya.test - _save_outputs: Command (pid 296953) elapsed time (sec): 0.8509039878845215
2025-10-26 15:13:36,347 - DEBUG - ya.test - _save_outputs: Command (pid 296953) idrss: 0
2025-10-26 15:13:36,347 - DEBUG - ya.test - _save_outputs: Command (pid 296953) inblock: 0
2025-10-26 15:13:36,348 - DEBUG - ya.test - _save_outputs: Command (pid 296953) isrss: 0
2025-10-26 15:13:36,348 - DEBUG - ya.test - _save_outputs: Command (pid 296953) ixrss: 0
2025-10-26 15:13:36,348 - DEBUG - ya.test - _save_outputs: Command (pid 296953) majflt: 0
2025-10-26 15:13:36,349 - DEBUG - ya.test - _save_outputs: Command (pid 296953) maxrss: 619400
2025-10-26 15:13:36,349 - DEBUG - ya.test - _save_outputs: Command (pid 296953) minflt: 45124
2025-10-26 15:13:36,349 - DEBUG - ya.test - _save_outputs: Command (pid 296953) msgrcv: 0
2025-10-26 15:13:36,350 - DEBUG - ya.test - _save_outputs: Command (pid 296953) msgsnd: 0
2025-10-26 15:13:36,350 - DEBUG - ya.test - _save_outputs: Command (pid 296953) nivcsw: 110
2025-10-26 15:13:36,350 - DEBUG - ya.test - _save_outputs: Command (pid 296953) nsignals: 0
2025-10-26 15:13:36,351 - DEBUG - ya.test - _save_outputs: Command (pid 296953) nswap: 0
2025-10-26 15:13:36,351 - DEBUG - ya.test - _save_outputs: Command (pid 296953) nvcsw: 14
2025-10-26 15:13:36,351 - DEBUG - ya.test - _save_outputs: Command (pid 296953) oublock: 8
2025-10-26 15:13:36,352 - DEBUG - ya.test - _save_outputs: Command (pid 296953) stime: 0.190798
2025-10-26 15:13:36,352 - DEBUG - ya.test - _save_outputs: Command (pid 296953) utime: 0.594603
2025-10-26 15:13:36,352 - DEBUG - ya.test - _save_outputs: Command (pid 296953) wtime: 0.859
2025-10-26 15:13:36,352 - DEBUG - ya.test - _save_outputs: Command (pid 296953) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-10-26 15:13:36,353 - DEBUG - ya.test - _save_outputs: Command (pid 296953) errors:

2025-10-26 15:13:36,353 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 15:13:41,494 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd
2025-10-26 15:13:41,495 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28240', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 23343\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 15:13:41,496 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.6
2025-10-26 15:13:41,497 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.6
2025-10-26 15:13:41,498 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28240', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 23343\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:13:41,518 - DEBUG - ya.test - execute: Command pid: 298113
2025-10-26 15:13:42,926 - DEBUG - ya.test - _save_outputs: Command (pid 298113) rc: 0
2025-10-26 15:13:42,927 - DEBUG - ya.test - _save_outputs: Command (pid 298113) elapsed time (sec): 1.4067695140838623
2025-10-26 15:13:42,927 - DEBUG - ya.test - _save_outputs: Command (pid 298113) idrss: 0
2025-10-26 15:13:42,927 - DEBUG - ya.test - _save_outputs: Command (pid 298113) inblock: 0
2025-10-26 15:13:42,928 - DEBUG - ya.test - _save_outputs: Command (pid 298113) isrss: 0
2025-10-26 15:13:42,928 - DEBUG - ya.test - _save_outputs: Command (pid 298113) ixrss: 0
2025-10-26 15:13:42,928 - DEBUG - ya.test - _save_outputs: Command (pid 298113) majflt: 0
2025-10-26 15:13:42,929 - DEBUG - ya.test - _save_outputs: Command (pid 298113) maxrss: 707332
2025-10-26 15:13:42,929 - DEBUG - ya.test - _save_outputs: Command (pid 298113) minflt: 51457
2025-10-26 15:13:42,929 - DEBUG - ya.test - _save_outputs: Command (pid 298113) msgrcv: 0
2025-10-26 15:13:42,929 - DEBUG - ya.test - _save_outputs: Command (pid 298113) msgsnd: 0
2025-10-26 15:13:42,934 - DEBUG - ya.test - _save_outputs: Command (pid 298113) nivcsw: 231
2025-10-26 15:13:42,935 - DEBUG - ya.test - _save_outputs: Command (pid 298113) nsignals: 0
2025-10-26 15:13:42,935 - DEBUG - ya.test - _save_outputs: Command (pid 298113) nswap: 0
2025-10-26 15:13:42,935 - DEBUG - ya.test - _save_outputs: Command (pid 298113) nvcsw: 532
2025-10-26 15:13:42,935 - DEBUG - ya.test - _save_outputs: Command (pid 298113) oublock: 8
2025-10-26 15:13:42,936 - DEBUG - ya.test - _save_outputs: Command (pid 298113) stime: 0.255843
2025-10-26 15:13:42,936 - DEBUG - ya.test - _save_outputs: Command (pid 298113) utime: 0.660955
2025-10-26 15:13:42,936 - DEBUG - ya.test - _save_outputs: Command (pid 298113) wtime: 1.428
2025-10-26 15:13:42,937 - DEBUG - ya.test - _save_outputs: Command (pid 298113) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-26 15:13:42,941 - DEBUG - ya.test - _save_outputs: Command (pid 298113) errors:

2025-10-26 15:13:42,943 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd
2025-10-26 15:13:42,943 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28240', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-10-26 15:13:42,945 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.7
2025-10-26 15:13:42,950 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.7
2025-10-26 15:13:42,951 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28240', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 15:13:42,960 - DEBUG - ya.test - execute: Command pid: 298478
2025-10-26 15:13:44,282 - DEBUG - ya.test - _save_outputs: Command (pid 298478) rc: 0
2025-10-26 15:13:44,283 - DEBUG - ya.test - _save_outputs: Command (pid 298478) elapsed time (sec): 1.3207931518554688
2025-10-26 15:13:44,283 - DEBUG - ya.test - _save_outputs: Command (pid 298478) idrss: 0
2025-10-26 15:13:44,283 - DEBUG - ya.test - _save_outputs: Command (pid 298478) inblock: 0
2025-10-26 15:13:44,284 - DEBUG - ya.test - _save_outputs: Command (pid 298478) isrss: 0
2025-10-26 15:13:44,284 - DEBUG - ya.test - _save_outputs: Command (pid 298478) ixrss: 0
2025-10-26 15:13:44,285 - DEBUG - ya.test - _save_outputs: Command (pid 298478) majflt: 0
2025-10-26 15:13:44,285 - DEBUG - ya.test - _save_outputs: Command (pid 298478) maxrss: 707364
2025-10-26 15:13:44,285 - DEBUG - ya.test - _save_outputs: Command (pid 298478) minflt: 51474
2025-10-26 15:13:44,285 - DEBUG - ya.test - _save_outputs: Command (pid 298478) msgrcv: 0
2025-10-26 15:13:44,290 - DEBUG - ya.test - _save_outputs: Command (pid 298478) msgsnd: 0
2025-10-26 15:13:44,290 - DEBUG - ya.test - _save_outputs: Command (pid 298478) nivcsw: 244
2025-10-26 15:13:44,291 - DEBUG - ya.test - _save_outputs: Command (pid 298478) nsignals: 0
2025-10-26 15:13:44,291 - DEBUG - ya.test - _save_outputs: Command (pid 298478) nswap: 0
2025-10-26 15:13:44,291 - DEBUG - ya.test - _save_outputs: Command (pid 298478) nvcsw: 515
2025-10-26 15:13:44,292 - DEBUG - ya.test - _save_outputs: Command (pid 298478) oublock: 8
2025-10-26 15:13:44,292 - DEBUG - ya.test - _save_outputs: Command (pid 298478) stime: 0.34384699999999996
2025-10-26 15:13:44,293 - DEBUG - ya.test - _save_outputs: Command (pid 298478) utime: 0.6000559999999999
2025-10-26 15:13:44,293 - DEBUG - ya.test - _save_outputs: Command (pid 298478) wtime: 1.33
2025-10-26 15:13:44,293 - DEBUG - ya.test - _save_outputs: Command (pid 298478) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 15:13:44,297 - DEBUG - ya.test - _save_outputs: Command (pid 298478) errors:

2025-10-26 15:13:44,298 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-10-26 15:13:44,351 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 15:13:44,960 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd
2025-10-26 15:13:44,961 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27058
2025-10-26 15:13:44,962 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3779
2025-10-26 15:13:44,962 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/14451
2025-10-26 15:13:44,963 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/6435
2025-10-26 15:13:44,963 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9927
2025-10-26 15:13:44,964 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21608
2025-10-26 15:13:44,965 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:13:44,965 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28240 --tenant=/Root/TenantSQS --log-file-name=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/slot_1/logfile_qrsnod0b.log --grpc-port=27058 --mon-port=3779 --ic-port=14451 --sqs-port=21608
2025-10-26 15:13:44,966 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:13:44,966 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28240 --tenant=/Root/TenantSQS --log-file-name=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/slot_1/logfile_qrsnod0b.log --grpc-port=27058 --mon-port=3779 --ic-port=14451 --sqs-port=21608
2025-10-26 15:13:44,968 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:28240', '--tenant=/Root/TenantSQS', '--log-file-name=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/slot_1/logfile_qrsnod0b.log', '--grpc-port=27058', '--mon-port=3779', '--ic-port=14451', '--sqs-port=21608')' in '/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/slot_1' (no wait)
2025-10-26 15:13:44,975 - DEBUG - ya.test - execute: Command pid: 298964
2025-10-26 15:13:44,976 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:27058/1
2025-10-26 15:13:44,978 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.8
2025-10-26 15:13:44,979 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.8
2025-10-26 15:13:44,980 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:13:44,982 - DEBUG - ya.test - execute: Command pid: 298965
2025-10-26 15:13:45,982 - DEBUG - ya.test - _save_outputs: Command (pid 298965) rc: 0
2025-10-26 15:13:45,983 - DEBUG - ya.test - _save_outputs: Command (pid 298965) elapsed time (sec): 0.999333381652832
2025-10-26 15:13:45,983 - DEBUG - ya.test - _save_outputs: Command (pid 298965) idrss: 0
2025-10-26 15:13:45,984 - DEBUG - ya.test - _save_outputs: Command (pid 298965) inblock: 0
2025-10-26 15:13:45,984 - DEBUG - ya.test - _save_outputs: Command (pid 298965) isrss: 0
2025-10-26 15:13:45,984 - DEBUG - ya.test - _save_outputs: Command (pid 298965) ixrss: 0
2025-10-26 15:13:45,984 - DEBUG - ya.test - _save_outputs: Command (pid 298965) majflt: 0
2025-10-26 15:13:45,985 - DEBUG - ya.test - _save_outputs: Command (pid 298965) maxrss: 708716
2025-10-26 15:13:45,985 - DEBUG - ya.test - _save_outputs: Command (pid 298965) minflt: 45165
2025-10-26 15:13:45,985 - DEBUG - ya.test - _save_outputs: Command (pid 298965) msgrcv: 0
2025-10-26 15:13:45,985 - DEBUG - ya.test - _save_outputs: Command (pid 298965) msgsnd: 0
2025-10-26 15:13:45,991 - DEBUG - ya.test - _save_outputs: Command (pid 298965) nivcsw: 157
2025-10-26 15:13:45,991 - DEBUG - ya.test - _save_outputs: Command (pid 298965) nsignals: 0
2025-10-26 15:13:45,992 - DEBUG - ya.test - _save_outputs: Command (pid 298965) nswap: 0
2025-10-26 15:13:45,992 - DEBUG - ya.test - _save_outputs: Command (pid 298965) nvcsw: 14
2025-10-26 15:13:45,992 - DEBUG - ya.test - _save_outputs: Command (pid 298965) oublock: 8
2025-10-26 15:13:45,992 - DEBUG - ya.test - _save_outputs: Command (pid 298965) stime: 0.214252
2025-10-26 15:13:45,993 - DEBUG - ya.test - _save_outputs: Command (pid 298965) utime: 0.555945
2025-10-26 15:13:45,993 - DEBUG - ya.test - _save_outputs: Command (pid 298965) wtime: 1.002
2025-10-26 15:13:45,993 - DEBUG - ya.test - _save_outputs: Command (pid 298965) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-10-26 15:13:45,994 - DEBUG - ya.test - _save_outputs: Command (pid 298965) errors:

2025-10-26 15:13:45,994 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 15:13:52,038 - 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-10-26 15:13:52,041 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-26 15:13:52,042 - 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-10-26 15:13:52,059 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/TenantSQS
2025-10-26 15:13:52,059 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 0f264ae7-f6b9-4548-8e12-54b11f8f07d2, localhost:28240): creating call state
2025-10-26 15:13:52,060 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 0f264ae7-f6b9-4548-8e12-54b11f8f07d2, localhost:28240): request = { database: "/Root/TenantSQS" }
2025-10-26 15:13:52,068 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 0f264ae7-f6b9-4548-8e12-54b11f8f07d2, localhost:28240): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-rvn5v36ipy.auto.internal" port: 27058 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 } self_location: "1" } } } }
2025-10-26 15:13:52,069 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/TenantSQS: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-rvn5v36ipy.auto.internal:27058, location , ssl: False>]>
2025-10-26 15:13:52,074 - 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-10-26 15:13:52,095 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28240
2025-10-26 15:13:52,110 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-10-26 15:13:52,111 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7b6ce7f2daf0 state=pending>
2025-10-26 15:13:52,111 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 1). will create a new session.
2025-10-26 15:13:52,112 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:52,112 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:52,113 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 0c0125a6-8599-4f4c-be38-93384eedced1, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:52,113 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 0c0125a6-8599-4f4c-be38-93384eedced1, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-10-26 15:13:53,071 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 0c0125a6-8599-4f4c-be38-93384eedced1, ghrun-rvn5v36ipy.auto.internal:27058): on response callback started
2025-10-26 15:13:53,072 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 0c0125a6-8599-4f4c-be38-93384eedced1, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" } } } }
2025-10-26 15:13:53,073 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:53,073 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:53,078 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, 0c0125a6-8599-4f4c-be38-93384eedced1, ghrun-rvn5v36ipy.auto.internal:27058): on response callback success
2025-10-26 15:13:53,074 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 5273b134-dcc9-463d-b925-05bff190ed40, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:53,081 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 5273b134-dcc9-463d-b925-05bff190ed40, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS//.AtomicCounter" columns { name: "counter_key" type { optional_type { item { type_id: UINT64 } } } } columns { name: "value" type { optional_type { item { type_id: UINT64 } } } } primary_key: "counter_key" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:53,923 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 5273b134-dcc9-463d-b925-05bff190ed40, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:53,924 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteDataQuery, e0cbae28-3958-4b0d-a3d7-17fc68072ba5, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:53,925 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteDataQuery, e0cbae28-3958-4b0d-a3d7-17fc68072ba5, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" tx_control { begin_tx { serializable_read_write { } } commit_tx: true } query { yql_text: "--!syntax_v1\nINSERT INTO `/Root/TenantSQS//.AtomicCounter` (counter_key, value) VALUES (0, 0);" } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:54,043 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteDataQuery, e0cbae28-3958-4b0d-a3d7-17fc68072ba5, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.ExecuteQueryResult] { tx_meta { } } } } }
2025-10-26 15:13:54,046 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 1b92ab23-d130-4a5b-b8f0-f83a7d717779, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,050 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 1b92ab23-d130-4a5b-b8f0-f83a7d717779, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS//.Queues" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueId" type { optional_type { item { type_id: STRING } } } } columns { name: "QueueState" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "DeadLetterQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Partitions" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MasterTabletId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Version" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Tags" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "QueueName" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:54,245 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 1b92ab23-d130-4a5b-b8f0-f83a7d717779, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:54,247 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ff233fcf-eded-48d1-a3fc-40a170b05c57, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,249 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ff233fcf-eded-48d1-a3fc-40a170b05c57, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS//.Events" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "EventType" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "EventTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Labels" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "QueueName" primary_key: "EventType" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:54,355 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ff233fcf-eded-48d1-a3fc-40a170b05c57, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:54,356 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 715ba5d4-d313-46fe-baf3-886b95e8c4e4, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,357 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 715ba5d4-d313-46fe-baf3-886b95e8c4e4, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS//.Settings" columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Name" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Value" type { optional_type { item { type_id: UTF8 } } } } primary_key: "Account" primary_key: "Name" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:54,456 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 715ba5d4-d313-46fe-baf3-886b95e8c4e4, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:54,459 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f59a4d56-f902-41b2-8e15-c604bc131907, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,461 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f59a4d56-f902-41b2-8e15-c604bc131907, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS//.RemovedQueues" columns { name: "RemoveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Account" type { optional_type { item { type_id: UTF8 } } } } columns { name: "QueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "Shards" type { optional_type { item { type_id: UINT32 } } } } columns { name: "CustomQueueName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "FolderId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "TablesFormat" type { optional_type { item { type_id: UINT32 } } } } columns { name: "StartProcessTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "NodeProcess" type { optional_type { item { type_id: UINT32 } } } } primary_key: "RemoveTimestamp" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-10-26 15:13:54,557 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f59a4d56-f902-41b2-8e15-c604bc131907, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:54,559 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 6d4ea428-6a7d-490d-a412-b9f7a0ac3cd0, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,562 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 6d4ea428-6a7d-490d-a412-b9f7a0ac3cd0, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//SentTimestampIdx" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "SentTimestamp" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:54,875 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 6d4ea428-6a7d-490d-a412-b9f7a0ac3cd0, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:54,877 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 0b4147c0-84da-4b80-a497-5c0ffb532acc, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:54,894 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 0b4147c0-84da-4b80-a497-5c0ffb532acc, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//Messages" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:55,342 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 0b4147c0-84da-4b80-a497-5c0ffb532acc, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:55,344 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, a7b89f8a-1753-437f-96fd-ce7242c3fd97, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:55,348 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, a7b89f8a-1753-437f-96fd-ce7242c3fd97, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//State" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "CleanupTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LastModifiedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RetentionBoundary" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "MessageCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "ReadOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "WriteOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupVersion" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyVersion" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "Shard" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:55,734 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, a7b89f8a-1753-437f-96fd-ce7242c3fd97, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:55,737 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ec70bad1-5be6-4fa5-9ccf-14292ea96ebf, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:55,740 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ec70bad1-5be6-4fa5-9ccf-14292ea96ebf, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//Attributes" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ContentBasedDeduplication" type { optional_type { item { type_id: BOOL } } } } columns { name: "DelaySeconds" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "MaximumMessageSize" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageRetentionPeriod" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveMessageWaitTime" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityTimeout" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DlqArn" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MaxReceiveCount" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ShowDetailedCountersDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:56,247 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ec70bad1-5be6-4fa5-9ccf-14292ea96ebf, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:56,249 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 9fb5b894-76e7-4699-917c-9d928fa776eb, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:56,257 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 9fb5b894-76e7-4699-917c-9d928fa776eb, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//SentTimestampIdx" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "SentTimestamp" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:56,566 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 9fb5b894-76e7-4699-917c-9d928fa776eb, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:56,568 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 6e15eba8-d6ad-442d-9f15-8fb416fe4e48, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:56,571 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 6e15eba8-d6ad-442d-9f15-8fb416fe4e48, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Messages" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } columns { name: "NextOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "NextRandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveCount" type { optional_type { item { type_id: UINT32 } } } } columns { name: "FirstReceiveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:56,923 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 6e15eba8-d6ad-442d-9f15-8fb416fe4e48, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:56,925 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, ebedefdb-9daf-4a3d-93f0-3878b1f4284d, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:56,933 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, ebedefdb-9daf-4a3d-93f0-3878b1f4284d, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//State" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CreatedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LastModifiedTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RetentionBoundary" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "MessageCount" type { optional_type { item { type_id: INT64 } } } } columns { name: "ReadOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "WriteOffset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "CleanupVersion" type { optional_type { item { type_id: UINT64 } } } } columns { name: "InflyVersion" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:57,433 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, ebedefdb-9daf-4a3d-93f0-3878b1f4284d, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:57,435 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 3c545ce1-8f61-4fbe-aebe-74621b65244b, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:57,437 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 3c545ce1-8f61-4fbe-aebe-74621b65244b, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Attributes" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ContentBasedDeduplication" type { optional_type { item { type_id: BOOL } } } } columns { name: "DelaySeconds" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FifoQueue" type { optional_type { item { type_id: BOOL } } } } columns { name: "MaximumMessageSize" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageRetentionPeriod" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveMessageWaitTime" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityTimeout" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DlqName" type { optional_type { item { type_id: UTF8 } } } } columns { name: "DlqArn" type { optional_type { item { type_id: UTF8 } } } } columns { name: "MaxReceiveCount" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ShowDetailedCountersDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:57,706 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 3c545ce1-8f61-4fbe-aebe-74621b65244b, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:57,708 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 59fedbeb-cc81-4744-847a-6c6fd81d94d5, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:57,711 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 59fedbeb-cc81-4744-847a-6c6fd81d94d5, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//Infly" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LoadId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "FirstReceiveTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "LockTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveCount" type { optional_type { item { type_id: UINT32 } } } } columns { name: "SentTimestamp" type { optional_type { item { type_id: UINT64 } } } } columns { name: "VisibilityDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DelayDeadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:58,041 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 59fedbeb-cc81-4744-847a-6c6fd81d94d5, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:58,043 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 8e00abf9-5c43-4d70-97ec-b41ae2b580d5, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:58,050 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 8e00abf9-5c43-4d70-97ec-b41ae2b580d5, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.STD//MessageData" columns { name: "QueueIdNumberAndShardHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Shard" type { optional_type { item { type_id: UINT32 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Attributes" type { optional_type { item { type_id: STRING } } } } columns { name: "Data" type { optional_type { item { type_id: STRING } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } columns { name: "SenderId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberAndShardHash" primary_key: "QueueIdNumber" primary_key: "Shard" primary_key: "RandomId" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:58,359 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 8e00abf9-5c43-4d70-97ec-b41ae2b580d5, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:58,360 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, e35c2ac2-46d4-4f70-ab0b-95f7904e1ce2, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:58,362 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, e35c2ac2-46d4-4f70-ab0b-95f7904e1ce2, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Reads" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveAttemptId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "Deadline" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "ReceiveAttemptId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:58,679 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, e35c2ac2-46d4-4f70-ab0b-95f7904e1ce2, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:58,681 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, 29494520-db44-4b69-98b4-7ca026151a36, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:58,683 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, 29494520-db44-4b69-98b4-7ca026151a36, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Groups" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "GroupId" type { optional_type { item { type_id: STRING } } } } columns { name: "VisibilityDeadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Head" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Tail" type { optional_type { item { type_id: UINT64 } } } } columns { name: "ReceiveAttemptId" type { optional_type { item { type_id: UTF8 } } } } columns { name: "LockTimestamp" type { optional_type { item { type_id: UINT64 } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "GroupId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:59,035 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, 29494520-db44-4b69-98b4-7ca026151a36, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:59,037 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, f1c54ba2-07ff-45fb-80b4-5c6601aa706b, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:59,051 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, f1c54ba2-07ff-45fb-80b4-5c6601aa706b, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Deduplication" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "DedupId" type { optional_type { item { type_id: STRING } } } } columns { name: "Deadline" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "DedupId" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:59,412 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, f1c54ba2-07ff-45fb-80b4-5c6601aa706b, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:59,414 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateTable, af1f7526-5898-4b6d-a5d7-56e205138e93, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:59,416 - DEBUG - ydb.connection - _log_request: RpcState(CreateTable, af1f7526-5898-4b6d-a5d7-56e205138e93, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" path: "/Root/TenantSQS/.FIFO//Data" columns { name: "QueueIdNumberHash" type { optional_type { item { type_id: UINT64 } } } } columns { name: "QueueIdNumber" type { optional_type { item { type_id: UINT64 } } } } columns { name: "RandomId" type { optional_type { item { type_id: UINT64 } } } } columns { name: "Offset" type { optional_type { item { type_id: UINT64 } } } } columns { name: "SenderId" type { optional_type { item { type_id: STRING } } } } columns { name: "DedupId" type { optional_type { item { type_id: STRING } } } } columns { name: "Attributes" type { optional_type { item { type_id: STRING } } } } columns { name: "Data" type { optional_type { item { type_id: STRING } } } } columns { name: "MessageId" type { optional_type { item { type_id: STRING } } } } primary_key: "QueueIdNumberHash" primary_key: "QueueIdNumber" primary_key: "RandomId" primary_key: "Offset" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } uniform_partitions: 10 partitioning_settings { partitioning_by_size: ENABLED partitioning_by_load: ENABLED min_partitions_count: 10 } }
2025-10-26 15:13:59,767 - DEBUG - ydb.connection - _log_response: RpcState(CreateTable, af1f7526-5898-4b6d-a5d7-56e205138e93, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:59,768 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:59,769 - DEBUG - ydb.table.SessionPool - stop: Requested session pool stop.
2025-10-26 15:13:59,769 - DEBUG - ydb.table.SessionPool - stop: Session pool is under stop, cancelling all in flight waiters.
2025-10-26 15:13:59,769 - DEBUG - ydb.table.SessionPool - stop: Destroying sessions in active queue
2025-10-26 15:13:59,770 - DEBUG - ydb.table.SessionPool - _destroy: Requested session destroy: <ydb.table.Session object at 0x7b6ce7f2fbb0>, reason: session-pool-terminated
2025-10-26 15:13:59,771 - DEBUG - ydb.table.SessionPool - _destroy: Session <ydb.table.Session object at 0x7b6ce7f2fbb0> is no longer active. Current active count 0.
2025-10-26 15:13:59,771 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 976c84c5-2800-480d-9084-d638b6617ae1, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:13:59,772 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 976c84c5-2800-480d-9084-d638b6617ae1, ghrun-rvn5v36ipy.auto.internal:27058): request = { session_id: "ydb://session/3?node_id=50000&id=ZDgyYmIyODktNTUxMDE0NGMtZjRkNWViYTItMTYzNGQ0ZjU=" operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-10-26 15:13:59,774 - DEBUG - ydb.table.SessionPool - _terminate_event: Terminated session pool.
2025-10-26 15:13:59,791 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 976c84c5-2800-480d-9084-d638b6617ae1, ghrun-rvn5v36ipy.auto.internal:27058): on response callback started
2025-10-26 15:13:59,792 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 976c84c5-2800-480d-9084-d638b6617ae1, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SUCCESS } }
2025-10-26 15:13:59,792 - DEBUG - ydb.connection - _on_response_callback: RpcState(DeleteSession, 976c84c5-2800-480d-9084-d638b6617ae1, ghrun-rvn5v36ipy.auto.internal:27058): on response callback success
2025-10-26 15:13:59,793 - DEBUG - ydb.table.SessionPool - _destroy: Sent delete on session <ydb.table.Session object at 0x7b6ce7f2fbb0>
2025-10-26 15:13:59,793 - DEBUG - ydb.table.SessionPool - stop: Destroyed active sessions
2025-10-26 15:13:59,793 - DEBUG - ydb.topic - close: Close topic client
2025-10-26 15:13:59,794 - DEBUG - ydb.topic - close: Topic client was closed
2025-10-26 15:13:59,795 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28240
2025-10-26 15:13:59,798 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-rvn5v36ipy.auto.internal:27058
2025-10-26 15:13:59,799 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-26 15:13:59,807 - DEBUG - root - setup_method: Test started: test_counters_when_reading_from_empty_queue
2025-10-26 15:13:59,807 - DEBUG - root - setup_method: Kikimr working dir: /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue
2025-10-26 15:13:59,808 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:13:59,808 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/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/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/node_1/logfile_8zkj9775.log --grpc-port=28240 --mon-port=13820 --ic-port=23343 --sqs-port=21574 --module=1
2025-10-26 15:13:59,809 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28240/1
2025-10-26 15:13:59,810 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.9
2025-10-26 15:13:59,811 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.9
2025-10-26 15:13:59,812 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:13:59,821 - DEBUG - ya.test - execute: Command pid: 303386
2025-10-26 15:14:00,964 - DEBUG - ya.test - _save_outputs: Command (pid 303386) rc: 0
2025-10-26 15:14:00,965 - DEBUG - ya.test - _save_outputs: Command (pid 303386) elapsed time (sec): 1.1414291858673096
2025-10-26 15:14:00,965 - DEBUG - ya.test - _save_outputs: Command (pid 303386) idrss: 0
2025-10-26 15:14:00,965 - DEBUG - ya.test - _save_outputs: Command (pid 303386) inblock: 0
2025-10-26 15:14:00,966 - DEBUG - ya.test - _save_outputs: Command (pid 303386) isrss: 0
2025-10-26 15:14:00,966 - DEBUG - ya.test - _save_outputs: Command (pid 303386) ixrss: 0
2025-10-26 15:14:00,966 - DEBUG - ya.test - _save_outputs: Command (pid 303386) majflt: 0
2025-10-26 15:14:00,967 - DEBUG - ya.test - _save_outputs: Command (pid 303386) maxrss: 712932
2025-10-26 15:14:00,967 - DEBUG - ya.test - _save_outputs: Command (pid 303386) minflt: 45104
2025-10-26 15:14:00,967 - DEBUG - ya.test - _save_outputs: Command (pid 303386) msgrcv: 0
2025-10-26 15:14:00,968 - DEBUG - ya.test - _save_outputs: Command (pid 303386) msgsnd: 0
2025-10-26 15:14:00,968 - DEBUG - ya.test - _save_outputs: Command (pid 303386) nivcsw: 174
2025-10-26 15:14:00,968 - DEBUG - ya.test - _save_outputs: Command (pid 303386) nsignals: 0
2025-10-26 15:14:00,969 - DEBUG - ya.test - _save_outputs: Command (pid 303386) nswap: 0
2025-10-26 15:14:00,969 - DEBUG - ya.test - _save_outputs: Command (pid 303386) nvcsw: 14
2025-10-26 15:14:00,969 - DEBUG - ya.test - _save_outputs: Command (pid 303386) oublock: 8
2025-10-26 15:14:00,969 - DEBUG - ya.test - _save_outputs: Command (pid 303386) stime: 0.217608
2025-10-26 15:14:00,978 - DEBUG - ya.test - _save_outputs: Command (pid 303386) utime: 0.574579
2025-10-26 15:14:00,979 - DEBUG - ya.test - _save_outputs: Command (pid 303386) wtime: 1.151
2025-10-26 15:14:00,979 - DEBUG - ya.test - _save_outputs: Command (pid 303386) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-10-26 15:14:00,979 - DEBUG - ya.test - _save_outputs: Command (pid 303386) errors:

2025-10-26 15:14:00,980 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 15:14:00,981 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/kikimr_configs"
2025-10-26 15:14:00,981 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28240 --tenant=/Root/TenantSQS --log-file-name=/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/tests/functional/sqs/cloud/test-results/py3test/testing_out_stuff/chunk37/testing_out_stuff/test_yandex_cloud_queue_counters.py.TestYmqQueueCounters.test_counters_when_reading_from_empty_queue/cluster/slot_1/logfile_qrsnod0b.log --grpc-port=27058 --mon-port=3779 --ic-port=14451 --sqs-port=21608
2025-10-26 15:14:00,981 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:27058/1
2025-10-26 15:14:00,992 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.10
2025-10-26 15:14:00,993 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.10
2025-10-26 15:14:00,994 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/xrv6/0029a5/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-26 15:14:01,006 - DEBUG - ya.test - execute: Command pid: 303592
2025-10-26 15:14:01,962 - DEBUG - ya.test - _save_outputs: Command (pid 303592) rc: 0
2025-10-26 15:14:01,963 - DEBUG - ya.test - _save_outputs: Command (pid 303592) elapsed time (sec): 0.9542171955108643
2025-10-26 15:14:01,963 - DEBUG - ya.test - _save_outputs: Command (pid 303592) idrss: 0
2025-10-26 15:14:01,963 - DEBUG - ya.test - _save_outputs: Command (pid 303592) inblock: 0
2025-10-26 15:14:01,964 - DEBUG - ya.test - _save_outputs: Command (pid 303592) isrss: 0
2025-10-26 15:14:01,964 - DEBUG - ya.test - _save_outputs: Command (pid 303592) ixrss: 0
2025-10-26 15:14:01,965 - DEBUG - ya.test - _save_outputs: Command (pid 303592) majflt: 0
2025-10-26 15:14:01,965 - DEBUG - ya.test - _save_outputs: Command (pid 303592) maxrss: 712996
2025-10-26 15:14:01,965 - DEBUG - ya.test - _save_outputs: Command (pid 303592) minflt: 45228
2025-10-26 15:14:01,970 - DEBUG - ya.test - _save_outputs: Command (pid 303592) msgrcv: 0
2025-10-26 15:14:01,971 - DEBUG - ya.test - _save_outputs: Command (pid 303592) msgsnd: 0
2025-10-26 15:14:01,971 - DEBUG - ya.test - _save_outputs: Command (pid 303592) nivcsw: 197
2025-10-26 15:14:01,971 - DEBUG - ya.test - _save_outputs: Command (pid 303592) nsignals: 0
2025-10-26 15:14:01,972 - DEBUG - ya.test - _save_outputs: Command (pid 303592) nswap: 0
2025-10-26 15:14:01,972 - DEBUG - ya.test - _save_outputs: Command (pid 303592) nvcsw: 13
2025-10-26 15:14:01,972 - DEBUG - ya.test - _save_outputs: Command (pid 303592) oublock: 8
2025-10-26 15:14:01,973 - DEBUG - ya.test - _save_outputs: Command (pid 303592) stime: 0.207165
2025-10-26 15:14:01,973 - DEBUG - ya.test - _save_outputs: Command (pid 303592) utime: 0.577159
2025-10-26 15:14:01,974 - DEBUG - ya.test - _save_outputs: Command (pid 303592) wtime: 0.967
2025-10-26 15:14:01,983 - DEBUG - ya.test - _save_outputs: Command (pid 303592) output:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-rvn5v36ipy
    Host information: 
        Linux ghrun-rvn5v36ipy 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -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-10-26 15:14:01,983 - DEBUG - ya.test - _save_outputs: Command (pid 303592) errors:

2025-10-26 15:14:01,984 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: b7d1a9635f8869090656181700e74e7e44ded2ba
    Branch: 
    Author: Oleg Doronin <dorooleg@yandex.ru>
    Summary: Merge 7c6978e1f9b65bcf1be18e00bef32e442225a050 into fd2cb7bd7d7256158095d1e0698510bf6e71ed0f
2025-10-26 15:14:01,999 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:3779
2025-10-26 15:14:02,013 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:3779 "GET /tablets/app?TabletID=72057594037968897&node=1&page=SetDown&down=0 HTTP/1.1" 200 33
2025-10-26 15:14:02,015 - DEBUG - root - _enable_tablets_on_node: Toggle up reply: {"NodeId":1,"Down":false}
2025-10-26 15:14:02,022 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Listing SQS users
2025-10-26 15:14:02,024 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:21608 from user U_counters_when_reading_from_empty_queue_677a1bc8-b27e-11f0-92e7-d00d1ea017b5 with params: Action=ListQueues
2025-10-26 15:14:02,027 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:21608
2025-10-26 15:14:02,084 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:21608 "POST / HTTP/1.1" 400 278
2025-10-26 15:14:02,103 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:02,104 - 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: d8932198-b963358a-e8c0b87-d493317a.</Message><Code>IncompleteSignature</Code></Error><RequestId></RequestId></ErrorResponse>
'
2025-10-26 15:14:02,105 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:02,107 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:02,107 - INFO - ydb.tests.library.sqs.test_base - wait_can_list_users: Success. Api is up.
2025-10-26 15:14:02,111 - 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-10-26 15:14:02,115 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-26 15:14:02,116 - 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-10-26 15:14:02,162 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/TenantSQS
2025-10-26 15:14:02,163 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 48a10a00-06f4-479d-b01e-9f80706c8c27, localhost:27058): creating call state
2025-10-26 15:14:02,163 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 48a10a00-06f4-479d-b01e-9f80706c8c27, localhost:27058): request = { database: "/Root/TenantSQS" }
2025-10-26 15:14:02,176 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 48a10a00-06f4-479d-b01e-9f80706c8c27, localhost:27058): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-rvn5v36ipy.auto.internal" port: 27058 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-10-26 15:14:02,177 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/TenantSQS: DiscoveryResult <self_location: , endpoints [<Endpoint ghrun-rvn5v36ipy.auto.internal:27058, location , ssl: False>]>
2025-10-26 15:14:02,179 - 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-10-26 15:14:02,212 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:27058
2025-10-26 15:14:02,214 - INFO - root - _before_test_start: run test with cloud_id=CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5 folder_id=folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5
2025-10-26 15:14:02,216 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_yandex_cloud_queue_counters.py::TestYmqQueueCounters, test_name: test_counters_when_reading_from_empty_queue)
2025-10-26 15:14:02,217 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:21608/private from user CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5 with params: QueueName=Q_counters_when_reading_from_empty_queue_677a20fa-b27e-11f0-a7da-d00d1ea017&Action=CreateQueue&folderId=folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5
2025-10-26 15:14:02,222 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:21608
2025-10-26 15:14:02,684 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:21608 "POST /private HTTP/1.1" 200 436
2025-10-26 15:14:02,708 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:02,709 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<CreateQueueResponse><CreateQueueResult><QueueUrl>http://ghrun-rvn5v36ipy.auto.internal:21608/CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5/000000000000000101ii/Q_counters_when_reading_from_empty_queue_677a20fa-b27e-11f0-a7da-d00d1ea017</QueueUrl></CreateQueueResult><ResponseMetadata><RequestId>a30f7bef-810fcabc-430de449-a2fc1bc1</RequestId></ResponseMetadata></CreateQueueResponse>

2025-10-26 15:14:02,710 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:02,712 - DEBUG - ydb.tests.library.sqs.requests_client - execute_request: Execute request POST http://localhost:21608/private from user CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5 with params: QueueUrl=http%3A%2F%2Fghrun-rvn5v36ipy.auto.internal%3A21608%2FCLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5%2F000000000000000101ii%2FQ_counters_when_reading_from_empty_queue_677a20fa-b27e-11f0-a7da-d00d1ea017&MaxNumberOfMessages=1&WaitTimeSeconds=1&Action=ReceiveMessage&folderId=folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5
2025-10-26 15:14:03,735 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:21608 "POST /private HTTP/1.1" 200 207
2025-10-26 15:14:03,821 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:03,826 - DEBUG - root - _process_response: Parsing response: <?xml version="1.0" encoding="UTF-8"?>
<ReceiveMessageResponse><ReceiveMessageResult/><ResponseMetadata><RequestId>29e45432-4eb3cf64-dae04126-b4dc9247</RequestId></ResponseMetadata></ReceiveMessageResponse>

2025-10-26 15:14:03,828 - DEBUG - charset_normalizer - from_bytes: Encoding detection: utf_8 is most likely the one.
2025-10-26 15:14:03,829 - ERROR - ydb.tests.library.sqs.requests_client - _process_response: Could not process response from SQS: {'ReceiveMessageResponse': {'ReceiveMessageResult': None, 'ResponseMetadata': {'RequestId': '29e45432-4eb3cf64-dae04126-b4dc9247'}}}. <class 'TypeError'>: 'NoneType' object is not subscriptable
2025-10-26 15:14:03,837 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:3779
2025-10-26 15:14:03,846 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:3779 "GET /counters/counters%3Dymq_public/cloud%3DCLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5/folder%3Dfolder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5/json HTTP/1.1" 200 560
2025-10-26 15:14:03,853 - DEBUG - root - _get_counters: Got counters from node 0:
{
  "sensors": [
    {
      "kind": "GAUGE",
      "labels": {
        "name": "queue.total_count"
      },
      "value": 1
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "delete_message",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "delete_message",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "delete_message",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "delete_message_batch",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "delete_message_batch",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "delete_message_batch",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "get_queue_attributes",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "get_queue_attributes",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "get_queue_attributes",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "get_queue_url",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "get_queue_url",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "get_queue_url",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "list_queue_tags",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "list_queue_tags",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "list_queue_tags",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "purge_queue",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "purge_queue",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "purge_queue",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "receive_message",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          1
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "receive_message",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "receive_message",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 1
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "send_message",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "send_message",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "send_message",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "send_message_batch",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "send_message_batch",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "send_message_batch",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "set_queue_attributes",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "set_queue_attributes",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "set_queue_attributes",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "tag_queue",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "tag_queue",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "tag_queue",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "untag_queue",
        "name": "api.http.errors_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "hist": {
        "bounds": [
          5,
          10,
          25,
          50,
          75,
          100,
          150,
          300,
          500,
          1000,
          5000
        ],
        "buckets": [
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0,
          0
        ],
        "inf": 0
      },
      "kind": "HIST_RATE",
      "labels": {
        "method": "untag_queue",
        "name": "api.http.request_duration_milliseconds",
        "queue": "000000000000000101ii"
      }
    },
    {
      "kind": "RATE",
      "labels": {
        "method": "untag_queue",
        "name": "api.http.requests_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.deduplicated_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.deleted_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.empty_receive_attempts_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 1
    },
    {
      "kind": "GAUGE",
      "labels": {
        "name": "queue.messages.inflight_count",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "GAUGE",
      "labels": {
        "name": "queue.messages.oldest_age_milliseconds",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.purged_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.received_bytes_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.received_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.request_timeouts_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.sent_bytes_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "RATE",
      "labels": {
        "name": "queue.messages.sent_count_per_second",
        "queue": "000000000000000101ii"
      },
      "value": 0
    },
    {
      "kind": "GAUGE",
      "labels": {
        "name": "queue.messages.stored_count",
        "queue": "000000000000000101ii"
      },
      "value": 0
    }
  ]
}
2025-10-26 15:14:03,854 - DEBUG - root - _get_counter: Searching for counter with labels:
{
  "name": "queue.messages.empty_receive_attempts_count_per_second",
  "queue": "000000000000000101ii"
}
2025-10-26 15:14:03,854 - DEBUG - root - _get_counter: Return counter:
{
  "kind": "RATE",
  "labels": {
    "name": "queue.messages.empty_receive_attempts_count_per_second",
    "queue": "000000000000000101ii"
  },
  "value": 1
}
2025-10-26 15:14:03,856 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 15:14:03,857 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, e81b35eb-fedb-4ed8-8a0f-b1a286788552, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,858 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, e81b35eb-fedb-4ed8-8a0f-b1a286788552, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS" }
2025-10-26 15:14:03,877 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, e81b35eb-fedb-4ed8-8a0f-b1a286788552, ghrun-rvn5v36ipy.auto.internal:27058): 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: 584 created_at { tx_id: 1 } } children { name: ".AtomicCounter" owner: "root@builtin" type: TABLE created_at { plan_step: 1761491633850 tx_id: 281474976720660 } } children { name: ".Events" owner: "root@builtin" type: TABLE created_at { plan_step: 1761491634370 tx_id: 281474976720666 } } children { name: ".FIFO" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761491636550 tx_id: 281474976720676 } } children { name: ".Queues" owner: "root@builtin" type: TABLE created_at { plan_step: 1761491634250 tx_id: 281474976720665 } } children { name: ".RemovedQueues" owner: "root@builtin" type: TABLE created_at { plan_step: 1761491634580 tx_id: 281474976720669 } } children { name: ".STD" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761491634820 tx_id: 281474976720670 } } children { name: ".Settings" owner: "root@builtin" type: TABLE created_at { plan_step: 1761491634470 tx_id: 281474976720668 } } children { name: ".metadata" owner: "metadata@system" type: DIRECTORY created_at { plan_step: 1761491633140 tx_id: 281474976720658 } } children { name: "CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5" owner: "root@builtin" type: DIRECTORY created_at { plan_step: 1761491642320 tx_id: 281474976720691 } } children { name: ".sys" type: DIRECTORY created_at { } } } } } }
2025-10-26 15:14:03,880 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 692aa313-e68e-4dc3-9e68-ea7a3159551c, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,880 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 692aa313-e68e-4dc3-9e68-ea7a3159551c, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.Events/Queues" }
2025-10-26 15:14:03,894 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 692aa313-e68e-4dc3-9e68-ea7a3159551c, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,899 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,900 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 33f5c0ea-43c8-493f-8e65-5bbc1035082c, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,901 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 33f5c0ea-43c8-493f-8e65-5bbc1035082c, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.FIFO/Queues" }
2025-10-26 15:14:03,912 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 33f5c0ea-43c8-493f-8e65-5bbc1035082c, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,913 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,913 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 1594f10c-85f8-4621-ac17-412fbf2dd222, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,914 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 1594f10c-85f8-4621-ac17-412fbf2dd222, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.RemovedQueues/Queues" }
2025-10-26 15:14:03,931 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 1594f10c-85f8-4621-ac17-412fbf2dd222, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,932 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,933 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, be7e1a16-9372-40b2-8cbf-67cc94dcd3da, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,933 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, be7e1a16-9372-40b2-8cbf-67cc94dcd3da, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.STD/Queues" }
2025-10-26 15:14:03,943 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, be7e1a16-9372-40b2-8cbf-67cc94dcd3da, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,944 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,945 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 6daed7c5-4ae7-47b5-aef1-d25088b74e54, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,951 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 6daed7c5-4ae7-47b5-aef1-d25088b74e54, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.metadata/Queues" }
2025-10-26 15:14:03,975 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 6daed7c5-4ae7-47b5-aef1-d25088b74e54, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,976 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,977 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, a59af3e4-5c53-4c58-8b32-5fe770ab30c6, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:03,977 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, a59af3e4-5c53-4c58-8b32-5fe770ab30c6, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5/Queues" }
2025-10-26 15:14:03,997 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, a59af3e4-5c53-4c58-8b32-5fe770ab30c6, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:03,998 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:03,999 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 04c024c7-1c36-410b-9cb6-ca0af2a63b49, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:04,000 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 04c024c7-1c36-410b-9cb6-ca0af2a63b49, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/.sys/Queues" }
2025-10-26 15:14:04,022 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 04c024c7-1c36-410b-9cb6-ca0af2a63b49, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:04,023 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:04,024 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 7b931451-862f-4699-bc64-efdbfecca018, ghrun-rvn5v36ipy.auto.internal:27058): creating call state
2025-10-26 15:14:04,025 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 7b931451-862f-4699-bc64-efdbfecca018, ghrun-rvn5v36ipy.auto.internal:27058): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/Root/TenantSQS/CLOUD_FOR_folder_acc_67984fa2-b27e-11f0-8b84-d00d1ea017b5/Queues" }
2025-10-26 15:14:04,047 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 7b931451-862f-4699-bc64-efdbfecca018, ghrun-rvn5v36ipy.auto.internal:27058): response = { operation { ready: true status: SCHEME_ERROR issues { message: "Path not found" severity: 1 } } }
2025-10-26 15:14:04,048 - DEBUG - ydb.tests.library.sqs.test_base - check_no_queues_table: No queue table: message: "Path not found" severity: 1 (server_code: 400070)
2025-10-26 15:14:04,048 - DEBUG - ydb.topic - close: Close topic client
2025-10-26 15:14:04,048 - DEBUG - ydb.topic - close: Topic client was closed
2025-10-26 15:14:04,049 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:27058
2025-10-26 15:14:04,050 - DEBUG - ydb.connection - close: Closing channel for endpoint ghrun-rvn5v36ipy.auto.internal:27058
2025-10-26 15:14:04,052 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-10-26 15:14:04,058 - DEBUG - root - teardown_method: Test finished: test_counters_when_reading_from_empty_queue
2025-10-26 15:14:11,078 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:27058/1
2025-10-26 15:14:21,086 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:28240/1
2025-10-26 15:14:21,090 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21608
2025-10-26 15:14:21,090 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/9927
2025-10-26 15:14:21,091 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6435
2025-10-26 15:14:21,091 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/14451
2025-10-26 15:14:21,091 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/3779
2025-10-26 15:14:21,092 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27058
2025-10-26 15:14:21,092 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/21574
2025-10-26 15:14:21,092 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/6948
2025-10-26 15:14:21,093 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/27231
2025-10-26 15:14:21,093 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/13820
2025-10-26 15:14:21,094 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28240
2025-10-26 15:14:21,094 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/23343
