2025-10-26T18:38:46.961046Z :MEMORY_PROFILER NOTICE: Bootstrapped
2025-10-26T18:38:46.971171Z :BLOB_CACHE NOTICE: MaxCacheDataSize: 1048576000 InFlightDataSize: 0
2025-10-26T18:38:46.993200Z :BS_PROXY NOTICE: EnsureMonitoring Group# 0 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T18:38:46.994545Z :GRPC_SERVER DEBUG: [0x61a00004a480] created request Name# Legacy/SchemeOperation
2025-10-26T18:38:46.994723Z :BS_PROXY NOTICE: Group# 4294967295 HasInvalidGroupId# 1 Bootstrap -> StateEjected Marker# DSP42
2025-10-26T18:38:46.995227Z :GRPC_SERVER DEBUG: [0x61a00004aa80] created request Name# Legacy/SchemeOperationStatus
2025-10-26T18:38:46.995967Z :GRPC_SERVER DEBUG: [0x61a00004b080] created request Name# Legacy/SchemeDescribe
2025-10-26T18:38:46.996596Z :GRPC_SERVER DEBUG: [0x61a00004b680] created request Name# Legacy/ChooseProxy
2025-10-26T18:38:46.997119Z :GRPC_SERVER DEBUG: [0x61a00004bc80] created request Name# Legacy/PersQueueRequest
2025-10-26T18:38:46.997785Z :GRPC_SERVER DEBUG: [0x61a00004c280] created request Name# Legacy/SchemeInitRoot
2025-10-26T18:38:46.998335Z :GRPC_SERVER DEBUG: [0x61a00004c880] created request Name# Legacy/ResolveNode
2025-10-26T18:38:46.998960Z :GRPC_SERVER DEBUG: [0x61a00004ce80] created request Name# Legacy/FillNode
2025-10-26T18:38:46.999492Z :GRPC_SERVER DEBUG: [0x61a00004d480] created request Name# Legacy/DrainNode
2025-10-26T18:38:46.999969Z :GRPC_SERVER DEBUG: [0x61a00004da80] created request Name# Legacy/BlobStorageConfig
2025-10-26T18:38:47.000641Z :GRPC_SERVER DEBUG: [0x61a00004e080] created request Name# Legacy/HiveCreateTablet
2025-10-26T18:38:47.001323Z :GRPC_SERVER DEBUG: [0x61a00004e680] created request Name# Legacy/TestShardControl
2025-10-26T18:38:47.002018Z :GRPC_SERVER DEBUG: [0x61a00004ec80] created request Name# Legacy/RegisterNode
2025-10-26T18:38:47.002662Z :GRPC_SERVER DEBUG: [0x61a00004f280] created request Name# Legacy/CmsRequest
2025-10-26T18:38:47.003399Z :GRPC_SERVER DEBUG: [0x61a000090080] created request Name# Legacy/ConsoleRequest
2025-10-26T18:38:47.003949Z :GRPC_SERVER DEBUG: [0x61a000090680] created request Name# Legacy/InterconnectDebug
2025-10-26T18:38:47.004507Z :GRPC_SERVER DEBUG: [0x61a000090c80] created request Name# Legacy/TabletStateRequest
2025-10-26T18:38:47.005058Z :GRPC_SERVER DEBUG: [0x61a000091280] created request Name# Legacy/LocalSchemeTx
2025-10-26T18:38:47.005732Z :GRPC_SERVER DEBUG: [0x61a000091880] created request Name# Legacy/LocalEnumerateTablets
2025-10-26T18:38:47.006579Z :GRPC_SERVER DEBUG: [0x61a000091e80] created request Name# Legacy/TabletKillRequest
2025-10-26T18:38:47.007163Z :GRPC_SERVER DEBUG: [0x61a000092480] created request Name# CreateSession
2025-10-26T18:38:47.007508Z :GRPC_SERVER DEBUG: [0x61a000092a80] created request Name# CreateSession
2025-10-26T18:38:47.007819Z :GRPC_SERVER DEBUG: [0x61a000093080] created request Name# CreateSession
2025-10-26T18:38:47.008076Z :GRPC_SERVER DEBUG: [0x61a000093680] created request Name# CreateSession
2025-10-26T18:38:47.008376Z :GRPC_SERVER DEBUG: [0x61a000093c80] created request Name# CreateSession
2025-10-26T18:38:47.008687Z :GRPC_SERVER DEBUG: [0x61a000094280] created request Name# CreateSession
2025-10-26T18:38:47.008959Z :GRPC_SERVER DEBUG: [0x61a000094880] created request Name# CreateSession
2025-10-26T18:38:47.009167Z :GRPC_SERVER DEBUG: [0x61a000094e80] created request Name# CreateSession
2025-10-26T18:38:47.009436Z :GRPC_SERVER DEBUG: [0x61a000095480] created request Name# CreateSession
2025-10-26T18:38:47.009542Z :INTERCONNECT WARN: Handshake [50000:7565601761947656383:10] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-10-26T18:38:47.009825Z :GRPC_SERVER DEBUG: [0x61a000095a80] created request Name# CreateSession
2025-10-26T18:38:47.010253Z :GRPC_SERVER DEBUG: [0x61a000096080] created request Name# CreateSession
2025-10-26T18:38:47.010523Z :GRPC_SERVER DEBUG: [0x61a000096680] created request Name# CreateSession
2025-10-26T18:38:47.010908Z :GRPC_SERVER DEBUG: [0x61a000096c80] created request Name# CreateSession
2025-10-26T18:38:47.011123Z :GRPC_SERVER DEBUG: [0x61a000097280] created request Name# CreateSession
2025-10-26T18:38:47.011361Z :GRPC_SERVER DEBUG: [0x61a000097880] created request Name# CreateSession
2025-10-26T18:38:47.011643Z :GRPC_SERVER DEBUG: [0x61a000097e80] created request Name# CreateSession
2025-10-26T18:38:47.011943Z :GRPC_SERVER DEBUG: [0x61a000098480] created request Name# CreateSession
2025-10-26T18:38:47.012173Z :GRPC_SERVER DEBUG: [0x61a000098a80] created request Name# CreateSession
2025-10-26T18:38:47.012509Z :GRPC_SERVER DEBUG: [0x61a000099080] created request Name# CreateSession
2025-10-26T18:38:47.012748Z :GRPC_SERVER DEBUG: [0x61a000099680] created request Name# CreateSession
2025-10-26T18:38:47.013388Z :GRPC_SERVER DEBUG: [0x61a000099c80] created request Name# KeepAlive
2025-10-26T18:38:47.013713Z :GRPC_SERVER DEBUG: [0x61a00009a280] created request Name# KeepAlive
2025-10-26T18:38:47.013995Z :GRPC_SERVER DEBUG: [0x61a00009a880] created request Name# KeepAlive
2025-10-26T18:38:47.014267Z :GRPC_SERVER DEBUG: [0x61a00009ae80] created request Name# KeepAlive
2025-10-26T18:38:47.014522Z :GRPC_SERVER DEBUG: [0x61a00009b480] created request Name# KeepAlive
2025-10-26T18:38:47.014833Z :GRPC_SERVER DEBUG: [0x61a00009ba80] created request Name# KeepAlive
2025-10-26T18:38:47.015134Z :GRPC_SERVER DEBUG: [0x61a00009c080] created request Name# KeepAlive
2025-10-26T18:38:47.015356Z :GRPC_SERVER DEBUG: [0x61a00009c680] created request Name# KeepAlive
2025-10-26T18:38:47.015623Z :GRPC_SERVER DEBUG: [0x61a00009cc80] created request Name# KeepAlive
2025-10-26T18:38:47.015851Z :GRPC_SERVER DEBUG: [0x61a00009d280] created request Name# KeepAlive
2025-10-26T18:38:47.016106Z :GRPC_SERVER DEBUG: [0x61a00009d880] created request Name# KeepAlive
2025-10-26T18:38:47.016511Z :GRPC_SERVER DEBUG: [0x61a00009de80] created request Name# KeepAlive
2025-10-26T18:38:47.016747Z :GRPC_SERVER DEBUG: [0x61a00009e480] created request Name# KeepAlive
2025-10-26T18:38:47.016998Z :GRPC_SERVER DEBUG: [0x61a00009ea80] created request Name# KeepAlive
2025-10-26T18:38:47.017216Z :GRPC_SERVER DEBUG: [0x61a00009f080] created request Name# KeepAlive
2025-10-26T18:38:47.017457Z :GRPC_SERVER DEBUG: [0x61a00009f680] created request Name# KeepAlive
2025-10-26T18:38:47.017557Z :TENANT_POOL NOTICE: TDomainTenantPool(Root) started tenant /Root/test_auditlog.py
2025-10-26T18:38:47.018012Z :GRPC_SERVER DEBUG: [0x61a0000afe80] created request Name# KeepAlive
2025-10-26T18:38:47.018346Z :GRPC_SERVER DEBUG: [0x61a0000b0480] created request Name# KeepAlive
2025-10-26T18:38:47.018590Z :GRPC_SERVER DEBUG: [0x61a0000b0a80] created request Name# KeepAlive
2025-10-26T18:38:47.018856Z :GRPC_SERVER DEBUG: [0x61a0000b1080] created request Name# KeepAlive
2025-10-26T18:38:47.019260Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Set up state: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.019471Z :GRPC_SERVER DEBUG: [0x61a0000b1680] created request Name# AlterTable
2025-10-26T18:38:47.019871Z :GRPC_SERVER DEBUG: [0x61a0000b1c80] created request Name# AlterTable
2025-10-26T18:38:47.020117Z :GRPC_SERVER DEBUG: [0x61a0000b2280] created request Name# AlterTable
2025-10-26T18:38:47.020431Z :GRPC_SERVER DEBUG: [0x61a0000b2880] created request Name# AlterTable
2025-10-26T18:38:47.020667Z :GRPC_SERVER DEBUG: [0x61a0000b2e80] created request Name# AlterTable
2025-10-26T18:38:47.020874Z :GRPC_SERVER DEBUG: [0x61a0000b3480] created request Name# AlterTable
2025-10-26T18:38:47.021134Z :GRPC_SERVER DEBUG: [0x61a0000b3a80] created request Name# AlterTable
2025-10-26T18:38:47.021417Z :GRPC_SERVER DEBUG: [0x61a0000b4080] created request Name# AlterTable
2025-10-26T18:38:47.021729Z :GRPC_SERVER DEBUG: [0x61a0000b4680] created request Name# AlterTable
2025-10-26T18:38:47.022092Z :GRPC_SERVER DEBUG: [0x61a0000b4c80] created request Name# AlterTable
2025-10-26T18:38:47.022400Z :GRPC_SERVER DEBUG: [0x61a0000b5280] created request Name# AlterTable
2025-10-26T18:38:47.022708Z :GRPC_SERVER DEBUG: [0x61a0000b5880] created request Name# AlterTable
2025-10-26T18:38:47.022962Z :GRPC_SERVER DEBUG: [0x61a0000b5e80] created request Name# AlterTable
2025-10-26T18:38:47.023227Z :GRPC_SERVER DEBUG: [0x61a0000b6480] created request Name# AlterTable
2025-10-26T18:38:47.023468Z :GRPC_SERVER DEBUG: [0x61a0000b6a80] created request Name# AlterTable
2025-10-26T18:38:47.023917Z :GRPC_SERVER DEBUG: [0x61a0000b7080] created request Name# AlterTable
2025-10-26T18:38:47.024276Z :GRPC_SERVER DEBUG: [0x61a0000b7680] created request Name# AlterTable
2025-10-26T18:38:47.024573Z :GRPC_SERVER DEBUG: [0x61a0000b7c80] created request Name# AlterTable
2025-10-26T18:38:47.024812Z :GRPC_SERVER DEBUG: [0x61a0000b8280] created request Name# AlterTable
2025-10-26T18:38:47.025112Z :GRPC_SERVER DEBUG: [0x61a0000b8880] created request Name# AlterTable
2025-10-26T18:38:47.025767Z :GRPC_SERVER DEBUG: [0x61a0000b8e80] created request Name# CreateTable
2025-10-26T18:38:47.026162Z :GRPC_SERVER DEBUG: [0x61a0000b9480] created request Name# CreateTable
2025-10-26T18:38:47.026471Z :GRPC_SERVER DEBUG: [0x61a0000b9a80] created request Name# CreateTable
2025-10-26T18:38:47.026819Z :GRPC_SERVER DEBUG: [0x61a0000ba080] created request Name# CreateTable
2025-10-26T18:38:47.027336Z :GRPC_SERVER DEBUG: [0x61a0000ba680] created request Name# CreateTable
2025-10-26T18:38:47.027699Z :GRPC_SERVER DEBUG: [0x61a0000bac80] created request Name# CreateTable
2025-10-26T18:38:47.027986Z :GRPC_SERVER DEBUG: [0x61a0000bb280] created request Name# CreateTable
2025-10-26T18:38:47.028227Z :GRPC_SERVER DEBUG: [0x61a0000bb880] created request Name# CreateTable
2025-10-26T18:38:47.028574Z :GRPC_SERVER DEBUG: [0x61a0000bbe80] created request Name# CreateTable
2025-10-26T18:38:47.028835Z :GRPC_SERVER DEBUG: [0x61a0000bc480] created request Name# CreateTable
2025-10-26T18:38:47.029210Z :GRPC_SERVER DEBUG: [0x61a0000bca80] created request Name# CreateTable
2025-10-26T18:38:47.029491Z :GRPC_SERVER DEBUG: [0x61a0000bd080] created request Name# CreateTable
2025-10-26T18:38:47.029763Z :GRPC_SERVER DEBUG: [0x61a0000bd680] created request Name# CreateTable
2025-10-26T18:38:47.030000Z :GRPC_SERVER DEBUG: [0x61a0000bdc80] created request Name# CreateTable
2025-10-26T18:38:47.030261Z :GRPC_SERVER DEBUG: [0x61a0000be280] created request Name# CreateTable
2025-10-26T18:38:47.030469Z :GRPC_SERVER DEBUG: [0x61a0000be880] created request Name# CreateTable
2025-10-26T18:38:47.030775Z :GRPC_SERVER DEBUG: [0x61a0000bee80] created request Name# CreateTable
2025-10-26T18:38:47.031025Z :GRPC_SERVER DEBUG: [0x61a0000bf480] created request Name# CreateTable
2025-10-26T18:38:47.031263Z :GRPC_SERVER DEBUG: [0x61a0000bfa80] created request Name# CreateTable
2025-10-26T18:38:47.031501Z :GRPC_SERVER DEBUG: [0x61a0000af880] created request Name# CreateTable
2025-10-26T18:38:47.032040Z :GRPC_SERVER DEBUG: [0x61a00008fa80] created request Name# DropTable
2025-10-26T18:38:47.032360Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 50000, serve as dynamic node
2025-10-26T18:38:47.032391Z :GRPC_SERVER DEBUG: [0x61a00007f880] created request Name# DropTable
2025-10-26T18:38:47.032692Z :GRPC_SERVER DEBUG: [0x61a00005fa80] created request Name# DropTable
2025-10-26T18:38:47.032901Z :GRPC_SERVER DEBUG: Subscribe to /Root
2025-10-26T18:38:47.032939Z :GRPC_SERVER DEBUG: [0x61a00004f880] created request Name# DropTable
2025-10-26T18:38:47.032957Z :GRPC_SERVER DEBUG: Subscribe to /Root/test_auditlog.py
2025-10-26T18:38:47.033160Z :GRPC_SERVER DEBUG: [0x61a000012c80] created request Name# DropTable
2025-10-26T18:38:47.033395Z :GRPC_SERVER DEBUG: [0x61a000013280] created request Name# DropTable
2025-10-26T18:38:47.033632Z :GRPC_SERVER DEBUG: [0x61a000013880] created request Name# DropTable
2025-10-26T18:38:47.033656Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T18:38:47.033978Z :GRPC_SERVER DEBUG: [0x61a000013e80] created request Name# DropTable
2025-10-26T18:38:47.034222Z :GRPC_SERVER DEBUG: [0x61a000014480] created request Name# DropTable
2025-10-26T18:38:47.034493Z :GRPC_SERVER DEBUG: [0x61a000014a80] created request Name# DropTable
2025-10-26T18:38:47.034739Z :GRPC_SERVER DEBUG: [0x61a000015080] created request Name# DropTable
2025-10-26T18:38:47.035041Z :GRPC_SERVER DEBUG: [0x61a000015680] created request Name# DropTable
2025-10-26T18:38:47.035265Z :GRPC_SERVER DEBUG: [0x61a000015c80] created request Name# DropTable
2025-10-26T18:38:47.035504Z :GRPC_SERVER DEBUG: [0x61a000016280] created request Name# DropTable
2025-10-26T18:38:47.035736Z :GRPC_SERVER DEBUG: [0x61a000016880] created request Name# DropTable
2025-10-26T18:38:47.035825Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Isrt;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.2;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T18:38:47.035970Z :GRPC_SERVER DEBUG: [0x61a000016e80] created request Name# DropTable
2025-10-26T18:38:47.036012Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 50000, serve as dynamic node
2025-10-26T18:38:47.036169Z :GRPC_SERVER DEBUG: Subscribe to /Root
2025-10-26T18:38:47.036206Z :GRPC_SERVER DEBUG: Subscribe to /Root/test_auditlog.py
2025-10-26T18:38:47.036231Z :GRPC_SERVER DEBUG: [0x61a000017480] created request Name# DropTable
2025-10-26T18:38:47.036486Z :GRPC_SERVER DEBUG: [0x61a000017a80] created request Name# DropTable
2025-10-26T18:38:47.036727Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Comp;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.33;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T18:38:47.036741Z :GRPC_SERVER DEBUG: [0x61a000018080] created request Name# DropTable
2025-10-26T18:38:47.036981Z :PGWIRE ERROR: Failed to bind [::]:5432. Error: Address already in use
2025-10-26T18:38:47.037065Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Scan;action=conveyor_registered;config=QueueSizeLimit=262144;Enabled=1;;
2025-10-26T18:38:47.037188Z :GRPC_SERVER DEBUG: [0x61a000018680] created request Name# DropTable
2025-10-26T18:38:47.037924Z :GRPC_SERVER DEBUG: [0x61a000018c80] created request Name# DescribeTable
2025-10-26T18:38:47.038338Z :GRPC_SERVER DEBUG: [0x61a000019280] created request Name# DescribeTable
2025-10-26T18:38:47.038634Z :GRPC_SERVER DEBUG: [0x61a000019880] created request Name# DescribeTable
2025-10-26T18:38:47.038947Z :GRPC_SERVER DEBUG: [0x61a000019e80] created request Name# DescribeTable
2025-10-26T18:38:47.039121Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 Marker# DSP57 initialize full monitoring
2025-10-26T18:38:47.039373Z :GRPC_SERVER DEBUG: [0x61a00001a480] created request Name# DescribeTable
2025-10-26T18:38:47.039621Z :GRPC_SERVER DEBUG: [0x61a00001aa80] created request Name# DescribeTable
2025-10-26T18:38:47.039895Z :GRPC_SERVER DEBUG: Got proxy service configuration
2025-10-26T18:38:47.039929Z :GRPC_SERVER INFO: Subscribed for config changes
2025-10-26T18:38:47.039971Z :GRPC_SERVER DEBUG: [0x61a00001b080] created request Name# DescribeTable
2025-10-26T18:38:47.040213Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Set up state: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.040264Z :GRPC_SERVER DEBUG: [0x61a00001b680] created request Name# DescribeTable
2025-10-26T18:38:47.040526Z :GRPC_SERVER DEBUG: Got proxy service configuration
2025-10-26T18:38:47.040556Z :GRPC_SERVER INFO: Subscribed for config changes
2025-10-26T18:38:47.040582Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:47.040628Z :GRPC_SERVER DEBUG: [0x61a00001bc80] created request Name# DescribeTable
2025-10-26T18:38:47.040637Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656446:4147][/Root] Set up state: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.040672Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:47.040806Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root
2025-10-26T18:38:47.040931Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root - no SecurityState
2025-10-26T18:38:47.040969Z :GRPC_SERVER DEBUG: [0x61a00001c280] created request Name# DescribeTable
2025-10-26T18:38:47.041093Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Set up state: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.041108Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656454:4151][/Root] Set up state: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.041175Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:47.041268Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:47.041298Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root
2025-10-26T18:38:47.041311Z :GRPC_SERVER DEBUG: [0x61a00001c880] created request Name# DescribeTable
2025-10-26T18:38:47.041359Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root - no SecurityState
2025-10-26T18:38:47.041581Z :GRPC_SERVER DEBUG: [0x61a00001ce80] created request Name# DescribeTable
2025-10-26T18:38:47.041861Z :GRPC_SERVER DEBUG: [0x61a00001d480] created request Name# DescribeTable
2025-10-26T18:38:47.041922Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.042161Z :GRPC_SERVER DEBUG: [0x61a00001da80] created request Name# DescribeTable
2025-10-26T18:38:47.042546Z :GRPC_SERVER DEBUG: [0x61a00001e080] created request Name# DescribeTable
2025-10-26T18:38:47.042777Z :GRPC_SERVER DEBUG: [0x61a00001e680] created request Name# DescribeTable
2025-10-26T18:38:47.043015Z :GRPC_SERVER DEBUG: [0x61a00001ec80] created request Name# DescribeTable
2025-10-26T18:38:47.043303Z :GRPC_SERVER DEBUG: [0x61a00001f280] created request Name# DescribeTable
2025-10-26T18:38:47.043520Z :GRPC_SERVER DEBUG: [0x61a00002fa80] created request Name# DescribeTable
2025-10-26T18:38:47.043814Z :GRPC_SERVER DEBUG: [0x61a00001f880] created request Name# DescribeTable
2025-10-26T18:38:47.044366Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656513:4141][/Root/test_auditlog.py/.metadata/cs_index/external] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.044368Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656512:4180][/Root/test_auditlog.py/.metadata/initialization/migrations] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.044538Z :GRPC_SERVER DEBUG: [0x61a0000cfc80] created request Name# CopyTable
2025-10-26T18:38:47.044884Z :GRPC_SERVER DEBUG: [0x61a0000d0280] created request Name# CopyTable
2025-10-26T18:38:47.045113Z :GRPC_SERVER DEBUG: [0x61a0000d0880] created request Name# CopyTable
2025-10-26T18:38:47.045479Z :GRPC_SERVER DEBUG: [0x61a0000d0e80] created request Name# CopyTable
2025-10-26T18:38:47.045755Z :GRPC_SERVER DEBUG: [0x61a0000d1480] created request Name# CopyTable
2025-10-26T18:38:47.045980Z :GRPC_SERVER DEBUG: [0x61a0000d1a80] created request Name# CopyTable
2025-10-26T18:38:47.046221Z :BS_PROXY_DISCOVER WARN: [e05ec0df654c4f1e] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046289Z :GRPC_SERVER DEBUG: [0x61a0000d2080] created request Name# CopyTable
2025-10-26T18:38:47.046291Z :BS_PROXY_DISCOVER WARN: [22e0803153794cc0] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046445Z :BS_PROXY_DISCOVER WARN: [9ed12305b258cbad] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046642Z :BS_PROXY_DISCOVER WARN: [fb76623b02b9839e] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046644Z :BS_PROXY_DISCOVER WARN: [1ca7a14eaf518017] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046658Z :GRPC_SERVER DEBUG: [0x61a0000d2680] created request Name# CopyTable
2025-10-26T18:38:47.046781Z :BS_PROXY_DISCOVER WARN: [2152608172162f29] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046886Z :BS_PROXY_DISCOVER WARN: [07555422a74bebe5] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.046903Z :GRPC_SERVER DEBUG: [0x61a0000d2c80] created request Name# CopyTable
2025-10-26T18:38:47.046969Z :BS_PROXY_DISCOVER WARN: [d3064ad8b4471842] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.047094Z :BS_PROXY_DISCOVER WARN: [80e4767129474129] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.047120Z :BS_PROXY_DISCOVER WARN: [33c88b4e78238f4f] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.047168Z :GRPC_SERVER DEBUG: [0x61a0000d3280] created request Name# CopyTable
2025-10-26T18:38:47.047418Z :GRPC_SERVER DEBUG: [0x61a0000d3880] created request Name# CopyTable
2025-10-26T18:38:47.047677Z :GRPC_SERVER DEBUG: [0x61a0000d3e80] created request Name# CopyTable
2025-10-26T18:38:47.047921Z :GRPC_SERVER DEBUG: [0x61a0000d4480] created request Name# CopyTable
2025-10-26T18:38:47.048357Z :GRPC_SERVER DEBUG: [0x61a0000d4a80] created request Name# CopyTable
2025-10-26T18:38:47.048630Z :GRPC_SERVER DEBUG: [0x61a0000d5080] created request Name# CopyTable
2025-10-26T18:38:47.048856Z :GRPC_SERVER DEBUG: [0x61a0000d5680] created request Name# CopyTable
2025-10-26T18:38:47.049140Z :GRPC_SERVER DEBUG: [0x61a0000d5c80] created request Name# CopyTable
2025-10-26T18:38:47.049372Z :GRPC_SERVER DEBUG: [0x61a0000d6280] created request Name# CopyTable
2025-10-26T18:38:47.049597Z :GRPC_SERVER DEBUG: [0x61a0000d6880] created request Name# CopyTable
2025-10-26T18:38:47.049839Z :GRPC_SERVER DEBUG: [0x61a0000d6e80] created request Name# CopyTable
2025-10-26T18:38:47.050464Z :GRPC_SERVER DEBUG: [0x61a0000d7480] created request Name# CopyTables
2025-10-26T18:38:47.050753Z :GRPC_SERVER DEBUG: [0x61a0000d7a80] created request Name# CopyTables
2025-10-26T18:38:47.051149Z :GRPC_SERVER DEBUG: [0x61a0000d8080] created request Name# CopyTables
2025-10-26T18:38:47.051419Z :GRPC_SERVER DEBUG: [0x61a0000d8680] created request Name# CopyTables
2025-10-26T18:38:47.051695Z :GRPC_SERVER DEBUG: [0x61a0000d8c80] created request Name# CopyTables
2025-10-26T18:38:47.051920Z :GRPC_SERVER DEBUG: [0x61a0000d9280] created request Name# CopyTables
2025-10-26T18:38:47.052161Z :GRPC_SERVER DEBUG: [0x61a0000d9880] created request Name# CopyTables
2025-10-26T18:38:47.052409Z :GRPC_SERVER DEBUG: [0x61a0000d9e80] created request Name# CopyTables
2025-10-26T18:38:47.052699Z :GRPC_SERVER DEBUG: [0x61a0000da480] created request Name# CopyTables
2025-10-26T18:38:47.052997Z :GRPC_SERVER DEBUG: [0x61a0000daa80] created request Name# CopyTables
2025-10-26T18:38:47.053367Z :GRPC_SERVER DEBUG: [0x61a0000db080] created request Name# CopyTables
2025-10-26T18:38:47.053648Z :GRPC_SERVER DEBUG: [0x61a0000db680] created request Name# CopyTables
2025-10-26T18:38:47.053960Z :GRPC_SERVER DEBUG: [0x61a0000dbc80] created request Name# CopyTables
2025-10-26T18:38:47.054212Z :GRPC_SERVER DEBUG: [0x61a0000dc280] created request Name# CopyTables
2025-10-26T18:38:47.054506Z :GRPC_SERVER DEBUG: [0x61a0000dc880] created request Name# CopyTables
2025-10-26T18:38:47.054908Z :GRPC_SERVER DEBUG: [0x61a0000dce80] created request Name# CopyTables
2025-10-26T18:38:47.055117Z :GRPC_SERVER DEBUG: [0x61a0000dd480] created request Name# CopyTables
2025-10-26T18:38:47.055389Z :GRPC_SERVER DEBUG: [0x61a0000dda80] created request Name# CopyTables
2025-10-26T18:38:47.055756Z :GRPC_SERVER DEBUG: [0x61a0000de080] created request Name# CopyTables
2025-10-26T18:38:47.055994Z :GRPC_SERVER DEBUG: [0x61a0000de680] created request Name# CopyTables
2025-10-26T18:38:47.056602Z :GRPC_SERVER DEBUG: [0x61a0000dec80] created request Name# RenameTables
2025-10-26T18:38:47.057009Z :GRPC_SERVER DEBUG: [0x61a0000df280] created request Name# RenameTables
2025-10-26T18:38:47.057288Z :GRPC_SERVER DEBUG: [0x61a0000dfe80] created request Name# RenameTables
2025-10-26T18:38:47.057620Z :GRPC_SERVER DEBUG: [0x61a0000e0480] created request Name# RenameTables
2025-10-26T18:38:47.057895Z :GRPC_SERVER DEBUG: [0x61a0000e0a80] created request Name# RenameTables
2025-10-26T18:38:47.058242Z :GRPC_SERVER DEBUG: [0x61a0000e1080] created request Name# RenameTables
2025-10-26T18:38:47.058536Z :GRPC_SERVER DEBUG: [0x61a0000e1680] created request Name# RenameTables
2025-10-26T18:38:47.058834Z :GRPC_SERVER DEBUG: [0x61a0000e1c80] created request Name# RenameTables
2025-10-26T18:38:47.059060Z :GRPC_SERVER DEBUG: [0x61a0000e2280] created request Name# RenameTables
2025-10-26T18:38:47.059218Z :GRPC_SERVER DEBUG: [0x61a0000e2880] created request Name# RenameTables
2025-10-26T18:38:47.059386Z :GRPC_SERVER DEBUG: [0x61a0000e2e80] created request Name# RenameTables
2025-10-26T18:38:47.059579Z :GRPC_SERVER DEBUG: [0x61a0000e3480] created request Name# RenameTables
2025-10-26T18:38:47.059725Z :GRPC_SERVER DEBUG: [0x61a0000e3a80] created request Name# RenameTables
2025-10-26T18:38:47.059953Z :GRPC_SERVER DEBUG: [0x61a0000e4080] created request Name# RenameTables
2025-10-26T18:38:47.060111Z :GRPC_SERVER DEBUG: [0x61a0000e4680] created request Name# RenameTables
2025-10-26T18:38:47.060268Z :GRPC_SERVER DEBUG: [0x61a0000e4c80] created request Name# RenameTables
2025-10-26T18:38:47.060425Z :GRPC_SERVER DEBUG: [0x61a0000e5280] created request Name# RenameTables
2025-10-26T18:38:47.060579Z :GRPC_SERVER DEBUG: [0x61a0000e5880] created request Name# RenameTables
2025-10-26T18:38:47.060717Z :GRPC_SERVER DEBUG: [0x61a0000e5e80] created request Name# RenameTables
2025-10-26T18:38:47.060858Z :GRPC_SERVER DEBUG: [0x61a0000e6480] created request Name# RenameTables
2025-10-26T18:38:47.061125Z :GRPC_SERVER DEBUG: [0x61a0000e6a80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.061325Z :GRPC_SERVER DEBUG: [0x61a0000e7080] created request Name# ExplainDataQuery
2025-10-26T18:38:47.061440Z :GRPC_SERVER DEBUG: [0x61a0000e7680] created request Name# ExplainDataQuery
2025-10-26T18:38:47.061584Z :GRPC_SERVER DEBUG: [0x61a0000e7c80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.061811Z :GRPC_SERVER DEBUG: [0x61a0000e8280] created request Name# ExplainDataQuery
2025-10-26T18:38:47.061957Z :GRPC_SERVER DEBUG: [0x61a0000e8880] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062087Z :GRPC_SERVER DEBUG: [0x61a0000e8e80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062270Z :GRPC_SERVER DEBUG: [0x61a0000e9480] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062415Z :GRPC_SERVER DEBUG: [0x61a0000e9a80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062539Z :GRPC_SERVER DEBUG: [0x61a0000ea080] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062729Z :GRPC_SERVER DEBUG: [0x61a0000ea680] created request Name# ExplainDataQuery
2025-10-26T18:38:47.062891Z :GRPC_SERVER DEBUG: [0x61a0000eac80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.063035Z :GRPC_SERVER DEBUG: [0x61a0000eb280] created request Name# ExplainDataQuery
2025-10-26T18:38:47.063220Z :GRPC_SERVER DEBUG: [0x61a0000eb880] created request Name# ExplainDataQuery
2025-10-26T18:38:47.063615Z :GRPC_SERVER DEBUG: [0x61a0000ebe80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.063804Z :GRPC_SERVER DEBUG: [0x61a0000ec480] created request Name# ExplainDataQuery
2025-10-26T18:38:47.063971Z :GRPC_SERVER DEBUG: [0x61a0000eca80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.064131Z :GRPC_SERVER DEBUG: [0x61a0000ed080] created request Name# ExplainDataQuery
2025-10-26T18:38:47.064307Z :GRPC_SERVER DEBUG: [0x61a0000ed680] created request Name# ExplainDataQuery
2025-10-26T18:38:47.064478Z :GRPC_SERVER DEBUG: [0x61a0000edc80] created request Name# ExplainDataQuery
2025-10-26T18:38:47.064837Z :GRPC_SERVER DEBUG: [0x61a0000ee280] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065048Z :GRPC_SERVER DEBUG: [0x61a0000ee880] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065172Z :GRPC_SERVER DEBUG: [0x61a0000eee80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065343Z :GRPC_SERVER DEBUG: [0x61a0000ef480] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065577Z :GRPC_SERVER DEBUG: [0x61a0000f0080] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065790Z :GRPC_SERVER DEBUG: [0x61a0000f0680] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.065984Z :GRPC_SERVER DEBUG: [0x61a0000f0c80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.066202Z :GRPC_SERVER DEBUG: [0x61a0000f1280] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.066351Z :GRPC_SERVER DEBUG: [0x61a0000f1880] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.066570Z :GRPC_SERVER DEBUG: [0x61a0000f1e80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.066784Z :GRPC_SERVER DEBUG: [0x61a0000f2480] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.066964Z :GRPC_SERVER DEBUG: [0x61a0000f2a80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.067198Z :GRPC_SERVER DEBUG: [0x61a0000f3080] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.067454Z :GRPC_SERVER DEBUG: [0x61a0000f3680] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.067736Z :GRPC_SERVER DEBUG: [0x61a0000f3c80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.068009Z :GRPC_SERVER DEBUG: [0x61a0000f4280] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.068307Z :GRPC_SERVER DEBUG: [0x61a0000f4880] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.068578Z :GRPC_SERVER DEBUG: [0x61a0000f4e80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.068950Z :GRPC_SERVER DEBUG: [0x61a0000f5480] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.069347Z :GRPC_SERVER DEBUG: [0x61a0000f5a80] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:47.069755Z :GRPC_SERVER DEBUG: [0x61a0000f6080] created request Name# BeginTransaction
2025-10-26T18:38:47.070073Z :GRPC_SERVER DEBUG: [0x61a0000f6680] created request Name# BeginTransaction
2025-10-26T18:38:47.070316Z :GRPC_SERVER DEBUG: [0x61a0000f6c80] created request Name# BeginTransaction
2025-10-26T18:38:47.070518Z :GRPC_SERVER DEBUG: [0x61a0000f7280] created request Name# BeginTransaction
2025-10-26T18:38:47.070751Z :GRPC_SERVER DEBUG: [0x61a0000f7880] created request Name# BeginTransaction
2025-10-26T18:38:47.071066Z :GRPC_SERVER DEBUG: [0x61a0000f7e80] created request Name# BeginTransaction
2025-10-26T18:38:47.071310Z :GRPC_SERVER DEBUG: [0x61a0000f8480] created request Name# BeginTransaction
2025-10-26T18:38:47.071530Z :GRPC_SERVER DEBUG: [0x61a0000f8a80] created request Name# BeginTransaction
2025-10-26T18:38:47.071771Z :GRPC_SERVER DEBUG: [0x61a0000f9080] created request Name# BeginTransaction
2025-10-26T18:38:47.072015Z :GRPC_SERVER DEBUG: [0x61a0000f9680] created request Name# BeginTransaction
2025-10-26T18:38:47.072383Z :GRPC_SERVER DEBUG: [0x61a0000f9c80] created request Name# BeginTransaction
2025-10-26T18:38:47.072671Z :GRPC_SERVER DEBUG: [0x61a0000fa280] created request Name# BeginTransaction
2025-10-26T18:38:47.072904Z :GRPC_SERVER DEBUG: [0x61a0000fa880] created request Name# BeginTransaction
2025-10-26T18:38:47.073123Z :GRPC_SERVER DEBUG: [0x61a0000fae80] created request Name# BeginTransaction
2025-10-26T18:38:47.073445Z :GRPC_SERVER DEBUG: [0x61a0000fb480] created request Name# BeginTransaction
2025-10-26T18:38:47.073713Z :GRPC_SERVER DEBUG: [0x61a0000fba80] created request Name# BeginTransaction
2025-10-26T18:38:47.073966Z :GRPC_SERVER DEBUG: [0x61a0000fc080] created request Name# BeginTransaction
2025-10-26T18:38:47.074231Z :GRPC_SERVER DEBUG: [0x61a0000fc680] created request Name# BeginTransaction
2025-10-26T18:38:47.074596Z :GRPC_SERVER DEBUG: [0x61a0000fcc80] created request Name# BeginTransaction
2025-10-26T18:38:47.074916Z :GRPC_SERVER DEBUG: [0x61a0000fd280] created request Name# BeginTransaction
2025-10-26T18:38:47.075343Z :GRPC_SERVER DEBUG: [0x61a0000fd880] created request Name# DescribeTableOptions
2025-10-26T18:38:47.075649Z :GRPC_SERVER DEBUG: [0x61a0000fde80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.076014Z :GRPC_SERVER DEBUG: [0x61a0000fe480] created request Name# DescribeTableOptions
2025-10-26T18:38:47.076334Z :GRPC_SERVER DEBUG: [0x61a0000fea80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.076843Z :GRPC_SERVER DEBUG: [0x61a0000ff080] created request Name# DescribeTableOptions
2025-10-26T18:38:47.077108Z :GRPC_SERVER DEBUG: [0x61a0000ff680] created request Name# DescribeTableOptions
2025-10-26T18:38:47.077384Z :GRPC_SERVER DEBUG: [0x61a0000ffc80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.077648Z :GRPC_SERVER DEBUG: [0x61a000100280] created request Name# DescribeTableOptions
2025-10-26T18:38:47.077952Z :GRPC_SERVER DEBUG: [0x61a000100880] created request Name# DescribeTableOptions
2025-10-26T18:38:47.078239Z :GRPC_SERVER DEBUG: [0x61a000100e80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.078487Z :GRPC_SERVER DEBUG: [0x61a000101480] created request Name# DescribeTableOptions
2025-10-26T18:38:47.078801Z :GRPC_SERVER DEBUG: [0x61a000101a80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.079094Z :GRPC_SERVER DEBUG: [0x61a000102080] created request Name# DescribeTableOptions
2025-10-26T18:38:47.079302Z :GRPC_SERVER DEBUG: [0x61a000102680] created request Name# DescribeTableOptions
2025-10-26T18:38:47.079549Z :GRPC_SERVER DEBUG: [0x61a000102c80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.079769Z :GRPC_SERVER DEBUG: [0x61a000103280] created request Name# DescribeTableOptions
2025-10-26T18:38:47.080459Z :GRPC_SERVER DEBUG: [0x61a000103880] created request Name# DescribeTableOptions
2025-10-26T18:38:47.080752Z :GRPC_SERVER DEBUG: [0x61a000103e80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.081025Z :GRPC_SERVER DEBUG: [0x61a000104480] created request Name# DescribeTableOptions
2025-10-26T18:38:47.081277Z :GRPC_SERVER DEBUG: [0x61a000104a80] created request Name# DescribeTableOptions
2025-10-26T18:38:47.081718Z :GRPC_SERVER DEBUG: [0x61a000105080] created request Name# DeleteSession
2025-10-26T18:38:47.082052Z :GRPC_SERVER DEBUG: [0x61a000105680] created request Name# DeleteSession
2025-10-26T18:38:47.082332Z :GRPC_SERVER DEBUG: [0x61a000105c80] created request Name# DeleteSession
2025-10-26T18:38:47.082569Z :GRPC_SERVER DEBUG: [0x61a000106280] created request Name# DeleteSession
2025-10-26T18:38:47.082864Z :GRPC_SERVER DEBUG: [0x61a000106880] created request Name# DeleteSession
2025-10-26T18:38:47.083112Z :GRPC_SERVER DEBUG: [0x61a000106e80] created request Name# DeleteSession
2025-10-26T18:38:47.083328Z :GRPC_SERVER DEBUG: [0x61a000107480] created request Name# DeleteSession
2025-10-26T18:38:47.083505Z :GRPC_SERVER DEBUG: [0x61a000107a80] created request Name# DeleteSession
2025-10-26T18:38:47.083922Z :GRPC_SERVER DEBUG: [0x61a000108080] created request Name# DeleteSession
2025-10-26T18:38:47.084331Z :GRPC_SERVER DEBUG: [0x61a000108680] created request Name# DeleteSession
2025-10-26T18:38:47.084705Z :GRPC_SERVER DEBUG: [0x61a000108c80] created request Name# DeleteSession
2025-10-26T18:38:47.084946Z :GRPC_SERVER DEBUG: [0x61a000109280] created request Name# DeleteSession
2025-10-26T18:38:47.085191Z :GRPC_SERVER DEBUG: [0x61a000109880] created request Name# DeleteSession
2025-10-26T18:38:47.085408Z :GRPC_SERVER DEBUG: [0x61a000109e80] created request Name# DeleteSession
2025-10-26T18:38:47.085667Z :GRPC_SERVER DEBUG: [0x61a00010a480] created request Name# DeleteSession
2025-10-26T18:38:47.085916Z :GRPC_SERVER DEBUG: [0x61a00010aa80] created request Name# DeleteSession
2025-10-26T18:38:47.086180Z :GRPC_SERVER DEBUG: [0x61a00010b080] created request Name# DeleteSession
2025-10-26T18:38:47.086434Z :GRPC_SERVER DEBUG: [0x61a00010b680] created request Name# DeleteSession
2025-10-26T18:38:47.086697Z :GRPC_SERVER DEBUG: [0x61a00010bc80] created request Name# DeleteSession
2025-10-26T18:38:47.086931Z :GRPC_SERVER DEBUG: [0x61a00010c280] created request Name# DeleteSession
2025-10-26T18:38:47.087590Z :GRPC_SERVER DEBUG: [0x61a00010c880] created request Name# CommitTransaction
2025-10-26T18:38:47.088027Z :GRPC_SERVER DEBUG: [0x61a00010ce80] created request Name# CommitTransaction
2025-10-26T18:38:47.088361Z :GRPC_SERVER DEBUG: [0x61a00010d480] created request Name# CommitTransaction
2025-10-26T18:38:47.088641Z :GRPC_SERVER DEBUG: [0x61a00010da80] created request Name# CommitTransaction
2025-10-26T18:38:47.088902Z :GRPC_SERVER DEBUG: [0x61a00010e080] created request Name# CommitTransaction
2025-10-26T18:38:47.089136Z :GRPC_SERVER DEBUG: [0x61a00010e680] created request Name# CommitTransaction
2025-10-26T18:38:47.089382Z :GRPC_SERVER DEBUG: [0x61a00010ec80] created request Name# CommitTransaction
2025-10-26T18:38:47.089581Z :GRPC_SERVER DEBUG: [0x61a00010f280] created request Name# CommitTransaction
2025-10-26T18:38:47.089892Z :GRPC_SERVER DEBUG: [0x61a00010fe80] created request Name# CommitTransaction
2025-10-26T18:38:47.090125Z :GRPC_SERVER DEBUG: [0x61a000110480] created request Name# CommitTransaction
2025-10-26T18:38:47.090316Z :GRPC_SERVER DEBUG: [0x61a000110a80] created request Name# CommitTransaction
2025-10-26T18:38:47.090547Z :GRPC_SERVER DEBUG: [0x61a000111080] created request Name# CommitTransaction
2025-10-26T18:38:47.090779Z :GRPC_SERVER DEBUG: [0x61a000111680] created request Name# CommitTransaction
2025-10-26T18:38:47.091048Z :GRPC_SERVER DEBUG: [0x61a000111c80] created request Name# CommitTransaction
2025-10-26T18:38:47.091309Z :GRPC_SERVER DEBUG: [0x61a000112280] created request Name# CommitTransaction
2025-10-26T18:38:47.091622Z :GRPC_SERVER DEBUG: [0x61a000112880] created request Name# CommitTransaction
2025-10-26T18:38:47.091896Z :GRPC_SERVER DEBUG: [0x61a000112e80] created request Name# CommitTransaction
2025-10-26T18:38:47.092137Z :GRPC_SERVER DEBUG: [0x61a000113480] created request Name# CommitTransaction
2025-10-26T18:38:47.092370Z :GRPC_SERVER DEBUG: [0x61a000113a80] created request Name# CommitTransaction
2025-10-26T18:38:47.092601Z :GRPC_SERVER DEBUG: [0x61a000114080] created request Name# CommitTransaction
2025-10-26T18:38:47.093049Z :GRPC_SERVER DEBUG: [0x61a000114680] created request Name# RollbackTransaction
2025-10-26T18:38:47.093348Z :GRPC_SERVER DEBUG: [0x61a000114c80] created request Name# RollbackTransaction
2025-10-26T18:38:47.093738Z :GRPC_SERVER DEBUG: [0x61a000115280] created request Name# RollbackTransaction
2025-10-26T18:38:47.093944Z :GRPC_SERVER DEBUG: [0x61a000115880] created request Name# RollbackTransaction
2025-10-26T18:38:47.094141Z :GRPC_SERVER DEBUG: [0x61a000115e80] created request Name# RollbackTransaction
2025-10-26T18:38:47.094410Z :GRPC_SERVER DEBUG: [0x61a000116480] created request Name# RollbackTransaction
2025-10-26T18:38:47.094725Z :GRPC_SERVER DEBUG: [0x61a000116a80] created request Name# RollbackTransaction
2025-10-26T18:38:47.095015Z :GRPC_SERVER DEBUG: [0x61a000117080] created request Name# RollbackTransaction
2025-10-26T18:38:47.095291Z :GRPC_SERVER DEBUG: [0x61a000117680] created request Name# RollbackTransaction
2025-10-26T18:38:47.095595Z :GRPC_SERVER DEBUG: [0x61a000117c80] created request Name# RollbackTransaction
2025-10-26T18:38:47.095855Z :GRPC_SERVER DEBUG: [0x61a000118280] created request Name# RollbackTransaction
2025-10-26T18:38:47.096162Z :GRPC_SERVER DEBUG: [0x61a000118880] created request Name# RollbackTransaction
2025-10-26T18:38:47.096438Z :GRPC_SERVER DEBUG: [0x61a000118e80] created request Name# RollbackTransaction
2025-10-26T18:38:47.096695Z :GRPC_SERVER DEBUG: [0x61a000119480] created request Name# RollbackTransaction
2025-10-26T18:38:47.096891Z :GRPC_SERVER DEBUG: [0x61a000119a80] created request Name# RollbackTransaction
2025-10-26T18:38:47.097120Z :GRPC_SERVER DEBUG: [0x61a00011a080] created request Name# RollbackTransaction
2025-10-26T18:38:47.097362Z :GRPC_SERVER DEBUG: [0x61a00011a680] created request Name# RollbackTransaction
2025-10-26T18:38:47.097568Z :GRPC_SERVER DEBUG: [0x61a00011ac80] created request Name# RollbackTransaction
2025-10-26T18:38:47.097827Z :GRPC_SERVER DEBUG: [0x61a00011b280] created request Name# RollbackTransaction
2025-10-26T18:38:47.098083Z :GRPC_SERVER DEBUG: [0x61a00011b880] created request Name# RollbackTransaction
2025-10-26T18:38:47.098801Z :GRPC_SERVER DEBUG: [0x61a00011be80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.099134Z :GRPC_SERVER DEBUG: [0x61a00011c480] created request Name# PrepareDataQuery
2025-10-26T18:38:47.099359Z :GRPC_SERVER DEBUG: [0x61a00011ca80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.099624Z :GRPC_SERVER DEBUG: [0x61a00011d080] created request Name# PrepareDataQuery
2025-10-26T18:38:47.099862Z :GRPC_SERVER DEBUG: [0x61a00011d680] created request Name# PrepareDataQuery
2025-10-26T18:38:47.100155Z :GRPC_SERVER DEBUG: [0x61a00011dc80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.100375Z :GRPC_SERVER DEBUG: [0x61a00011e280] created request Name# PrepareDataQuery
2025-10-26T18:38:47.100588Z :GRPC_SERVER DEBUG: [0x61a00011e880] created request Name# PrepareDataQuery
2025-10-26T18:38:47.100845Z :GRPC_SERVER DEBUG: [0x61a00011ee80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.101108Z :GRPC_SERVER DEBUG: [0x61a00011f480] created request Name# PrepareDataQuery
2025-10-26T18:38:47.101366Z :GRPC_SERVER DEBUG: [0x61a000120080] created request Name# PrepareDataQuery
2025-10-26T18:38:47.101577Z :GRPC_SERVER DEBUG: [0x61a000120680] created request Name# PrepareDataQuery
2025-10-26T18:38:47.102093Z :GRPC_SERVER DEBUG: [0x61a000120c80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.102410Z :GRPC_SERVER DEBUG: [0x61a000121280] created request Name# PrepareDataQuery
2025-10-26T18:38:47.102684Z :GRPC_SERVER DEBUG: [0x61a000121880] created request Name# PrepareDataQuery
2025-10-26T18:38:47.102924Z :GRPC_SERVER DEBUG: [0x61a000121e80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.103163Z :GRPC_SERVER DEBUG: [0x61a000122480] created request Name# PrepareDataQuery
2025-10-26T18:38:47.103418Z :GRPC_SERVER DEBUG: [0x61a000122a80] created request Name# PrepareDataQuery
2025-10-26T18:38:47.103700Z :GRPC_SERVER DEBUG: [0x61a000123080] created request Name# PrepareDataQuery
2025-10-26T18:38:47.103924Z :GRPC_SERVER DEBUG: [0x61a000123680] created request Name# PrepareDataQuery
2025-10-26T18:38:47.104396Z :GRPC_SERVER DEBUG: [0x61a000123c80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.104664Z :GRPC_SERVER DEBUG: [0x61a000124280] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.104895Z :GRPC_SERVER DEBUG: [0x61a000124880] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.105195Z :GRPC_SERVER DEBUG: [0x61a000124e80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.105488Z :GRPC_SERVER DEBUG: [0x61a000125480] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.105798Z :GRPC_SERVER DEBUG: [0x61a000125a80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.106077Z :GRPC_SERVER DEBUG: [0x61a000126080] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.106333Z :GRPC_SERVER DEBUG: [0x61a000126680] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.106600Z :GRPC_SERVER DEBUG: [0x61a000126c80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.106846Z :GRPC_SERVER DEBUG: [0x61a000127280] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.107066Z :GRPC_SERVER DEBUG: [0x61a000127880] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.107309Z :GRPC_SERVER DEBUG: [0x61a000127e80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.107583Z :GRPC_SERVER DEBUG: [0x61a000128480] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.107837Z :GRPC_SERVER DEBUG: [0x61a000128a80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.108069Z :GRPC_SERVER DEBUG: [0x61a000129080] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.108319Z :GRPC_SERVER DEBUG: [0x61a000129680] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.108622Z :GRPC_SERVER DEBUG: [0x61a000129c80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.108942Z :GRPC_SERVER DEBUG: [0x61a00012a280] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.109159Z :GRPC_SERVER DEBUG: [0x61a00012a880] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.109427Z :GRPC_SERVER DEBUG: [0x61a00012ae80] created request Name# ExecuteDataQuery
2025-10-26T18:38:47.109925Z :GRPC_SERVER DEBUG: [0x61a00012b480] created request Name# BulkUpsert
2025-10-26T18:38:47.110253Z :GRPC_SERVER DEBUG: [0x61a00012ba80] created request Name# BulkUpsert
2025-10-26T18:38:47.110555Z :GRPC_SERVER DEBUG: [0x61a00012c080] created request Name# BulkUpsert
2025-10-26T18:38:47.110812Z :GRPC_SERVER DEBUG: [0x61a00012c680] created request Name# BulkUpsert
2025-10-26T18:38:47.111104Z :GRPC_SERVER DEBUG: [0x61a00012cc80] created request Name# BulkUpsert
2025-10-26T18:38:47.111410Z :GRPC_SERVER DEBUG: [0x61a00012d280] created request Name# BulkUpsert
2025-10-26T18:38:47.111749Z :GRPC_SERVER DEBUG: [0x61a00012d880] created request Name# BulkUpsert
2025-10-26T18:38:47.112166Z :GRPC_SERVER DEBUG: [0x61a00012de80] created request Name# BulkUpsert
2025-10-26T18:38:47.112451Z :GRPC_SERVER DEBUG: [0x61a00012e480] created request Name# BulkUpsert
2025-10-26T18:38:47.112740Z :GRPC_SERVER DEBUG: [0x61a00012ea80] created request Name# BulkUpsert
2025-10-26T18:38:47.113016Z :GRPC_SERVER DEBUG: [0x61a00012f080] created request Name# BulkUpsert
2025-10-26T18:38:47.113271Z :GRPC_SERVER DEBUG: [0x61a00012f680] created request Name# BulkUpsert
2025-10-26T18:38:47.113588Z :GRPC_SERVER DEBUG: [0x61a00012fc80] created request Name# BulkUpsert
2025-10-26T18:38:47.113865Z :GRPC_SERVER DEBUG: [0x61a000130280] created request Name# BulkUpsert
2025-10-26T18:38:47.114152Z :GRPC_SERVER DEBUG: [0x61a000130880] created request Name# BulkUpsert
2025-10-26T18:38:47.114425Z :GRPC_SERVER DEBUG: [0x61a000130e80] created request Name# BulkUpsert
2025-10-26T18:38:47.114750Z :GRPC_SERVER DEBUG: [0x61a000131480] created request Name# BulkUpsert
2025-10-26T18:38:47.114995Z :GRPC_SERVER DEBUG: [0x61a000131a80] created request Name# BulkUpsert
2025-10-26T18:38:47.115239Z :GRPC_SERVER DEBUG: [0x61a000132080] created request Name# BulkUpsert
2025-10-26T18:38:47.115562Z :GRPC_SERVER DEBUG: [0x61a000132680] created request Name# BulkUpsert
2025-10-26T18:38:47.116215Z :GRPC_SERVER DEBUG: [0x61a000132c80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.116564Z :GRPC_SERVER DEBUG: [0x61a000133280] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.116862Z :GRPC_SERVER DEBUG: [0x61a000133880] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.117249Z :GRPC_SERVER DEBUG: [0x61a000133e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.117508Z :GRPC_SERVER DEBUG: [0x61a000134480] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.117807Z :GRPC_SERVER DEBUG: [0x61a000134a80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.118079Z :GRPC_SERVER DEBUG: [0x61a000135080] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.118330Z :GRPC_SERVER DEBUG: [0x61a000135680] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.118559Z :GRPC_SERVER DEBUG: [0x61a000135c80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.118923Z :GRPC_SERVER DEBUG: [0x61a000136280] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.119185Z :GRPC_SERVER DEBUG: [0x61a000136880] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.119496Z :GRPC_SERVER DEBUG: [0x61a000136e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.119790Z :GRPC_SERVER DEBUG: [0x61a000137480] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.120052Z :GRPC_SERVER DEBUG: [0x61a000137a80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.120376Z :GRPC_SERVER DEBUG: [0x61a000138080] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.120584Z :GRPC_SERVER DEBUG: [0x61a000138680] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.120824Z :GRPC_SERVER DEBUG: [0x61a000138c80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.121051Z :GRPC_SERVER DEBUG: [0x61a000139280] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.121327Z :GRPC_SERVER DEBUG: [0x61a000139880] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.121590Z :GRPC_SERVER DEBUG: [0x61a000139e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T18:38:47.122060Z :GRPC_SERVER DEBUG: [0x61a00013a480] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.122372Z :GRPC_SERVER DEBUG: [0x61a00013aa80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.122684Z :GRPC_SERVER DEBUG: [0x61a00013b080] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.122913Z :GRPC_SERVER DEBUG: [0x61a00013b680] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.123154Z :GRPC_SERVER DEBUG: [0x61a00013bc80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.123224Z :BS_PROXY_DISCOVER WARN: [38b01e94b45964bb] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.123402Z :GRPC_SERVER DEBUG: [0x61a00013c280] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.123403Z :BS_PROXY_DISCOVER WARN: [d7bb66270e5ec8bb] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.123517Z :BS_PROXY_DISCOVER WARN: [0771fe2121ec478e] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.123630Z :GRPC_SERVER DEBUG: [0x61a00013c880] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.123661Z :BS_PROXY_DISCOVER WARN: [4ad7e124cdaa56b3] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.123866Z :BS_PROXY_DISCOVER WARN: [ce8f124894c74bc0] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.123878Z :GRPC_SERVER DEBUG: [0x61a00013ce80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.124010Z :BS_PROXY_DISCOVER WARN: [a92fd7c4bc36959f] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.124166Z :GRPC_SERVER DEBUG: [0x61a00013d480] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.124174Z :BS_PROXY_DISCOVER WARN: [c0ea0aa2cab22a02] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.124397Z :GRPC_SERVER DEBUG: [0x61a00013da80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.124457Z :BS_PROXY_DISCOVER WARN: [065e1f56190b7cc4] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T18:38:47.124708Z :GRPC_SERVER DEBUG: [0x61a00013e080] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.124760Z :BS_PROXY_DISCOVER WARN: [ddc27020bb3575df] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:47.124935Z :GRPC_SERVER DEBUG: [0x61a00013e680] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.125151Z :GRPC_SERVER DEBUG: [0x61a00013ec80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.125404Z :GRPC_SERVER DEBUG: [0x61a00013f280] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.125675Z :GRPC_SERVER DEBUG: [0x61a00013fe80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.125937Z :GRPC_SERVER DEBUG: [0x61a000140480] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.126312Z :GRPC_SERVER DEBUG: [0x61a000140a80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.126625Z :GRPC_SERVER DEBUG: [0x61a000141080] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.126871Z :GRPC_SERVER DEBUG: [0x61a000141680] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.127136Z :GRPC_SERVER DEBUG: [0x61a000141c80] created streaming request Name# StreamReadTable
2025-10-26T18:38:47.127751Z :GRPC_SERVER DEBUG: [0x61a000142280] created request Name# ReadRows
2025-10-26T18:38:47.128055Z :GRPC_SERVER DEBUG: [0x61a000142880] created request Name# ReadRows
2025-10-26T18:38:47.128341Z :GRPC_SERVER DEBUG: [0x61a000142e80] created request Name# ReadRows
2025-10-26T18:38:47.128625Z :GRPC_SERVER DEBUG: [0x61a000143480] created request Name# ReadRows
2025-10-26T18:38:47.128870Z :GRPC_SERVER DEBUG: [0x61a000143a80] created request Name# ReadRows
2025-10-26T18:38:47.129159Z :GRPC_SERVER DEBUG: [0x61a000144080] created request Name# ReadRows
2025-10-26T18:38:47.129378Z :GRPC_SERVER DEBUG: [0x61a000144680] created request Name# ReadRows
2025-10-26T18:38:47.129605Z :GRPC_SERVER DEBUG: [0x61a000144c80] created request Name# ReadRows
2025-10-26T18:38:47.129968Z :GRPC_SERVER DEBUG: [0x61a000145280] created request Name# ReadRows
2025-10-26T18:38:47.130221Z :GRPC_SERVER DEBUG: [0x61a000145880] created request Name# ReadRows
2025-10-26T18:38:47.130446Z :GRPC_SERVER DEBUG: [0x61a000145e80] created request Name# ReadRows
2025-10-26T18:38:47.130689Z :GRPC_SERVER DEBUG: [0x61a000146480] created request Name# ReadRows
2025-10-26T18:38:47.130956Z :GRPC_SERVER DEBUG: [0x61a000146a80] created request Name# ReadRows
2025-10-26T18:38:47.131246Z :GRPC_SERVER DEBUG: [0x61a000147080] created request Name# ReadRows
2025-10-26T18:38:47.131542Z :GRPC_SERVER DEBUG: [0x61a000147680] created request Name# ReadRows
2025-10-26T18:38:47.131806Z :GRPC_SERVER DEBUG: [0x61a000147c80] created request Name# ReadRows
2025-10-26T18:38:47.132042Z :GRPC_SERVER DEBUG: [0x61a000148280] created request Name# ReadRows
2025-10-26T18:38:47.132325Z :GRPC_SERVER DEBUG: [0x61a000148880] created request Name# ReadRows
2025-10-26T18:38:47.132639Z :GRPC_SERVER DEBUG: [0x61a000148e80] created request Name# ReadRows
2025-10-26T18:38:47.132860Z :GRPC_SERVER DEBUG: [0x61a000149480] created request Name# ReadRows
2025-10-26T18:38:47.133475Z :GRPC_SERVER DEBUG: [0x61a000149a80] created request Name# Scan
2025-10-26T18:38:47.134151Z :GRPC_SERVER DEBUG: [0x61a00014a080] created request Name# GetShardLocations
2025-10-26T18:38:47.134673Z :GRPC_SERVER DEBUG: [0x61a00014a680] created request Name# DescribeTable
2025-10-26T18:38:47.135264Z :GRPC_SERVER DEBUG: [0x61a00014ac80] created request Name# CreateSnapshot
2025-10-26T18:38:47.135860Z :GRPC_SERVER DEBUG: [0x61a00014b280] created request Name# RefreshSnapshot
2025-10-26T18:38:47.136578Z :GRPC_SERVER DEBUG: [0x61a00014b880] created request Name# DiscardSnapshot
2025-10-26T18:38:47.137283Z :GRPC_SERVER DEBUG: [0x61a00014be80] created request Name# ExecuteYql
2025-10-26T18:38:47.137898Z :GRPC_SERVER DEBUG: [0x61a00014c480] created streaming request Name# StreamExecuteYql
2025-10-26T18:38:47.138449Z :GRPC_SERVER DEBUG: [0x61a00014ca80] created request Name# ExplainYql
2025-10-26T18:38:47.139148Z :GRPC_SERVER DEBUG: [0x61a00014d080] created request Name# MakeDirectory
2025-10-26T18:38:47.139690Z :GRPC_SERVER DEBUG: [0x61a00014d680] created request Name# RemoveDirectory
2025-10-26T18:38:47.140336Z :GRPC_SERVER DEBUG: [0x61a00014dc80] created request Name# ListDirectory
2025-10-26T18:38:47.140864Z :GRPC_SERVER DEBUG: [0x61a00014e280] created request Name# DescribePath
2025-10-26T18:38:47.141449Z :GRPC_SERVER DEBUG: [0x61a00014e880] created request Name# ModifyPermissions
2025-10-26T18:38:47.142025Z :GRPC_SERVER DEBUG: [0x61a00014ee80] created request Name# GetOperation
2025-10-26T18:38:47.142580Z :GRPC_SERVER DEBUG: [0x61a00014f480] created request Name# CancelOperation
2025-10-26T18:38:47.143089Z :GRPC_SERVER DEBUG: [0x61a00015fc80] created request Name# ForgetOperation
2025-10-26T18:38:47.143603Z :GRPC_SERVER DEBUG: [0x61a000160280] created request Name# ListOperations
2025-10-26T18:38:47.144211Z :GRPC_SERVER DEBUG: [0x61a000160880] created request Name# ExportToYt
2025-10-26T18:38:47.144814Z :GRPC_SERVER DEBUG: [0x61a000160e80] created request Name# ExportToS3
2025-10-26T18:38:47.145465Z :GRPC_SERVER DEBUG: [0x61a000161480] created request Name# ImportFromS3
2025-10-26T18:38:47.145947Z :GRPC_SERVER DEBUG: [0x61a000161a80] created request Name# ImportData
2025-10-26T18:38:47.146377Z :GRPC_SERVER DEBUG: [0x61a000162080] created request Name# Coordination/CreateNode
2025-10-26T18:38:47.146823Z :GRPC_SERVER DEBUG: [0x61a000162680] created request Name# Coordination/AlterNode
2025-10-26T18:38:47.147357Z :GRPC_SERVER DEBUG: [0x61a000162c80] created request Name# Coordination/DropNode
2025-10-26T18:38:47.147889Z :GRPC_SERVER DEBUG: [0x61a000163280] created request Name# Coordination/DescribeNode
2025-10-26T18:38:47.157791Z :BS_PROXY_DISCOVER WARN: [e90cccf663462ec5] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T18:38:47.167457Z :TX_MEDIATOR NOTICE: tablet# 72075186224037893 actor# [50000:7565601761947656522:8194] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T18:38:47.177283Z :GRPC_SERVER INFO: Updated app config
2025-10-26T18:38:47.177350Z :GRPC_SERVER INFO: Updated app config
2025-10-26T18:38:47.177504Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828672, Sender [50000:7565601761947656403:4114], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTablet::TEvBoot
2025-10-26T18:38:47.178710Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828673, Sender [50000:7565601761947656403:4114], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTablet::TEvRestored
2025-10-26T18:38:47.179041Z :FLAT_TX_SCHEMESHARD NOTICE: BackgroundCompactionQueue configured: Timeout# 600.000000s, compact single parted# no, Rate# 1, WakeupInterval# 60.000000s, RoundInterval# 172800.000000s, InflightLimit# 1, MinCompactionRepeatDelaySeconds# 600.000000s, MaxRate# 1
2025-10-26T18:38:47.179106Z :FLAT_TX_SCHEMESHARD NOTICE: BorrowedCompactionQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T18:38:47.179138Z :FLAT_TX_SCHEMESHARD NOTICE: StatsBatching config: StatsBatchTimeout# 0.100000s, StatsMaxBatchSize# 100, StatsMaxExecuteTime# 0.010000s
2025-10-26T18:38:47.179163Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: using default configuration
2025-10-26T18:38:47.179196Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxMergeTablePartition, limit 10000
2025-10-26T18:38:47.179214Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxSplitTablePartition, limit 10000
2025-10-26T18:38:47.179241Z :FLAT_TX_SCHEMESHARD NOTICE: BackgroundCleaningQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T18:38:47.179599Z :FLAT_TX_SCHEMESHARD DEBUG: TxInitSchema.Execute
2025-10-26T18:38:47.198499Z :STATISTICS WARN: [72075186224037897] TTxInit::Complete. EnableColumnStatistics=false
2025-10-26T18:38:47.205885Z :GRPC_SERVER DEBUG: [0x61a000163e80] created request Name# PersQueueService/GetReadSessionsInfo
2025-10-26T18:38:47.206605Z :GRPC_SERVER DEBUG: [0x61a000164480] created request Name# PersQueueService/DropTopic
2025-10-26T18:38:47.207237Z :GRPC_SERVER DEBUG: [0x61a000164a80] created request Name# PersQueueService/CreateTopic
2025-10-26T18:38:47.207884Z :GRPC_SERVER DEBUG: [0x61a000165080] created request Name# PersQueueService/AlterTopic
2025-10-26T18:38:47.208570Z :GRPC_SERVER DEBUG: [0x61a000165680] created request Name# PersQueueService/DescribeTopic
2025-10-26T18:38:47.209282Z :GRPC_SERVER DEBUG: [0x61a000165c80] created request Name# PersQueueService/AddReadRule
2025-10-26T18:38:47.210034Z :GRPC_SERVER DEBUG: [0x61a000166280] created request Name# PersQueueService/RemoveReadRule
2025-10-26T18:38:47.212620Z :GRPC_SERVER DEBUG: [0x61a000166880] created request Name# TopicService/CommitOffset
2025-10-26T18:38:47.213415Z :GRPC_SERVER DEBUG: [0x61a000166e80] created request Name# TopicService/DropTopic
2025-10-26T18:38:47.214071Z :GRPC_SERVER DEBUG: [0x61a000167480] created request Name# TopicService/CreateTopic
2025-10-26T18:38:47.214758Z :GRPC_SERVER DEBUG: [0x61a000167a80] created request Name# TopicService/AlterTopic
2025-10-26T18:38:47.215493Z :GRPC_SERVER DEBUG: [0x61a000168080] created request Name# TopicService/DescribeTopic
2025-10-26T18:38:47.216286Z :GRPC_SERVER DEBUG: [0x61a000168680] created request Name# TopicService/DescribeConsumer
2025-10-26T18:38:47.217027Z :GRPC_SERVER DEBUG: [0x61a000168c80] created request Name# TopicService/DescribePartition
2025-10-26T18:38:47.217813Z :GRPC_SERVER DEBUG: [0x61a000169280] created request Name# UpdateOffsetsInTransaction
2025-10-26T18:38:47.218910Z :GRPC_SERVER DEBUG: [0x61a000169880] created request Name# DiscoverClusters
2025-10-26T18:38:47.219440Z :GRPC_SERVER DEBUG: [0x61a000169e80] created request Name# CreateDatabase
2025-10-26T18:38:47.220014Z :GRPC_SERVER DEBUG: [0x61a00016a480] created request Name# AlterDatabase
2025-10-26T18:38:47.220652Z :GRPC_SERVER DEBUG: [0x61a00016aa80] created request Name# GetDatabaseStatus
2025-10-26T18:38:47.221332Z :GRPC_SERVER DEBUG: [0x61a00016b080] created request Name# ListDatabases
2025-10-26T18:38:47.221960Z :GRPC_SERVER DEBUG: [0x61a00016b680] created request Name# RemoveDatabase
2025-10-26T18:38:47.222580Z :GRPC_SERVER DEBUG: [0x61a00016bc80] created request Name# DescribeDatabaseOptions
2025-10-26T18:38:47.223195Z :GRPC_SERVER DEBUG: [0x61a00016c280] created request Name# GetScaleRecommendation
2025-10-26T18:38:47.223778Z :GRPC_SERVER DEBUG: [0x61a00016c880] created request Name# SetConfig
2025-10-26T18:38:47.224477Z :GRPC_SERVER DEBUG: [0x61a00016ce80] created request Name# ReplaceConfig
2025-10-26T18:38:47.225117Z :GRPC_SERVER DEBUG: [0x61a00016d480] created request Name# DropConfig
2025-10-26T18:38:47.225644Z :GRPC_SERVER DEBUG: [0x61a00016da80] created request Name# AddVolatileConfig
2025-10-26T18:38:47.226211Z :GRPC_SERVER DEBUG: [0x61a00016e080] created request Name# RemoveVolatileConfig
2025-10-26T18:38:47.226742Z :GRPC_SERVER DEBUG: [0x61a00016e680] created request Name# GetConfig
2025-10-26T18:38:47.227181Z :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/70hy/00109e/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk0/testing_out_stuff/netData.tsv
2025-10-26T18:38:47.227229Z :GRPC_SERVER DEBUG: [0x61a00016ec80] created request Name# GetMetadata
2025-10-26T18:38:47.227232Z :NET_CLASSIFIER WARN: will try to initialize from file: /home/runner/.ya/build/build_root/70hy/00109e/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk0/testing_out_stuff/netData.tsv
2025-10-26T18:38:47.227364Z :NET_CLASSIFIER WARN: successfully initialized from file: /home/runner/.ya/build/build_root/70hy/00109e/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk0/testing_out_stuff/netData.tsv
2025-10-26T18:38:47.227562Z :GRPC_SERVER DEBUG: [0x61a00016f280] created request Name# GetNodeLabels
2025-10-26T18:38:47.227596Z :NET_CLASSIFIER ERROR: got bad distributable configuration
2025-10-26T18:38:47.228015Z :GRPC_SERVER DEBUG: [0x61a00016fe80] created request Name# ResolveConfig
2025-10-26T18:38:47.228463Z :GRPC_SERVER DEBUG: [0x61a000170480] created request Name# ResolveAllConfig
2025-10-26T18:38:47.228949Z :GRPC_SERVER DEBUG: [0x61a000170a80] created request Name# WhoAmI
2025-10-26T18:38:47.229432Z :GRPC_SERVER DEBUG: [0x61a000171080] created request Name# NodeRegistration
2025-10-26T18:38:47.229922Z :GRPC_SERVER DEBUG: [0x61a000171680] created request Name# ListEndpoints
2025-10-26T18:38:47.230372Z :GRPC_SERVER DEBUG: [0x61a000171c80] created request Name# RateLimiter/CreateResource
2025-10-26T18:38:47.230823Z :GRPC_SERVER DEBUG: [0x61a000172280] created request Name# RateLimiter/AlterResource
2025-10-26T18:38:47.231313Z :GRPC_SERVER DEBUG: [0x61a000172880] created request Name# RateLimiter/DropResource
2025-10-26T18:38:47.231820Z :GRPC_SERVER DEBUG: [0x61a000172e80] created request Name# RateLimiter/ListResources
2025-10-26T18:38:47.232294Z :GRPC_SERVER DEBUG: [0x61a000173480] created request Name# RateLimiter/DescribeResource
2025-10-26T18:38:47.232723Z :GRPC_SERVER DEBUG: [0x61a000173a80] created request Name# RateLimiter/AcquireResource
2025-10-26T18:38:47.233215Z :GRPC_SERVER DEBUG: [0x61a000174080] created request Name# SelfCheck
2025-10-26T18:38:47.233752Z :GRPC_SERVER DEBUG: [0x61a000174680] created request Name# NodeCheck
2025-10-26T18:38:47.234280Z :GRPC_SERVER DEBUG: [0x61a000174c80] created request Name# Login
2025-10-26T18:38:47.234757Z :GRPC_SERVER DEBUG: [0x61a000175280] created request Name# DescribeStream
2025-10-26T18:38:47.235270Z :GRPC_SERVER DEBUG: [0x61a000175880] created request Name# CreateStream
2025-10-26T18:38:47.235783Z :GRPC_SERVER DEBUG: [0x61a000175e80] created request Name# ListStreams
2025-10-26T18:38:47.236192Z :GRPC_SERVER DEBUG: [0x61a000176480] created request Name# DeleteStream
2025-10-26T18:38:47.236754Z :GRPC_SERVER DEBUG: [0x61a000176a80] created request Name# ListShards
2025-10-26T18:38:47.237361Z :GRPC_SERVER DEBUG: [0x61a000177080] created request Name# PutRecord
2025-10-26T18:38:47.237653Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828684, Sender [50000:7565601761947656403:4114], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-26T18:38:47.237822Z :GRPC_SERVER DEBUG: [0x61a000177680] created request Name# PutRecords
2025-10-26T18:38:47.238157Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 273481729, Sender [50000:7565601757652688983:4109], Recipient [50000:7565601761947656614:57]: NKikimr::NConsole::TEvConfigsDispatcher::TEvSetConfigSubscriptionResponse
2025-10-26T18:38:47.238189Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, processing event NConsole::TEvConfigsDispatcher::TEvSetConfigSubscriptionResponse
2025-10-26T18:38:47.238213Z :FLAT_TX_SCHEMESHARD NOTICE: Subscription to Console has been set up, schemeshardId: 72075186224037889
2025-10-26T18:38:47.238321Z :FLAT_TX_SCHEMESHARD DEBUG: TxInitSchema.Complete
2025-10-26T18:38:47.238351Z :GRPC_SERVER DEBUG: [0x61a000177c80] created request Name# GetRecords
2025-10-26T18:38:47.238836Z :GRPC_SERVER DEBUG: [0x61a000178280] created request Name# GetShardIterator
2025-10-26T18:38:47.239343Z :GRPC_SERVER DEBUG: [0x61a000178880] created streaming request Name# SubscribeToShard
2025-10-26T18:38:47.239802Z :GRPC_SERVER DEBUG: [0x61a000178e80] created request Name# DescribeLimits
2025-10-26T18:38:47.240241Z :TX_MEDIATOR NOTICE: tablet# 72075186224037894 actor# [50000:7565601761947656520:8193] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T18:38:47.240286Z :GRPC_SERVER DEBUG: [0x61a000179480] created request Name# DescribeStreamSummary
2025-10-26T18:38:47.240712Z :GRPC_SERVER DEBUG: [0x61a000179a80] created request Name# DecreaseStreamRetentionPeriod
2025-10-26T18:38:47.241200Z :GRPC_SERVER DEBUG: [0x61a00017a080] created request Name# IncreaseStreamRetentionPeriod
2025-10-26T18:38:47.241699Z :GRPC_SERVER DEBUG: [0x61a00017a680] created request Name# UpdateShardCount
2025-10-26T18:38:47.242157Z :GRPC_SERVER DEBUG: [0x61a00017ac80] created request Name# UpdateStreamMode
2025-10-26T18:38:47.242806Z :GRPC_SERVER DEBUG: [0x61a00017b280] created request Name# RegisterStreamConsumer
2025-10-26T18:38:47.243282Z :GRPC_SERVER DEBUG: [0x61a00017b880] created request Name# DeregisterStreamConsumer
2025-10-26T18:38:47.243814Z :GRPC_SERVER DEBUG: [0x61a00017be80] created request Name# DescribeStreamConsumer
2025-10-26T18:38:47.244348Z :GRPC_SERVER DEBUG: [0x61a00017c480] created request Name# ListStreamConsumers
2025-10-26T18:38:47.244798Z :GRPC_SERVER DEBUG: [0x61a00017ca80] created request Name# AddTagsToStream
2025-10-26T18:38:47.245348Z :GRPC_SERVER DEBUG: [0x61a00017d080] created request Name# DisableEnhancedMonitoring
2025-10-26T18:38:47.245832Z :GRPC_SERVER DEBUG: [0x61a00017d680] created request Name# EnableEnhancedMonitoring
2025-10-26T18:38:47.246340Z :GRPC_SERVER DEBUG: [0x61a00017dc80] created request Name# ListTagsForStream
2025-10-26T18:38:47.246782Z :GRPC_SERVER DEBUG: [0x61a00017e280] created request Name# MergeShards
2025-10-26T18:38:47.247275Z :GRPC_SERVER DEBUG: [0x61a00017e880] created request Name# RemoveTagsFromStream
2025-10-26T18:38:47.247658Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 273285138, Sender [50000:7565601757652688983:4109], Recipient [50000:7565601761947656614:57]: NKikimr::NConsole::TEvConsole::TEvConfigNotificationRequest { Config { FeatureFlags { EnablePersistentQueryStats: true EnableMvccSnapshotReads: true EnableSchemeTransactionsAtSchemeShard: true EnablePublicApiExternalBlobs: false } TableProfilesConfig { TableProfiles { Name: "default" CompactionPolicy: "default" ExecutionPolicy: "default" PartitioningPolicy: "default" StoragePolicy: "default" ReplicationPolicy: "default" CachingPolicy: "default" } TableProfiles { Name: "log_lz4" CompactionPolicy: "default" ExecutionPolicy: "default" PartitioningPolicy: "default" StoragePolicy: "log_lz4" ReplicationPolicy: "default" CachingPolicy: "default" } CompactionPolicies { Name: "default" } ExecutionPolicies { Name: "default" } PartitioningPolicies { Name: "default" AutoSplit: true AutoMerge: false SizeToSplit: 2147483648 } StoragePolicies { Name: "log_lz4" ColumnFamilies { ColumnCodec: ColumnCodecLZ4 StorageConfig { SysLog { PreferredPoolKind: "hdd" } Log { PreferredPoolKind: "hdd" } Data { Prefe
2025-10-26T18:38:47.247818Z :GRPC_SERVER DEBUG: [0x61a00017ee80] created request Name# SplitShard
2025-10-26T18:38:47.247986Z :FLAT_TX_SCHEMESHARD INFO: Got new config: FeatureFlags { EnablePersistentQueryStats: true EnableMvccSnapshotReads: true EnableSchemeTransactionsAtSchemeShard: true EnablePublicApiExternalBlobs: false } TableProfilesConfig { TableProfiles { Name: "default" CompactionPolicy: "default" ExecutionPolicy: "default" PartitioningPolicy: "default" StoragePolicy: "default" ReplicationPolicy: "default" CachingPolicy: "default" } TableProfiles { Name: "log_lz4" CompactionPolicy: "default" ExecutionPolicy: "default" PartitioningPolicy: "default" StoragePolicy: "log_lz4" ReplicationPolicy: "default" CachingPolicy: "default" } CompactionPolicies { Name: "default" } ExecutionPolicies { Name: "default" } PartitioningPolicies { Name: "default" AutoSplit: true AutoMerge: false SizeToSplit: 2147483648 } StoragePolicies { Name: "log_lz4" ColumnFamilies { ColumnCodec: ColumnCodecLZ4 StorageConfig { SysLog { PreferredPoolKind: "hdd" } Log { PreferredPoolKind: "hdd" } Data { PreferredPoolKind: "hdd" } } } } StoragePolicies { Name: "default" ColumnFamilies { StorageConfig { SysLog { PreferredPoolKind: "hdd" } Log { PreferredPoolKind: "hdd" } Data { PreferredPoolKind: "hdd" } } } } ReplicationPolicies { Name: "default" } CachingPolicies { Name: "default" } }
2025-10-26T18:38:47.248013Z :IMPORT NOTICE: Load table profiles
2025-10-26T18:38:47.248150Z :FLAT_TX_SCHEMESHARD TRACE: Send TEvConfigNotificationResponse: SubscriptionId: 0 ConfigId { }
2025-10-26T18:38:47.248272Z :GRPC_SERVER DEBUG: [0x61a00017f480] created request Name# StartStreamEncryption
2025-10-26T18:38:47.248549Z :FLAT_TX_SCHEMESHARD DEBUG: TTxUpgradeSchema.Execute
2025-10-26T18:38:47.248694Z :FLAT_TX_SCHEMESHARD NOTICE: UpgradeInitState as Uninitialized, schemeshardId: 72075186224037889
2025-10-26T18:38:47.248878Z :GRPC_SERVER DEBUG: [0x61a00018fc80] created request Name# StopStreamEncryption
2025-10-26T18:38:47.249560Z :GRPC_SERVER DEBUG: [0x61a000190280] created request Name# UpdateStream
2025-10-26T18:38:47.250082Z :GRPC_SERVER DEBUG: [0x61a000190880] created request Name# SetWriteQuota
2025-10-26T18:38:47.250570Z :GRPC_SERVER DEBUG: [0x61a000190e80] created request Name# CreateQuery
2025-10-26T18:38:47.251017Z :GRPC_SERVER DEBUG: [0x61a000191480] created request Name# ListQueries
2025-10-26T18:38:47.251390Z :FLAT_TX_SCHEMESHARD DEBUG: TTxUpgradeSchema.Complete
2025-10-26T18:38:47.251535Z :GRPC_SERVER DEBUG: [0x61a000191a80] created request Name# DescribeQuery
2025-10-26T18:38:47.251567Z :FLAT_TX_SCHEMESHARD INFO: Clear TempDirsState with owners number: 0
2025-10-26T18:38:47.252049Z :GRPC_SERVER DEBUG: [0x61a000192080] created request Name# GetQueryStatus
2025-10-26T18:38:47.252586Z :GRPC_SERVER DEBUG: [0x61a000192680] created request Name# ModifyQuery
2025-10-26T18:38:47.252686Z :FLAT_TX_SCHEMESHARD NOTICE: TTxInit, SS hasn't been configured yet, state: 1, at schemeshard: 72075186224037889
2025-10-26T18:38:47.252753Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:47.253128Z :GRPC_SERVER DEBUG: [0x61a000192c80] created request Name# DeleteQuery
2025-10-26T18:38:47.253596Z :GRPC_SERVER DEBUG: [0x61a000193280] created request Name# ControlQuery
2025-10-26T18:38:47.254096Z :GRPC_SERVER DEBUG: [0x61a000193880] created request Name# GetResultData
2025-10-26T18:38:47.254637Z :GRPC_SERVER DEBUG: [0x61a000193e80] created request Name# ListJobs
2025-10-26T18:38:47.255054Z :GRPC_SERVER DEBUG: [0x61a000194480] created request Name# DescribeJob
2025-10-26T18:38:47.255557Z :GRPC_SERVER DEBUG: [0x61a000194a80] created request Name# CreateConnection
2025-10-26T18:38:47.256071Z :GRPC_SERVER DEBUG: [0x61a000195080] created request Name# ListConnections
2025-10-26T18:38:47.256517Z :GRPC_SERVER DEBUG: [0x61a000195680] created request Name# DescribeConnection
2025-10-26T18:38:47.256988Z :GRPC_SERVER DEBUG: [0x61a000195c80] created request Name# ModifyConnection
2025-10-26T18:38:47.257479Z :GRPC_SERVER DEBUG: [0x61a000196280] created request Name# DeleteConnection
2025-10-26T18:38:47.257963Z :GRPC_SERVER DEBUG: [0x61a000196880] created request Name# TestConnection
2025-10-26T18:38:47.258417Z :GRPC_SERVER DEBUG: [0x61a000196e80] created request Name# CreateBinding
2025-10-26T18:38:47.258839Z :GRPC_SERVER DEBUG: [0x61a000197480] created request Name# ListBindings
2025-10-26T18:38:47.259207Z :GRPC_SERVER DEBUG: [0x61a000197a80] created request Name# DescribeBinding
2025-10-26T18:38:47.259591Z :GRPC_SERVER DEBUG: [0x61a000198080] created request Name# ModifyBinding
2025-10-26T18:38:47.260067Z :GRPC_SERVER DEBUG: [0x61a000198680] created request Name# DeleteBinding
2025-10-26T18:38:47.260570Z :GRPC_SERVER DEBUG: [0x61a000198c80] created request Name# PingTask
2025-10-26T18:38:47.261103Z :GRPC_SERVER DEBUG: [0x61a000199280] created request Name# GetTask
2025-10-26T18:38:47.261552Z :GRPC_SERVER DEBUG: [0x61a000199880] created request Name# WriteTaskResult
2025-10-26T18:38:47.262011Z :GRPC_SERVER DEBUG: [0x61a000199e80] created request Name# NodesHealthCheck
2025-10-26T18:38:47.262464Z :GRPC_SERVER DEBUG: [0x61a00019a480] created request Name# CreateRateLimiterResource
2025-10-26T18:38:47.262849Z :GRPC_SERVER DEBUG: [0x61a00019aa80] created request Name# DeleteRateLimiterResource
2025-10-26T18:38:47.263423Z :GRPC_SERVER DEBUG: [0x61a00019b080] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.263760Z :GRPC_SERVER DEBUG: [0x61a00019b680] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.264045Z :GRPC_SERVER DEBUG: [0x61a00019bc80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.264393Z :GRPC_SERVER DEBUG: [0x61a00019c280] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.264707Z :GRPC_SERVER DEBUG: [0x61a00019c880] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.265034Z :GRPC_SERVER DEBUG: [0x61a00019ce80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.265221Z :GRPC_SERVER DEBUG: [0x61a00019d480] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.265454Z :GRPC_SERVER DEBUG: [0x61a00019da80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.265795Z :GRPC_SERVER DEBUG: [0x61a00019e080] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.265953Z :GRPC_SERVER DEBUG: [0x61a00019e680] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.266162Z :GRPC_SERVER DEBUG: [0x61a00019ec80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.266353Z :GRPC_SERVER DEBUG: [0x61a00019f280] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.266529Z :GRPC_SERVER DEBUG: [0x61a00019fe80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.266709Z :GRPC_SERVER DEBUG: [0x61a0001a0480] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.266937Z :GRPC_SERVER DEBUG: [0x61a0001a0a80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.267126Z :GRPC_SERVER DEBUG: [0x61a0001a1080] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.267301Z :GRPC_SERVER DEBUG: [0x61a0001a1680] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.267623Z :GRPC_SERVER DEBUG: [0x61a0001a1c80] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.267896Z :GRPC_SERVER DEBUG: [0x61a0001a2280] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.268134Z :GRPC_SERVER DEBUG: [0x61a0001a2880] created streaming request Name# ExecuteQuery
2025-10-26T18:38:47.268539Z :GRPC_SERVER DEBUG: [0x61a0001a2e80] created request Name# ExecuteScript
2025-10-26T18:38:47.268769Z :GRPC_SERVER DEBUG: [0x61a0001a3480] created request Name# ExecuteScript
2025-10-26T18:38:47.268977Z :GRPC_SERVER DEBUG: [0x61a0001a3a80] created request Name# ExecuteScript
2025-10-26T18:38:47.269169Z :GRPC_SERVER DEBUG: [0x61a0001a4080] created request Name# ExecuteScript
2025-10-26T18:38:47.269413Z :GRPC_SERVER DEBUG: [0x61a0001a4680] created request Name# ExecuteScript
2025-10-26T18:38:47.269599Z :GRPC_SERVER DEBUG: [0x61a0001a4c80] created request Name# ExecuteScript
2025-10-26T18:38:47.269781Z :GRPC_SERVER DEBUG: [0x61a0001a5280] created request Name# ExecuteScript
2025-10-26T18:38:47.269954Z :GRPC_SERVER DEBUG: [0x61a0001a5880] created request Name# ExecuteScript
2025-10-26T18:38:47.270094Z :GRPC_SERVER DEBUG: [0x61a0001a5e80] created request Name# ExecuteScript
2025-10-26T18:38:47.270314Z :GRPC_SERVER DEBUG: [0x61a0001a6480] created request Name# ExecuteScript
2025-10-26T18:38:47.270461Z :GRPC_SERVER DEBUG: [0x61a0001a6a80] created request Name# ExecuteScript
2025-10-26T18:38:47.270658Z :GRPC_SERVER DEBUG: [0x61a0001a7080] created request Name# ExecuteScript
2025-10-26T18:38:47.270830Z :GRPC_SERVER DEBUG: [0x61a0001a7680] created request Name# ExecuteScript
2025-10-26T18:38:47.271003Z :GRPC_SERVER DEBUG: [0x61a0001a7c80] created request Name# ExecuteScript
2025-10-26T18:38:47.271178Z :GRPC_SERVER DEBUG: [0x61a0001a8280] created request Name# ExecuteScript
2025-10-26T18:38:47.271353Z :GRPC_SERVER DEBUG: [0x61a0001a8880] created request Name# ExecuteScript
2025-10-26T18:38:47.271552Z :GRPC_SERVER DEBUG: [0x61a0001a8e80] created request Name# ExecuteScript
2025-10-26T18:38:47.271791Z :GRPC_SERVER DEBUG: [0x61a0001a9480] created request Name# ExecuteScript
2025-10-26T18:38:47.271964Z :GRPC_SERVER DEBUG: [0x61a0001a9a80] created request Name# ExecuteScript
2025-10-26T18:38:47.272143Z :GRPC_SERVER DEBUG: [0x61a0001aa080] created request Name# ExecuteScript
2025-10-26T18:38:47.272548Z :GRPC_SERVER DEBUG: [0x61a0001aa680] created request Name# FetchScriptResults
2025-10-26T18:38:47.272770Z :GRPC_SERVER DEBUG: [0x61a0001aac80] created request Name# FetchScriptResults
2025-10-26T18:38:47.272965Z :GRPC_SERVER DEBUG: [0x61a0001ab280] created request Name# FetchScriptResults
2025-10-26T18:38:47.273144Z :GRPC_SERVER DEBUG: [0x61a0001ab880] created request Name# FetchScriptResults
2025-10-26T18:38:47.273291Z :GRPC_SERVER DEBUG: [0x61a0001abe80] created request Name# FetchScriptResults
2025-10-26T18:38:47.273449Z :GRPC_SERVER DEBUG: [0x61a0001ac480] created request Name# FetchScriptResults
2025-10-26T18:38:47.273623Z :GRPC_SERVER DEBUG: [0x61a0001aca80] created request Name# FetchScriptResults
2025-10-26T18:38:47.273901Z :GRPC_SERVER DEBUG: [0x61a0001ad080] created request Name# FetchScriptResults
2025-10-26T18:38:47.274078Z :GRPC_SERVER DEBUG: [0x61a0001ad680] created request Name# FetchScriptResults
2025-10-26T18:38:47.274312Z :GRPC_SERVER DEBUG: [0x61a0001adc80] created request Name# FetchScriptResults
2025-10-26T18:38:47.274485Z :GRPC_SERVER DEBUG: [0x61a0001ae280] created request Name# FetchScriptResults
2025-10-26T18:38:47.274641Z :GRPC_SERVER DEBUG: [0x61a0001ae880] created request Name# FetchScriptResults
2025-10-26T18:38:47.274822Z :GRPC_SERVER DEBUG: [0x61a0001aee80] created request Name# FetchScriptResults
2025-10-26T18:38:47.274988Z :GRPC_SERVER DEBUG: [0x61a0001af480] created request Name# FetchScriptResults
2025-10-26T18:38:47.275193Z :GRPC_SERVER DEBUG: [0x61a0001b0080] created request Name# FetchScriptResults
2025-10-26T18:38:47.275394Z :GRPC_SERVER DEBUG: [0x61a0001b0680] created request Name# FetchScriptResults
2025-10-26T18:38:47.275564Z :GRPC_SERVER DEBUG: [0x61a0001b0c80] created request Name# FetchScriptResults
2025-10-26T18:38:47.275736Z :GRPC_SERVER DEBUG: [0x61a0001b1280] created request Name# FetchScriptResults
2025-10-26T18:38:47.275897Z :GRPC_SERVER DEBUG: [0x61a0001b1880] created request Name# FetchScriptResults
2025-10-26T18:38:47.276068Z :GRPC_SERVER DEBUG: [0x61a0001b1e80] created request Name# FetchScriptResults
2025-10-26T18:38:47.276672Z :GRPC_SERVER DEBUG: [0x61a0001b2480] created request Name# CreateSession
2025-10-26T18:38:47.277024Z :GRPC_SERVER DEBUG: [0x61a0001b2a80] created request Name# CreateSession
2025-10-26T18:38:47.277350Z :GRPC_SERVER DEBUG: [0x61a0001b3080] created request Name# CreateSession
2025-10-26T18:38:47.277599Z :GRPC_SERVER DEBUG: [0x61a0001b3680] created request Name# CreateSession
2025-10-26T18:38:47.277831Z :GRPC_SERVER DEBUG: [0x61a0001b3c80] created request Name# CreateSession
2025-10-26T18:38:47.278008Z :GRPC_SERVER DEBUG: [0x61a0001b4280] created request Name# CreateSession
2025-10-26T18:38:47.278256Z :GRPC_SERVER DEBUG: [0x61a0001b4880] created request Name# CreateSession
2025-10-26T18:38:47.278469Z :GRPC_SERVER DEBUG: [0x61a0001b4e80] created request Name# CreateSession
2025-10-26T18:38:47.278590Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 269877761, Sender [50000:7565601761947656745:62], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:47.278662Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:47.278693Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T18:38:47.278775Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 271124999, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:47.278786Z :GRPC_SERVER DEBUG: [0x61a0001b5480] created request Name# CreateSession
2025-10-26T18:38:47.278826Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:47.279033Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 271125001, Sender [1:7565601737253325352:70], Recipient [50000:7565601761947656745:62]
2025-10-26T18:38:47.279060Z :GRPC_SERVER DEBUG: [0x61a0001b5a80] created request Name# CreateSession
2025-10-26T18:38:47.279082Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvSchemeShard::TEvInitTenantSchemeShard
2025-10-26T18:38:47.279318Z :GRPC_SERVER DEBUG: [0x61a0001b6080] created request Name# CreateSession
2025-10-26T18:38:47.279572Z :GRPC_SERVER DEBUG: [0x61a0001b6680] created request Name# CreateSession
2025-10-26T18:38:47.279836Z :GRPC_SERVER DEBUG: [0x61a0001b6c80] created request Name# CreateSession
2025-10-26T18:38:47.280056Z :GRPC_SERVER DEBUG: [0x61a0001b7280] created request Name# CreateSession
2025-10-26T18:38:47.280347Z :GRPC_SERVER DEBUG: [0x61a0001b7880] created request Name# CreateSession
2025-10-26T18:38:47.280603Z :GRPC_SERVER DEBUG: [0x61a0001b7e80] created request Name# CreateSession
2025-10-26T18:38:47.280851Z :GRPC_SERVER DEBUG: [0x61a0001b8480] created request Name# CreateSession
2025-10-26T18:38:47.281074Z :GRPC_SERVER DEBUG: [0x61a0001b8a80] created request Name# CreateSession
2025-10-26T18:38:47.281391Z :GRPC_SERVER DEBUG: [0x61a0001b9080] created request Name# CreateSession
2025-10-26T18:38:47.281669Z :GRPC_SERVER DEBUG: [0x61a0001b9680] created request Name# CreateSession
2025-10-26T18:38:47.282306Z :GRPC_SERVER DEBUG: [0x61a0001b9c80] created request Name# DeleteSession
2025-10-26T18:38:47.282675Z :GRPC_SERVER DEBUG: [0x61a0001ba280] created request Name# DeleteSession
2025-10-26T18:38:47.282905Z :GRPC_SERVER DEBUG: [0x61a0001ba880] created request Name# DeleteSession
2025-10-26T18:38:47.283115Z :GRPC_SERVER DEBUG: [0x61a0001bae80] created request Name# DeleteSession
2025-10-26T18:38:47.283399Z :GRPC_SERVER DEBUG: [0x61a0001bb480] created request Name# DeleteSession
2025-10-26T18:38:47.283651Z :GRPC_SERVER DEBUG: [0x61a0001bba80] created request Name# DeleteSession
2025-10-26T18:38:47.283895Z :GRPC_SERVER DEBUG: [0x61a0001bc080] created request Name# DeleteSession
2025-10-26T18:38:47.284112Z :GRPC_SERVER DEBUG: [0x61a0001bc680] created request Name# DeleteSession
2025-10-26T18:38:47.284394Z :GRPC_SERVER DEBUG: [0x61a0001bcc80] created request Name# DeleteSession
2025-10-26T18:38:47.284662Z :GRPC_SERVER DEBUG: [0x61a0001bd280] created request Name# DeleteSession
2025-10-26T18:38:47.284894Z :GRPC_SERVER DEBUG: [0x61a0001bd880] created request Name# DeleteSession
2025-10-26T18:38:47.285176Z :GRPC_SERVER DEBUG: [0x61a0001bde80] created request Name# DeleteSession
2025-10-26T18:38:47.285454Z :GRPC_SERVER DEBUG: [0x61a0001be480] created request Name# DeleteSession
2025-10-26T18:38:47.285758Z :GRPC_SERVER DEBUG: [0x61a0001bea80] created request Name# DeleteSession
2025-10-26T18:38:47.286000Z :GRPC_SERVER DEBUG: [0x61a0001bf080] created request Name# DeleteSession
2025-10-26T18:38:47.286219Z :GRPC_SERVER DEBUG: [0x61a0001bf680] created request Name# DeleteSession
2025-10-26T18:38:47.286504Z :GRPC_SERVER DEBUG: [0x61a0001bfc80] created request Name# DeleteSession
2025-10-26T18:38:47.286791Z :FLAT_TX_SCHEMESHARD NOTICE: TEvInitTenantSchemeShard DoExecute, message: DomainSchemeShard: 72075186232723360 DomainPathId: 2 RootPath: "/Root/test_auditlog.py" Owner: "root@builtin" EffectiveACL: "\n\021\010\001\020\200\200\002\032\005USERS \003(\001\n\033\010\001\020\210\004\032\020METADATA-READERS \003(\001\n\026\010\001\020\001\032\014DATA-READERS \003(\001\n\026\010\001\020\006\032\014DATA-WRITERS \003(\001\n\025\010\001\020\360\n\032\nDDL-ADMINS \003(\001\n\030\010\001\020\200@\032\rACCESS-ADMINS \003(\001\n\032\010\001\020\2000\032\017DATABASE-ADMINS \003(\001" EffectiveACLVersion: 0 ProcessingParams { Version: 2 PlanResolution: 10 Coordinators: 72075186224037890 Coordinators: 72075186224037891 Coordinators: 72075186224037892 TimeCastBucketsPerMediator: 2 Mediators: 72075186224037893 Mediators: 72075186224037894 Mediators: 72075186224037895 SchemeShard: 72075186224037889 Hive: 72075186224037888 SysViewProcessor: 72075186224037896 StatisticsAggregator: 72075186224037897 } StoragePools { Name: "/Root/test_auditlog.py:hdd" Kind: "hdd" } UserAttributesVersion: 1 SchemeLimits { MaxDepth: 32 MaxPaths: 10000 MaxChildrenInDir: 100000 MaxAclBytesSize: 10240 MaxTableColumns: 200 MaxTableColumnNameLength: 255 MaxTableKeyColumns: 20 MaxTableIndices: 20 MaxShards: 200000 MaxShardsInPath: 35000 MaxConsistentCopyTargets: 10000 MaxPathElementLength: 255 ExtraPathSymbolsAllowed: "!\"#$%&\'()*+,-.:;<=>?@[\\]^_`{|}~" MaxPQPartitions: 1000000 MaxTableCdcStreams: 5 MaxExports: 10 MaxImports: 10 MaxColumnTableColumns: 10000 } ResourcesDomainOwnerId: 72075186232723360 ResourcesDomainPathId: 2, at schemeshard: 72075186224037889
2025-10-26T18:38:47.286807Z :GRPC_SERVER DEBUG: [0x61a0001c0280] created request Name# DeleteSession
2025-10-26T18:38:47.287029Z :GRPC_SERVER DEBUG: [0x61a0001c0880] created request Name# DeleteSession
2025-10-26T18:38:47.287114Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 0
2025-10-26T18:38:47.287257Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 1
2025-10-26T18:38:47.287334Z :GRPC_SERVER DEBUG: [0x61a0001c0e80] created request Name# DeleteSession
2025-10-26T18:38:47.287340Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 2
2025-10-26T18:38:47.287374Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 3
2025-10-26T18:38:47.287395Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 4
2025-10-26T18:38:47.287443Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 5
2025-10-26T18:38:47.287487Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 6
2025-10-26T18:38:47.287525Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 7
2025-10-26T18:38:47.287613Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 8
2025-10-26T18:38:47.287680Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 9
2025-10-26T18:38:47.287824Z :GRPC_SERVER DEBUG: [0x61a0001c1480] created streaming request Name# AttachSession
2025-10-26T18:38:47.288229Z :GRPC_SERVER DEBUG: [0x61a0001c1a80] created streaming request Name# AttachSession
2025-10-26T18:38:47.288566Z :GRPC_SERVER DEBUG: [0x61a0001c2080] created streaming request Name# AttachSession
2025-10-26T18:38:47.288833Z :GRPC_SERVER DEBUG: [0x61a0001c2680] created streaming request Name# AttachSession
2025-10-26T18:38:47.289035Z :GRPC_SERVER DEBUG: [0x61a0001c2c80] created streaming request Name# AttachSession
2025-10-26T18:38:47.289301Z :GRPC_SERVER DEBUG: [0x61a0001c3280] created streaming request Name# AttachSession
2025-10-26T18:38:47.289512Z :GRPC_SERVER DEBUG: [0x61a0001c3880] created streaming request Name# AttachSession
2025-10-26T18:38:47.289880Z :GRPC_SERVER DEBUG: [0x61a0001c3e80] created streaming request Name# AttachSession
2025-10-26T18:38:47.290149Z :GRPC_SERVER DEBUG: [0x61a0001c4480] created streaming request Name# AttachSession
2025-10-26T18:38:47.290443Z :GRPC_SERVER DEBUG: [0x61a0001c4a80] created streaming request Name# AttachSession
2025-10-26T18:38:47.290672Z :GRPC_SERVER DEBUG: [0x61a0001c5080] created streaming request Name# AttachSession
2025-10-26T18:38:47.290958Z :GRPC_SERVER DEBUG: [0x61a0001c5680] created streaming request Name# AttachSession
2025-10-26T18:38:47.291255Z :GRPC_SERVER DEBUG: [0x61a0001c5c80] created streaming request Name# AttachSession
2025-10-26T18:38:47.291257Z :FLAT_TX_SCHEMESHARD NOTICE: TEvInitTenantSchemeShard DoComplete, status: StatusSuccess, at schemeshard: 72075186224037889
2025-10-26T18:38:47.291444Z :FLAT_TX_SCHEMESHARD DEBUG: Send TEvSyncTenantSchemeShard, to parent: [OwnerId: 72075186232723360, LocalPathId: 2], from: 72075186224037889
2025-10-26T18:38:47.291547Z :GRPC_SERVER DEBUG: [0x61a0001c6280] created streaming request Name# AttachSession
2025-10-26T18:38:47.291686Z :GRPC_SERVER DEBUG: [0x61a0001c6880] created streaming request Name# AttachSession
2025-10-26T18:38:47.291916Z :GRPC_SERVER DEBUG: [0x61a0001c6e80] created streaming request Name# AttachSession
2025-10-26T18:38:47.292117Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435079, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvServerlessStorageBilling
2025-10-26T18:38:47.292142Z :GRPC_SERVER DEBUG: [0x61a0001c7480] created streaming request Name# AttachSession
2025-10-26T18:38:47.292172Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvServerlessStorageBilling
2025-10-26T18:38:47.292236Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T18:38:47.292278Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 0, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T18:38:47.292369Z :GRPC_SERVER DEBUG: [0x61a0001c7a80] created streaming request Name# AttachSession
2025-10-26T18:38:47.292397Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T18:38:47.292424Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 0, path id: 1
2025-10-26T18:38:47.292455Z :FLAT_TX_SCHEMESHARD DEBUG: TTxServerlessStorageBilling.Execute
2025-10-26T18:38:47.292519Z :FLAT_TX_SCHEMESHARD NOTICE: TTxServerlessStorageBilling: unable to make a bill, domain is not a serverless db, schemeshardId: 72075186224037889, domainId: [OwnerId: 72075186232723360, LocalPathId: 2]
2025-10-26T18:38:47.292550Z :FLAT_TX_SCHEMESHARD DEBUG: TTxServerlessStorageBilling.Complete
2025-10-26T18:38:47.292570Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:47.292574Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 0, is deletion# false, version: 4
2025-10-26T18:38:47.292781Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274399233, Sender [50000:7565601761947656715:57], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTxAllocatorClient::TEvAllocateResult
2025-10-26T18:38:47.292799Z :GRPC_SERVER DEBUG: [0x61a0001c8080] created streaming request Name# AttachSession
2025-10-26T18:38:47.292824Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxAllocatorClient::TEvAllocateResult
2025-10-26T18:38:47.292857Z :FLAT_TX_SCHEMESHARD INFO: Handle: TEvAllocateResult: Cookie# 0, at schemeshard: 72075186224037889
2025-10-26T18:38:47.292979Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565601761947656748:4145], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:47.292990Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656752:68] Successful handshake: replica# [1:7565601737253324789:4110]
2025-10-26T18:38:47.293010Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:47.293024Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656752:68] Start full sync: replica# [1:7565601737253324789:4110]
2025-10-26T18:38:47.293065Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186232723360, status: OK, at schemeshard: 72075186224037889
2025-10-26T18:38:47.293124Z :GRPC_SERVER DEBUG: [0x61a0001c8680] created streaming request Name# AttachSession
2025-10-26T18:38:47.293220Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565601761947656749:4184], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:47.293248Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:47.293264Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037897, status: OK, at schemeshard: 72075186224037889
2025-10-26T18:38:47.293588Z :GRPC_SERVER DEBUG: [0x61a0001c8c80] created request Name# BeginTransaction
2025-10-26T18:38:47.293839Z :GRPC_SERVER DEBUG: [0x61a0001c9280] created request Name# BeginTransaction
2025-10-26T18:38:47.294048Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.294073Z :GRPC_SERVER DEBUG: [0x61a0001c9880] created request Name# BeginTransaction
2025-10-26T18:38:47.294079Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.294089Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.294214Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.294314Z :GRPC_SERVER DEBUG: [0x61a0001c9e80] created request Name# BeginTransaction
2025-10-26T18:38:47.294449Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:47.294488Z :GRPC_SERVER DEBUG: [0x61a0001ca480] created request Name# BeginTransaction
2025-10-26T18:38:47.294537Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 0, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 4
2025-10-26T18:38:47.294577Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:47.294598Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:47.294672Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:47.294806Z :GRPC_SERVER DEBUG: [0x61a0001caa80] created request Name# BeginTransaction
2025-10-26T18:38:47.295088Z :GRPC_SERVER DEBUG: [0x61a0001cb080] created request Name# BeginTransaction
2025-10-26T18:38:47.295269Z :GRPC_SERVER DEBUG: [0x61a0001cb680] created request Name# BeginTransaction
2025-10-26T18:38:47.295445Z :GRPC_SERVER DEBUG: [0x61a0001cbc80] created request Name# BeginTransaction
2025-10-26T18:38:47.295585Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656754:4194][[OwnerId: 72075186232723360, LocalPathId: 2]] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:47.295640Z :GRPC_SERVER DEBUG: [0x61a0001cc280] created request Name# BeginTransaction
2025-10-26T18:38:47.295843Z :GRPC_SERVER DEBUG: [0x61a0001cc880] created request Name# BeginTransaction
2025-10-26T18:38:47.296001Z :GRPC_SERVER DEBUG: [0x61a0001cce80] created request Name# BeginTransaction
2025-10-26T18:38:47.296192Z :GRPC_SERVER DEBUG: [0x61a0001cd480] created request Name# BeginTransaction
2025-10-26T18:38:47.296397Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 4 }
2025-10-26T18:38:47.296446Z :GRPC_SERVER DEBUG: [0x61a0001cda80] created request Name# BeginTransaction
2025-10-26T18:38:47.296451Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:47.296522Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 4 PathOwnerId: 72075186224037889, cookie: 0
2025-10-26T18:38:47.296640Z :GRPC_SERVER DEBUG: [0x61a0001ce080] created request Name# BeginTransaction
2025-10-26T18:38:47.296845Z :GRPC_SERVER DEBUG: [0x61a0001ce680] created request Name# BeginTransaction
2025-10-26T18:38:47.297027Z :GRPC_SERVER DEBUG: [0x61a0001cec80] created request Name# BeginTransaction
2025-10-26T18:38:47.297187Z :GRPC_SERVER DEBUG: [0x61a0001cf280] created request Name# BeginTransaction
2025-10-26T18:38:47.297413Z :GRPC_SERVER DEBUG: [0x61a0001cfe80] created request Name# BeginTransaction
2025-10-26T18:38:47.297599Z :GRPC_SERVER DEBUG: [0x61a0001d0480] created request Name# BeginTransaction
2025-10-26T18:38:47.298000Z :GRPC_SERVER DEBUG: [0x61a0001d0a80] created request Name# CommitTransaction
2025-10-26T18:38:47.298234Z :GRPC_SERVER DEBUG: [0x61a0001d1080] created request Name# CommitTransaction
2025-10-26T18:38:47.298511Z :GRPC_SERVER DEBUG: [0x61a0001d1680] created request Name# CommitTransaction
2025-10-26T18:38:47.298706Z :GRPC_SERVER DEBUG: [0x61a0001d1c80] created request Name# CommitTransaction
2025-10-26T18:38:47.298901Z :GRPC_SERVER DEBUG: [0x61a0001d2280] created request Name# CommitTransaction
2025-10-26T18:38:47.299111Z :GRPC_SERVER DEBUG: [0x61a0001d2880] created request Name# CommitTransaction
2025-10-26T18:38:47.299294Z :GRPC_SERVER DEBUG: [0x61a0001d2e80] created request Name# CommitTransaction
2025-10-26T18:38:47.299510Z :GRPC_SERVER DEBUG: [0x61a0001d3480] created request Name# CommitTransaction
2025-10-26T18:38:47.299812Z :GRPC_SERVER DEBUG: [0x61a0001d3a80] created request Name# CommitTransaction
2025-10-26T18:38:47.300106Z :GRPC_SERVER DEBUG: [0x61a0001d4080] created request Name# CommitTransaction
2025-10-26T18:38:47.300386Z :GRPC_SERVER DEBUG: [0x61a0001d4680] created request Name# CommitTransaction
2025-10-26T18:38:47.300653Z :GRPC_SERVER DEBUG: [0x61a0001d4c80] created request Name# CommitTransaction
2025-10-26T18:38:47.300898Z :GRPC_SERVER DEBUG: [0x61a0001d5280] created request Name# CommitTransaction
2025-10-26T18:38:47.301189Z :GRPC_SERVER DEBUG: [0x61a0001d5880] created request Name# CommitTransaction
2025-10-26T18:38:47.301439Z :GRPC_SERVER DEBUG: [0x61a0001d5e80] created request Name# CommitTransaction
2025-10-26T18:38:47.301714Z :GRPC_SERVER DEBUG: [0x61a0001d6480] created request Name# CommitTransaction
2025-10-26T18:38:47.301963Z :GRPC_SERVER DEBUG: [0x61a0001d6a80] created request Name# CommitTransaction
2025-10-26T18:38:47.302255Z :GRPC_SERVER DEBUG: [0x61a0001d7080] created request Name# CommitTransaction
2025-10-26T18:38:47.302520Z :GRPC_SERVER DEBUG: [0x61a0001d7680] created request Name# CommitTransaction
2025-10-26T18:38:47.302774Z :GRPC_SERVER DEBUG: [0x61a0001d7c80] created request Name# CommitTransaction
2025-10-26T18:38:47.303313Z :GRPC_SERVER DEBUG: [0x61a0001d8280] created request Name# RollbackTransaction
2025-10-26T18:38:47.303599Z :GRPC_SERVER DEBUG: [0x61a0001d8880] created request Name# RollbackTransaction
2025-10-26T18:38:47.303865Z :GRPC_SERVER DEBUG: [0x61a0001d8e80] created request Name# RollbackTransaction
2025-10-26T18:38:47.304188Z :GRPC_SERVER DEBUG: [0x61a0001d9480] created request Name# RollbackTransaction
2025-10-26T18:38:47.304423Z :GRPC_SERVER DEBUG: [0x61a0001d9a80] created request Name# RollbackTransaction
2025-10-26T18:38:47.304698Z :GRPC_SERVER DEBUG: [0x61a0001da080] created request Name# RollbackTransaction
2025-10-26T18:38:47.304941Z :GRPC_SERVER DEBUG: [0x61a0001da680] created request Name# RollbackTransaction
2025-10-26T18:38:47.305202Z :GRPC_SERVER DEBUG: [0x61a0001dac80] created request Name# RollbackTransaction
2025-10-26T18:38:47.305460Z :GRPC_SERVER DEBUG: [0x61a0001db280] created request Name# RollbackTransaction
2025-10-26T18:38:47.305741Z :GRPC_SERVER DEBUG: [0x61a0001db880] created request Name# RollbackTransaction
2025-10-26T18:38:47.306022Z :GRPC_SERVER DEBUG: [0x61a0001dbe80] created request Name# RollbackTransaction
2025-10-26T18:38:47.306297Z :GRPC_SERVER DEBUG: [0x61a0001dc480] created request Name# RollbackTransaction
2025-10-26T18:38:47.306581Z :GRPC_SERVER DEBUG: [0x61a0001dca80] created request Name# RollbackTransaction
2025-10-26T18:38:47.306837Z :GRPC_SERVER DEBUG: [0x61a0001dd080] created request Name# RollbackTransaction
2025-10-26T18:38:47.307053Z :GRPC_SERVER DEBUG: [0x61a0001dd680] created request Name# RollbackTransaction
2025-10-26T18:38:47.307329Z :GRPC_SERVER DEBUG: [0x61a0001ddc80] created request Name# RollbackTransaction
2025-10-26T18:38:47.307543Z :GRPC_SERVER DEBUG: [0x61a0001de280] created request Name# RollbackTransaction
2025-10-26T18:38:47.307768Z :GRPC_SERVER DEBUG: [0x61a0001de880] created request Name# RollbackTransaction
2025-10-26T18:38:47.307936Z :GRPC_SERVER DEBUG: [0x61a0001dee80] created request Name# RollbackTransaction
2025-10-26T18:38:47.308191Z :GRPC_SERVER DEBUG: [0x61a0001df480] created request Name# RollbackTransaction
2025-10-26T18:38:47.308658Z :GRPC_SERVER DEBUG: [0x61a0001e0080] created request Name# KeyValue/CreateVolume
2025-10-26T18:38:47.309074Z :GRPC_SERVER DEBUG: [0x61a0001e0680] created request Name# KeyValue/DropVolume
2025-10-26T18:38:47.309518Z :GRPC_SERVER DEBUG: [0x61a0001e0c80] created request Name# KeyValue/AlterVolume
2025-10-26T18:38:47.310058Z :GRPC_SERVER DEBUG: [0x61a0001e1280] created request Name# KeyValue/DescribeVolume
2025-10-26T18:38:47.310527Z :GRPC_SERVER DEBUG: [0x61a0001e1880] created request Name# KeyValue/ListLocalPartitions
2025-10-26T18:38:47.311010Z :GRPC_SERVER DEBUG: [0x61a0001e1e80] created request Name# KeyValue/AcquireLock
2025-10-26T18:38:47.311478Z :GRPC_SERVER DEBUG: [0x61a0001e2480] created request Name# KeyValue/ExecuteTransaction
2025-10-26T18:38:47.311953Z :GRPC_SERVER DEBUG: [0x61a0001e2a80] created request Name# KeyValue/Read
2025-10-26T18:38:47.312483Z :GRPC_SERVER DEBUG: [0x61a0001e3080] created request Name# KeyValue/ReadRange
2025-10-26T18:38:47.312985Z :GRPC_SERVER DEBUG: [0x61a0001e3680] created request Name# KeyValue/ListRange
2025-10-26T18:38:47.313508Z :GRPC_SERVER DEBUG: [0x61a0001e3c80] created request Name# KeyValue/GetStorageChannelStatus
2025-10-26T18:38:47.321069Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE TEvConfigure Version# 2
2025-10-26T18:38:47.325602Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T18:38:47.325663Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T18:38:47.385905Z :TX_MEDIATOR NOTICE: tablet# 72075186224037895 actor# [50000:7565601761947656527:10237] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T18:38:47.388634Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T18:38:47.446638Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE TEvConfigure Version# 2
2025-10-26T18:38:47.450017Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T18:38:47.450068Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T18:38:47.450108Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T18:38:47.479367Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE TEvConfigure Version# 2
2025-10-26T18:38:47.482982Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T18:38:47.483191Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T18:38:47.483238Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T18:38:47.568267Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656754:4194][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:48.022791Z :GRPC_SERVER DEBUG: [0x61a000092480] received request Name# CreateSession ok# true data# operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:48.022948Z :GRPC_SERVER DEBUG: [0x61a0001ffe80] created request Name# CreateSession
2025-10-26T18:38:48.023486Z :GRPC_SERVER DEBUG: [0x61a000092480] received request without user token Name# CreateSession data# operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } }  peer# ipv4:127.0.0.1:43994 database# /Root/test_auditlog.py
2025-10-26T18:38:48.024014Z :GRPC_SERVER DEBUG: Got grpc request# CreateSessionRequest, traceId# 01k8gx1qpqah88x0zxyaf282je, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 2.987721s
2025-10-26T18:38:48.279034Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:48.279076Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:48.279129Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:48.279145Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:49.279436Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:49.279466Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:49.279532Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:49.279552Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:49.619623Z :KQP_PROXY DEBUG: Updated YQL logs priority: 3
2025-10-26T18:38:49.620199Z :KQP_PROXY INFO: Cannot start publishing usage, tenants: /Root/test_auditlog.py, empty
2025-10-26T18:38:49.622034Z :KQP_PROXY DEBUG: Created new session, sessionId: ydb://session/3?node_id=50000&id=NjhmMGNhNTEtN2Y4NzgyYzEtNGIzNWEzZDEtNDYyMjY3MTI=, workerId: [50000:7565601770537591478:4211], database: , longSession: 0, local sessions count: 1
2025-10-26T18:38:49.622070Z :KQP_PROXY INFO: Cannot start publishing usage, tenants: /Root/test_auditlog.py, empty
2025-10-26T18:38:49.622173Z :KQP_PROXY DEBUG: Ctx: { TraceId: , Database: , DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=NjhmMGNhNTEtN2Y4NzgyYzEtNGIzNWEzZDEtNDYyMjY3MTI=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 2, targetId: [50000:7565601770537591478:4211]
2025-10-26T18:38:49.622217Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 2 timeout: 300.000000s actor id: [50000:7565601770537591479:144]
2025-10-26T18:38:49.622339Z :KQP_PROXY DEBUG: TraceId: "01k8gx1qpqah88x0zxyaf282je", Request has 1.389396s seconds to be completed
2025-10-26T18:38:49.623977Z :KQP_PROXY DEBUG: TraceId: "01k8gx1qpqah88x0zxyaf282je", Created new session, sessionId: ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=, workerId: [50000:7565601770537591482:4142], database: /Root/test_auditlog.py, longSession: 1, local sessions count: 2
2025-10-26T18:38:49.624013Z :KQP_PROXY INFO: Cannot start publishing usage, tenants: /Root/test_auditlog.py, empty
2025-10-26T18:38:49.624108Z :KQP_PROXY DEBUG: Received create session request, trace_id: 01k8gx1qpqah88x0zxyaf282je
2025-10-26T18:38:49.624158Z :KQP_PROXY DEBUG: Subscribed for config changes.
2025-10-26T18:38:49.624249Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.2682777767
2025-10-26T18:38:49.624321Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.2682777767
2025-10-26T18:38:49.624387Z :KQP_PROXY DEBUG: Updated table service config.
2025-10-26T18:38:49.624410Z :KQP_PROXY DEBUG: Updated YQL logs priority: 3
2025-10-26T18:38:49.624465Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.2682777767
2025-10-26T18:38:49.624497Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.2682777767
2025-10-26T18:38:49.624517Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.2682777767
2025-10-26T18:38:49.624857Z :GRPC_SERVER DEBUG: [0x61a000092480] issuing response Name# CreateSession data# operation { ready: true status: SUCCESS result { type_url: "type.googleapis.com/Ydb.Table.CreateSessionResult" value: "\nQydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=" } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.625327Z :GRPC_SERVER DEBUG: [0x61a000092480] finished request Name# CreateSession ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.632286Z :GRPC_SERVER DEBUG: [0x61a0000ee280] received request Name# ExecuteSchemeQuery ok# true data# session_id: "ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=" yql_text: "\n            create table `/Root/test_auditlog.py/test-table` (\n                id int64,\n                value int64,\n                primary key (id)\n            );\n        " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.632372Z :GRPC_SERVER DEBUG: [0x61a000200480] created request Name# ExecuteSchemeQuery
2025-10-26T18:38:49.632654Z :GRPC_SERVER DEBUG: [0x61a0000ee280] received request without user token Name# ExecuteSchemeQuery data# session_id: "ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=" yql_text: "\n            create table `/Root/test_auditlog.py/test-table` (\n                id int64,\n                value int64,\n                primary key (id)\n            );\n        " operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } }  peer# ipv4:127.0.0.1:43994 database# /Root/test_auditlog.py
2025-10-26T18:38:49.632802Z :GRPC_SERVER DEBUG: Got grpc request# ExecuteSchemeQueryRequest, traceId# 01k8gx1s90amn3wcmj9eth4r2j, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.998900s
2025-10-26T18:38:49.632998Z :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gx1s90amn3wcmj9eth4r2j, Database: /Root/test_auditlog.py, DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 600.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 4, targetId: [50000:7565601770537591482:4142]
2025-10-26T18:38:49.633015Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 4 timeout: 600.000000s actor id: [50000:7565601770537591485:145]
2025-10-26T18:38:49.750275Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: /Root/test_auditlog.py/test-table
2025-10-26T18:38:49.751296Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591488:4163][/Root/test_auditlog.py/test-table] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.756052Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: 
2025-10-26T18:38:49.761025Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591497:4157][/Root] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.762889Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565601770537591504:128], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.762919Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.762938Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T18:38:49.762987Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [50000:7565601770537591496:4156], Recipient [50000:7565601761947656614:57]: {TEvModifySchemeTransaction txid# 281474976720657 TabletId# 72075186224037889}
2025-10-26T18:38:49.763010Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-10-26T18:38:49.765397Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [50000:7565601770537591480:4212], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T18:38:49.766610Z :KQP_PROXY DEBUG: Forwarded response to sender actor, requestId: 2, sender: [50000:7565601757652688943:4101], selfId: [50000:7565601757652688973:4115], source: [50000:7565601770537591478:4211]
2025-10-26T18:38:49.766668Z :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=50000&id=NjhmMGNhNTEtN2Y4NzgyYzEtNGIzNWEzZDEtNDYyMjY3MTI=, workerId: [50000:7565601770537591478:4211], local sessions count: 1
2025-10-26T18:38:49.768688Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Execute, message: Transaction { WorkingDir: "/Root/test_auditlog.py" OperationType: ESchemeOpCreateTable CreateTable { Name: "test-table" Columns { Name: "id" Type: "Int64" NotNull: false } Columns { Name: "value" Type: "Int64" NotNull: false } KeyColumnNames: "id" PartitionConfig { PartitioningPolicy { SizeToSplit: 2147483648 } ColumnFamilies { StorageConfig { SysLog { PreferredPoolKind: "hdd" } Log { PreferredPoolKind: "hdd" } Data { PreferredPoolKind: "hdd" } } } } Temporary: false } } TxId: 281474976720657 TabletId: 72075186224037889 PeerName: "" , at schemeshard: 72075186224037889
2025-10-26T18:38:49.769013Z :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/test_auditlog.py/test-table, opId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.769146Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable Propose, path: /Root/test_auditlog.py/test-table, opId: 281474976720657:0, schema: Name: "test-table" Columns { Name: "id" Type: "Int64" NotNull: false } Columns { Name: "value" Type: "Int64" NotNull: false } KeyColumnNames: "id" PartitionConfig { PartitioningPolicy { SizeToSplit: 2147483648 } ColumnFamilies { StorageConfig { SysLog { PreferredPoolKind: "hdd" } Log { PreferredPoolKind: "hdd" } Data { PreferredPoolKind: "hdd" } } } } Temporary: false, at schemeshard: 72075186224037889
2025-10-26T18:38:49.769642Z :FLAT_TX_SCHEMESHARD DEBUG: AttachChild: child attached as only one child to the parent, parent id: [OwnerId: 72075186224037889, LocalPathId: 1], parent name: Root/test_auditlog.py, child name: test-table, child id: [OwnerId: 72075186224037889, LocalPathId: 2], at schemeshard: 72075186224037889
2025-10-26T18:38:49.769703Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 0
2025-10-26T18:38:49.769744Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 1
2025-10-26T18:38:49.769851Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 2
2025-10-26T18:38:49.769875Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 1 -> 2
2025-10-26T18:38:49.770453Z :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976720657:0, propose status:StatusAccepted, reason: , at schemeshard: 72075186224037889
2025-10-26T18:38:49.770483Z :FLAT_TX_SCHEMESHARD WARN: Operation part proposed ok, but propose itself is undo unsafe, suboperation type: ESchemeOpCreateTable, opId: 281474976720657:0, at schemeshard:  72075186224037889
2025-10-26T18:38:49.770539Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.770590Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 11
2025-10-26T18:38:49.770624Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T18:38:49.773173Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976720657, response: Status: StatusAccepted TxId: 281474976720657 SchemeshardId: 72075186224037889 PathId: 2, at schemeshard: 72075186224037889
2025-10-26T18:38:49.773407Z :FLAT_TX_SCHEMESHARD NOTICE: AUDIT: txId: 281474976720657, database: /Root/test_auditlog.py, subject: , status: StatusAccepted, operation: CREATE TABLE, path: /Root/test_auditlog.py/test-table
2025-10-26T18:38:49.773441Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.773458Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T18:38:49.773528Z :KQP_GATEWAY DEBUG: Received TEvProposeTransactionStatus for scheme request, TxId: 281474976720657, status: ExecInProgress, scheme shard status: 1
2025-10-26T18:38:49.773568Z :KQP_GATEWAY DEBUG: Sent TEvNotifyTxCompletion request, TxId: 281474976720657
2025-10-26T18:38:49.773645Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.773670Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.773723Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T18:38:49.773738Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T18:38:49.773842Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 2]
2025-10-26T18:38:49.773914Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T18:38:49.773934Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 1
2025-10-26T18:38:49.773966Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 2
2025-10-26T18:38:49.773992Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 281474976720657, is deletion# false, version: 5
2025-10-26T18:38:49.774059Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565601770537591504:128], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.774097Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.774153Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T18:38:49.774161Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], cookie# 281474976720657, is deletion# false, version: 1
2025-10-26T18:38:49.774187Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.774216Z :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976720657:0 ProgressState, operation type: TxCreateTable, at tablet72075186224037889
2025-10-26T18:38:49.774472Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976720657:0 CreateRequest Event to Hive: 72075186224037888 msg:  Owner: 72075186224037889
OwnerIdx: 11
TabletType: DataShard
ObjectDomain {
  SchemeShard: 72075186232723360
  PathId: 2
}
ObjectId: 2
BindedChannels {
  StoragePoolName: "/Root/test_auditlog.py:hdd"
}
BindedChannels {
  StoragePoolName: "/Root/test_auditlog.py:hdd"
}
AllowedDomains {
  SchemeShard: 72075186232723360
  PathId: 2
}
2025-10-26T18:38:49.774528Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.774742Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565601770537591509:86], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.774764Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.774777Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T18:38:49.774843Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.774853Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [50000:7565601770537591495:4155], Recipient [50000:7565601761947656614:57]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976720657
2025-10-26T18:38:49.774855Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.774872Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-10-26T18:38:49.774885Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.774912Z :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976720657, at schemeshard: 72075186224037889
2025-10-26T18:38:49.774934Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: false
2025-10-26T18:38:49.774954Z :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976720657, at schemeshard: 72075186224037889
2025-10-26T18:38:49.774967Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:49.774972Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.775056Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 5
2025-10-26T18:38:49.775058Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591488:4163][/Root/test_auditlog.py/test-table] Update to non-empty state: owner# [50000:7565601761947656389:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 2], Version: 1) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.775067Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:49.775105Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], version# 1
2025-10-26T18:38:49.775142Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:49.775144Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 5 }
2025-10-26T18:38:49.775163Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:49.775213Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 5 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.775229Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:49.775291Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 5 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.775310Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T18:38:49.775326Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 1], version: 5
2025-10-26T18:38:49.775343Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 12
2025-10-26T18:38:49.775404Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.775541Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 2] Version: 1 }
2025-10-26T18:38:49.775560Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:49.775599Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 1 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.775660Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 1 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.775674Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T18:38:49.775684Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 2], version: 1
2025-10-26T18:38:49.775693Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 4
2025-10-26T18:38:49.775733Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: true
2025-10-26T18:38:49.775751Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.776412Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.776458Z :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037888 cookie: 72075186224037889:11 msg type: 268697601
2025-10-26T18:38:49.776579Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 0, tablet: 72075186224037888
2025-10-26T18:38:49.776603Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976720657, shardIdx: 72075186224037889:11, partId: 0
2025-10-26T18:38:49.776756Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565601770537591516:4167], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.776779Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.776802Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72075186224037889
2025-10-26T18:38:49.777220Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.777242Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.777290Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.777303Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.784343Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [50000:7565601761947656528:4129], Recipient [50000:7565601761947656614:57]: {EvCreateTabletReply Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888}
2025-10-26T18:38:49.784370Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-10-26T18:38:49.784432Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72075186224037889 message: Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888
2025-10-26T18:38:49.784451Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976720657, shardIdx: 72075186224037889:11, partId: 0
2025-10-26T18:38:49.784533Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889, message: Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888
2025-10-26T18:38:49.784572Z :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976720657:0 HandleReply TEvCreateTabletReply, at tabletId: 72075186224037889
2025-10-26T18:38:49.784623Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976720657:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888
2025-10-26T18:38:49.784679Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 2 -> 3
2025-10-26T18:38:49.784742Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.784767Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037888 cookie: 72075186224037889:11
2025-10-26T18:38:49.786344Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.786363Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.786377Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T18:38:49.786494Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.786518Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.786556Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.786582Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState at tabletId# 72075186224037889
2025-10-26T18:38:49.786631Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037898 seqNo: 1:1
2025-10-26T18:38:49.787435Z :BS_PROXY_DISCOVER WARN: [ffa6166b51c33e01] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T18:38:49.810009Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037898 message: TxKind: TX_KIND_SCHEME SourceDeprecated { RawX1: 7565601761947656614 RawX2: 4718347992170553 } TxBody: "\n\364\004\n\ntest-table\020\002\032\014\n\002id\030\003 \001(\000@\000\032\017\n\005value\030\003 \002(\000@\000(\001:\374\003\022\253\003\010\200\200\200\002\020\254\002\030\364\003 \200\200\200\010(\0000\200\200\200 8\200\200\200\010@\2008H\000RX\010\000\020\000\030\010 \010(\200\200\200@0\377\377\377\377\0178\001B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen1P\nX\200\200\001`nh\000p\000Rb\010\001\020\200\200\200\024\030\005 \020(\200\200\200\200\0020\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen2P\nX\200\200\001`nh\200\200\200\004p\200\200\200\004Rc\010\002\020\200\200\200\310\001\030\005 \020(\200\200\200\200@0\377\377\377\377\0178\000B$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionJ\017compaction_gen3P\nX\200\200\001`nh\200\200\200(p\200\200\200(X\001`\005j$\010e\020d\031\000\000\000\000\000\000\360?*\025background_compactionr\017compaction_gen0z\017compaction_gen0\202\001\004scan\210\001\200\200\200\010\220\001\364\003\230\0012\270\001\2008\300\001\006R\010\010\200\200\200\200\010\020\001b\031\010\000J\025\n\005\n\003hdd\022\005\n\003hdd\032\005\n\003hdd\212\001&\010\000\022\004\010\001\020\000\022\004\010\002\020\001\022\004\010\003\020\001\032\004\010\001\020\000\032\004\010\002\020\001\032\004\010\003\020\001J!/Root/test_auditlog.py/test-table\242\001\006\001\000\000\000\000\200\252\001\000\260\001\001\270\001\000\210\002\001\222\002\013\t\001\000\001\000\000\020\000\001\020\002:\004\010\001\020\001" TxId: 281474976720657 ExecLevel: 0 Flags: 0 SchemeShardId: 72075186224037889 ProcessingParams { Version: 2 PlanResolution: 10 Coordinators: 72075186224037890 Coordinators: 72075186224037891 Coordinators: 72075186224037892 TimeCastBucketsPerMediator: 2 Mediators: 72075186224037893 Mediators: 72075186224037894 Mediators: 72075186224037895 SchemeShard: 72075186224037889 Hive: 72075186224037888 SysViewProcessor: 72075186224037896 StatisticsAggregator: 72075186224037897 } SubDomainPathId: 1
2025-10-26T18:38:49.810162Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.812588Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.812615Z :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037898 cookie: 72075186224037889:11 msg type: 269549568
2025-10-26T18:38:49.812706Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 0, tablet: 72075186224037898
2025-10-26T18:38:49.814679Z :BS_PROXY_DISCOVER WARN: [d556ec4d82cf6e14] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T18:38:49.830209Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565601770537591542:4215], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.830231Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.830254Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037898, status: OK, at schemeshard: 72075186224037889
2025-10-26T18:38:49.831417Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591561:4226][[OwnerId: 72075186224037889, LocalPathId: 1]] Set up state: owner# [50000:7565601770537591560:4217], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.833093Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [50000:7565601761947656528:4129], Recipient [50000:7565601761947656614:57]: {EvTabletCreationResult Status: OK TabletID: 72075186224037898}
2025-10-26T18:38:49.835638Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [50000:7565601770537591537:69], Recipient [50000:7565601761947656614:57]: NKikimrTxDataShard.TEvProposeTransactionResult TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: PREPARED TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1761503929830254 ExecLatency: 0 ProposeLatency: 2 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 320 } }
2025-10-26T18:38:49.835672Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-10-26T18:38:49.835768Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72075186224037889, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: PREPARED TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1761503929830254 ExecLatency: 0 ProposeLatency: 2 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 320 } }
2025-10-26T18:38:49.835797Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T18:38:49.835932Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: PREPARED TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1761503929830254 ExecLatency: 0 ProposeLatency: 2 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 320 } }
2025-10-26T18:38:49.835964Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId#281474976720657:0 HandleReply TEvProposeTransactionResult at tabletId# 72075186224037889
2025-10-26T18:38:49.836045Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId#281474976720657:0 HandleReply TEvProposeTransactionResult message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: PREPARED TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1761503929830254 ExecLatency: 0 ProposeLatency: 2 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 320 } }
2025-10-26T18:38:49.836066Z :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72075186224037889
2025-10-26T18:38:49.836145Z :FLAT_TX_SCHEMESHARD DEBUG: CollectProposeTransactionResults accept TEvProposeTransactionResult, shard: 72075186224037898, shardIdx: 72075186224037889:11, operationId: 281474976720657:0, left await: 0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.836166Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 3 -> 128
2025-10-26T18:38:49.836209Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.836239Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037898 cookie: 72075186224037889:11
2025-10-26T18:38:49.838392Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.838427Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.838442Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T18:38:49.838566Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.838589Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.838620Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.838651Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId#281474976720657:0 HandleReply ProgressState at tablet: 72075186224037889
2025-10-26T18:38:49.838680Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.838719Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976720657 ready parts: 1/1
2025-10-26T18:38:49.841715Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoPropose send propose to coordinator: 72075186224037890 message:Transaction { AffectedSet { TabletId: 72075186224037889 Flags: 2 } AffectedSet { TabletId: 72075186224037898 Flags: 2 } ExecLevel: 0 TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 IgnoreLowDiskSpace: true } CoordinatorID: 72075186224037890
2025-10-26T18:38:49.844093Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.844141Z :FLAT_TX_SCHEMESHARD DEBUG: Send tablet strongly msg  operationId: 281474976720657:4294967295 from tablet: 72075186224037889 to tablet: 72075186224037890 cookie: 0:281474976720657 msg type: 269090816
2025-10-26T18:38:49.844265Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 4294967295, tablet: 72075186224037890
2025-10-26T18:38:49.844534Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565601770537591572:4227], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.844576Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T18:38:49.844608Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72075186224037889
2025-10-26T18:38:49.844736Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [50000:7565601761947656525:10235], Recipient [50000:7565601761947656614:57]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1761503929010 TxId: 281474976720657
2025-10-26T18:38:49.847262Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [50000:7565601761947656525:10235], Recipient [50000:7565601761947656614:57]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1761503929890 TxId: 281474976720657
2025-10-26T18:38:49.847660Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565601770537591581:118], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.847684Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.847712Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T18:38:49.847776Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [50000:7565601761947656699:4139], Recipient [50000:7565601761947656614:57]: {TEvPlanStep step# 1761503929890 MediatorId# 72075186224037893 TabletID 72075186224037889}
2025-10-26T18:38:49.847805Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-10-26T18:38:49.847871Z :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1761503929890, transactions count in step: 1, at schemeshard: 72075186224037889
2025-10-26T18:38:49.847967Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976720657 AckTo { RawX1: 7565601761947656802 RawX2: 214748364800129 } } Step: 1761503929890 MediatorID: 72075186224037893 TabletID: 72075186224037889, at schemeshard: 72075186224037889
2025-10-26T18:38:49.848032Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId#281474976720657:0 HandleReply TEvOperationPlan at tablet: 72075186224037889, stepId: 1761503929890
2025-10-26T18:38:49.848168Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 128 -> 129
2025-10-26T18:38:49.848260Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.848324Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 11
2025-10-26T18:38:49.848366Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T18:38:49.848392Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:4294967295 from tablet: 72075186224037889 to tablet: 0 cookie: 0:281474976720657
2025-10-26T18:38:49.850932Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.850961Z :FLAT_TX_SCHEMESHARD TRACE: Ack coordinator stepId#1761503929890 first txId#281474976720657 countTxs#1
2025-10-26T18:38:49.851003Z :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1761503929890
2025-10-26T18:38:49.851079Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T18:38:49.851279Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.851304Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.851341Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T18:38:49.851361Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T18:38:49.851512Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 2]
2025-10-26T18:38:49.851738Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T18:38:49.851759Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 1
2025-10-26T18:38:49.851773Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 2
2025-10-26T18:38:49.851812Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.851844Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 281474976720657, is deletion# false, version: 6
2025-10-26T18:38:49.851851Z :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976720657:0 ProgressState at tablet: 72075186224037889
2025-10-26T18:38:49.851937Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.851970Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], cookie# 281474976720657, is deletion# false, version: 3
2025-10-26T18:38:49.852360Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [50000:7565601770537591537:69], Recipient [50000:7565601761947656614:57]: NKikimrTxDataShard.TEvProposeTransactionResult TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761503929890 OrderId: 281474976720657 ExecLatency: 0 ProposeLatency: 3 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1542 } }
2025-10-26T18:38:49.852388Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-10-26T18:38:49.852457Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72075186224037889, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761503929890 OrderId: 281474976720657 ExecLatency: 0 ProposeLatency: 3 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1542 } }
2025-10-26T18:38:49.852471Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T18:38:49.852594Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761503929890 OrderId: 281474976720657 ExecLatency: 0 ProposeLatency: 3 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1542 } }
2025-10-26T18:38:49.852730Z :FLAT_TX_SCHEMESHARD INFO: Unexpected message: tablet# 72075186224037889, ev# TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761503929890 OrderId: 281474976720657 ExecLatency: 0 ProposeLatency: 3 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1542 } }
2025-10-26T18:38:49.852752Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.852844Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.852860Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.852939Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565601770537591612:177], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.853024Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T18:38:49.853031Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591561:4226][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565601770537591560:4217], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.853051Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T18:38:49.853215Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [50000:7565601770537591537:69], Recipient [50000:7565601761947656614:57]: NKikimrTxDataShard.TEvSchemaChanged Source { RawX1: 7565601770537591537 RawX2: 4718347992170565 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T18:38:49.853267Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-10-26T18:38:49.853298Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.853342Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72075186224037889, at schemeshard: 72075186224037889, message: Source { RawX1: 7565601770537591537 RawX2: 4718347992170565 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T18:38:49.853364Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T18:38:49.853414Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.853458Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889, message: Source { RawX1: 7565601770537591537 RawX2: 4718347992170565 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T18:38:49.853479Z :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976720657:0 HandleReply TEvSchemaChanged at tablet: 72075186224037889
2025-10-26T18:38:49.853543Z :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976720657:0 HandleReply TEvSchemaChanged at tablet: 72075186224037889 message: Source { RawX1: 7565601770537591537 RawX2: 4718347992170565 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T18:38:49.853581Z :FLAT_TX_SCHEMESHARD DEBUG: CollectSchemaChanged accept TEvDataShard::TEvSchemaChanged, operationId: 281474976720657:0, shardIdx: 72075186224037889:11, datashard: 72075186224037898, left await: 0, txState.State: ProposedWaitParts, txState.ReadyForNotifications: 1, at schemeshard: 72075186224037889
2025-10-26T18:38:49.853594Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591488:4163][/Root/test_auditlog.py/test-table] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 2], Version: 1) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 2], Version: 3) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:49.853600Z :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.853612Z :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976720657:0, datashard: 72075186224037898, at schemeshard: 72075186224037889
2025-10-26T18:38:49.853633Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 129 -> 240
2025-10-26T18:38:49.853778Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.853944Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.854017Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 6
2025-10-26T18:38:49.854035Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], version# 3
2025-10-26T18:38:49.854084Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 6 }
2025-10-26T18:38:49.854109Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:49.854160Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 6 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.854192Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:49.854233Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 6 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.854246Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T18:38:49.854257Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 1], version: 6
2025-10-26T18:38:49.854268Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 12
2025-10-26T18:38:49.854285Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:49.854296Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:49.854302Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.854351Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:49.854424Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 2] Version: 3 }
2025-10-26T18:38:49.854444Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:49.854506Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 3 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.854557Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 3 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.854570Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T18:38:49.854581Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 2], version: 3
2025-10-26T18:38:49.854590Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 4
2025-10-26T18:38:49.854623Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: true
2025-10-26T18:38:49.854631Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.854730Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.854749Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.855344Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.855374Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.855388Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T18:38:49.855443Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [50000:7565601770537591537:69] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976720657 at schemeshard: 72075186224037889
2025-10-26T18:38:49.855564Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.855586Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T18:38:49.855626Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T18:38:49.855647Z :FLAT_TX_SCHEMESHARD INFO: [72075186224037889] TDone opId# 281474976720657:0ProgressState
2025-10-26T18:38:49.855718Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:49.855757Z :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976720657:0 progress is 1/1
2025-10-26T18:38:49.855774Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T18:38:49.855788Z :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976720657:0 progress is 1/1
2025-10-26T18:38:49.855795Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T18:38:49.855808Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 1/1, is published: true
2025-10-26T18:38:49.855847Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [50000:7565601770537591495:4155] message: TxId: 281474976720657
2025-10-26T18:38:49.855874Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T18:38:49.855892Z :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976720657:0
2025-10-26T18:38:49.855910Z :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976720657:0
2025-10-26T18:38:49.855998Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T18:38:49.856230Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.856242Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.856267Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T18:38:49.856270Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.857535Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:49.857611Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [50000:7565601770537591495:4155] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976720657 at schemeshard: 72075186224037889
2025-10-26T18:38:49.857658Z :KQP_GATEWAY DEBUG: Received TEvNotifyTxCompletionResult for scheme request, TxId: 281474976720657
2025-10-26T18:38:49.857669Z :KQP_GATEWAY DEBUG: Successful completion of scheme request, TxId: 281474976720657
2025-10-26T18:38:49.857811Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565601770537591612:177], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.857843Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.857864Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T18:38:49.857921Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565601770537591509:86], Recipient [50000:7565601761947656614:57]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.857945Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T18:38:49.857965Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T18:38:49.860125Z :KQP_PROXY DEBUG: TraceId: "01k8gx1s90amn3wcmj9eth4r2j", Forwarded response to sender actor, requestId: 4, sender: [50000:7565601770537591483:4199], selfId: [50000:7565601757652688973:4115], source: [50000:7565601770537591482:4142]
2025-10-26T18:38:49.860244Z :GRPC_SERVER DEBUG: [0x61a0000ee280] issuing response Name# ExecuteSchemeQuery data# operation { ready: true status: SUCCESS }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.860741Z :GRPC_SERVER DEBUG: [0x61a0000ee280] finished request Name# ExecuteSchemeQuery ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.866928Z :GRPC_SERVER DEBUG: [0x61a000123c80] received request Name# ExecuteDataQuery ok# true data# session_id: "ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "\n            insert into `/Root/test_auditlog.py/test-table` (id, value) values (1, 1), (2, 2)\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:49.867000Z :GRPC_SERVER DEBUG: [0x61a000200a80] created request Name# ExecuteDataQuery
2025-10-26T18:38:49.867321Z :GRPC_SERVER DEBUG: [0x61a000123c80] received request without user token Name# ExecuteDataQuery data# session_id: "ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=" tx_control { begin_tx { serializable_read_write { } } } query { yql_text: "\n            insert into `/Root/test_auditlog.py/test-table` (id, value) values (1, 1), (2, 2)\n        " } operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } }  peer# ipv4:127.0.0.1:43994 database# /Root/test_auditlog.py
2025-10-26T18:38:49.867501Z :GRPC_SERVER DEBUG: Got grpc request# ExecuteDataQueryRequest, traceId# 01k8gx1sgbdhwfgc99awh93mvj, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.998204s
2025-10-26T18:38:49.867759Z :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gx1sgbdhwfgc99awh93mvj, Database: /Root/test_auditlog.py, DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=ODc0ZWI4Y2QtMzQ1YzdmMzYtYTk4NmY1MjUtNzhiMzJlYmI=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 600.000000s cancelAfter: 600.000000s. Send request to target, requestId: 5, targetId: [50000:7565601770537591482:4142]
2025-10-26T18:38:49.867809Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 5 timeout: 300.000000s actor id: [50000:7565601770537591627:116]
2025-10-26T18:38:49.876448Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: /Root/test_auditlog.py/test-table
2025-10-26T18:38:50.069664Z :KQP_PROXY DEBUG: TraceId: "01k8gx1sgbdhwfgc99awh93mvj", Forwarded response to sender actor, requestId: 5, sender: [50000:7565601770537591625:4143], selfId: [50000:7565601757652688973:4115], source: [50000:7565601770537591482:4142]
2025-10-26T18:38:50.069921Z :GRPC_SERVER DEBUG: [0x61a000123c80] issuing response Name# ExecuteDataQuery data# operation { ready: true status: SUCCESS result { type_url: "type.googleapis.com/Ydb.Table.ExecuteQueryResult" value: "\022\034\n\03201k8gx1spb33w6gzj82k5za7g4" } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.070342Z :GRPC_SERVER DEBUG: [0x61a000123c80] finished request Name# ExecuteDataQuery ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.279914Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:50.279956Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T18:38:50.280008Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565601761947656614:57], Recipient [50000:7565601761947656614:57]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:50.280025Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T18:38:50.558666Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125004, Sender [1:7565601737253325352:70], Recipient [50000:7565601761947656614:57]
2025-10-26T18:38:50.558706Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvUpdateTenantSchemeShard
2025-10-26T18:38:50.558876Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateTenantSchemeShard, at schemeshard: 72075186224037889, msg: TabletId: 72075186232723360 Generation: 2 StoragePools { Name: "/Root/test_auditlog.py:hdd" Kind: "hdd" } SubdomainVersion: 3 AuditSettings { EnableDmlAudit: true }
2025-10-26T18:38:50.558978Z :FLAT_TX_SCHEMESHARD DEBUG: TTxUpdateTenant DoExecute, msg: TabletId: 72075186232723360 Generation: 2 StoragePools { Name: "/Root/test_auditlog.py:hdd" Kind: "hdd" } SubdomainVersion: 3 AuditSettings { EnableDmlAudit: true }, at schemeshard: 72075186224037889
2025-10-26T18:38:50.559166Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T18:38:50.559191Z :FLAT_TX_SCHEMESHARD DEBUG: Cannot publish paths for unknown operation id#0
2025-10-26T18:38:50.559263Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656754:4194][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 4) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.561565Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T18:38:50.561771Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [1:7565601737253325352:70] msg type: 271125003 msg: NKikimrScheme.TEvSyncTenantSchemeShard DomainSchemeShard: 72075186232723360 DomainPathId: 2 TabletID: 72075186224037889 Generation: 1 EffectiveACLVersion: 0 SubdomainVersion: 3 UserAttributesVersion: 1 TenantHive: 72075186224037888 TenantSysViewProcessor: 72075186224037896 TenantRootACL: "" TenantStatisticsAggregator: 72075186224037897 TenantGraphShard: 18446744073709551615 at schemeshard: 72075186224037889
2025-10-26T18:38:50.561869Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T18:38:50.561891Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 0, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T18:38:50.562010Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T18:38:50.562031Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565601761947656751:4185], at schemeshard: 72075186224037889, txId: 0, path id: 1
2025-10-26T18:38:50.562106Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 0, is deletion# false, version: 7
2025-10-26T18:38:50.562885Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.562908Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.562939Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591561:4226][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565601770537591560:4217], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.562990Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.563087Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565601761947656751:4185] Ack update: ack to# [50000:7565601761947656614:57], cookie# 0, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 7
2025-10-26T18:38:50.563127Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:50.563226Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565601761947656751:4185], Recipient [50000:7565601761947656614:57]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 7 }
2025-10-26T18:38:50.563249Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:50.563262Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T18:38:50.563286Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:50.563331Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 7 PathOwnerId: 72075186224037889, cookie: 0
2025-10-26T18:38:50.563356Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T18:38:50.563429Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T18:38:50.624597Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3265398174
2025-10-26T18:38:50.768353Z :KQP_PROXY DEBUG: Created new session, sessionId: ydb://session/3?node_id=50000&id=N2RlZWE3M2ItMjM1MTk4M2ItY2I4N2NlNWYtYmQ4M2U5YTE=, workerId: [50000:7565601774832558985:4242], database: , longSession: 0, local sessions count: 2
2025-10-26T18:38:50.768485Z :KQP_PROXY DEBUG: Ctx: { TraceId: , Database: , DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=N2RlZWE3M2ItMjM1MTk4M2ItY2I4N2NlNWYtYmQ4M2U5YTE=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 6, targetId: [50000:7565601774832558985:4242]
2025-10-26T18:38:50.768514Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 6 timeout: 300.000000s actor id: [50000:7565601774832558986:141]
2025-10-26T18:38:50.780794Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: 
2025-10-26T18:38:50.783177Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [50000:7565601774832558987:4158], status: SCHEME_ERROR, issues: <main>: Error: Type annotation, code: 1030
    <main>:3:16: Error: At function: KiReadTable!
        <main>:3:16: Error: Cannot find table 'db.[]' because it does not exist or you do not have access permissions. Please check correctness of table path and user permissions., code: 2003
2025-10-26T18:38:50.783537Z :KQP_PROXY DEBUG: Forwarded response to sender actor, requestId: 6, sender: [50000:7565601757652688943:4101], selfId: [50000:7565601757652688973:4115], source: [50000:7565601774832558985:4242]
2025-10-26T18:38:50.783592Z :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=50000&id=N2RlZWE3M2ItMjM1MTk4M2ItY2I4N2NlNWYtYmQ4M2U5YTE=, workerId: [50000:7565601774832558985:4242], local sessions count: 1
2025-10-26T18:38:50.793082Z :GRPC_SERVER DEBUG: [0x61a000093080] received request Name# CreateSession ok# true data# operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.793147Z :GRPC_SERVER DEBUG: [0x61a000201080] created request Name# CreateSession
2025-10-26T18:38:50.793466Z :GRPC_SERVER DEBUG: Got grpc request# CreateSessionRequest, traceId# 01k8gx1td92tzj9j4wpqgc8frf, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 3.008238s
2025-10-26T18:38:50.794017Z :KQP_PROXY DEBUG: TraceId: "01k8gx1td92tzj9j4wpqgc8frf", Request has 3.007680s seconds to be completed
2025-10-26T18:38:50.795298Z :KQP_PROXY DEBUG: TraceId: "01k8gx1td92tzj9j4wpqgc8frf", Created new session, sessionId: ydb://session/3?node_id=50000&id=NmEzMTU3M2EtYjJjN2Q3YWYtNDM4ZjIyOTMtYzUzYmFiOTE=, workerId: [50000:7565601774832558994:4158], database: /Root/test_auditlog.py, longSession: 1, local sessions count: 2
2025-10-26T18:38:50.795396Z :KQP_PROXY DEBUG: Received create session request, trace_id: 01k8gx1td92tzj9j4wpqgc8frf
2025-10-26T18:38:50.795566Z :GRPC_SERVER DEBUG: [0x61a000093080] issuing response Name# CreateSession data# operation { ready: true status: SUCCESS result { type_url: "type.googleapis.com/Ydb.Table.CreateSessionResult" value: "\nQydb://session/3?node_id=50000&id=NmEzMTU3M2EtYjJjN2Q3YWYtNDM4ZjIyOTMtYzUzYmFiOTE=" } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.795950Z :GRPC_SERVER DEBUG: [0x61a000093080] finished request Name# CreateSession ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.804746Z :GRPC_SERVER DEBUG: [0x61a00016c880] received request Name# SetConfig ok# true data# operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } config: "\n---\n123metadata:\n  kind: MainConfig\n  cluster: \"\"\n  version: %s\nconfig:\n  yaml_config_enabled: true\nallowed_labels:\n  node_id:\n    type: string\n  host:\n    type: string\n  tenant:\n    type: string\nselector_config: []\n    "  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.804801Z :GRPC_SERVER DEBUG: [0x61a000201680] created request Name# SetConfig
2025-10-26T18:38:50.805130Z :GRPC_SERVER DEBUG: Got grpc request# SetConfigRequest, traceId# 01k8gx1tdmcbv7k2ms48t9jq9c, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.997575s
2025-10-26T18:38:50.814852Z :GRPC_SERVER DEBUG: [0x61a00016c880] issuing response Name# SetConfig data# operation { ready: true status: BAD_REQUEST issues { message: "ydb/library/fyamlcpp/fyamlcpp.cpp:1053: \n6:12 plain scalar cannot start with \'%\'" severity: 1 } }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.815240Z :GRPC_SERVER DEBUG: [0x61a00016c880] finished request Name# SetConfig ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.932871Z :GRPC_SERVER DEBUG: [0x61a000201680] received request Name# SetConfig ok# true data# operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } config: "\n---\nmetadata:\n  kind: MainConfig\n  cluster: \"\"\n  version: 0\nconfig:\n  yaml_config_enabled: true\nallowed_labels:\n  node_id:\n    type: string\n  host:\n    type: string\n  tenant:\n    type: string\nselector_config: []\n    "  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.932950Z :GRPC_SERVER DEBUG: [0x61a000201c80] created request Name# SetConfig
2025-10-26T18:38:50.933200Z :GRPC_SERVER DEBUG: Got grpc request# SetConfigRequest, traceId# 01k8gx1thn7d0qsdnxbjbxe3z7, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:43994, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.998520s
2025-10-26T18:38:50.942172Z :GRPC_SERVER DEBUG: [0x61a000201680] issuing response Name# SetConfig data# operation { ready: true status: SUCCESS }  peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:50.942606Z :GRPC_SERVER DEBUG: [0x61a000201680] finished request Name# SetConfig ok# true peer# ipv4:127.0.0.1:43994
2025-10-26T18:38:51.033458Z :KQP_PROXY DEBUG: Updated table service config.
2025-10-26T18:38:51.033495Z :KQP_PROXY DEBUG: Updated YQL logs priority to current level: 3
2025-10-26T18:38:51.038118Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_DATASHARD has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038157Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component FLAT_TX_SCHEMESHARD has been changed from TRACE to NOTICE
2025-10-26T18:38:51.038169Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component HIVE has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038198Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_PROXY has been changed from CRIT to NOTICE
2025-10-26T18:38:51.038211Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_PROXY_SCHEME_CACHE has been changed from CRIT to NOTICE
2025-10-26T18:38:51.038222Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component GRPC_SERVER has been changed from DEBUG to NOTICE
2025-10-26T18:38:51.038232Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component GRPC_PROXY has been changed from DEBUG to NOTICE
2025-10-26T18:38:51.038245Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component CMS_TENANTS has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038255Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_PROXY has been changed from DEBUG to NOTICE
2025-10-26T18:38:51.038266Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_WORKER has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038277Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_GATEWAY has been changed from DEBUG to NOTICE
2025-10-26T18:38:51.038287Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_YQL has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038298Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_COMPILE_ACTOR has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038308Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_SESSION has been changed from ERROR to NOTICE
2025-10-26T18:38:51.038324Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component PERSQUEUE_CLUSTER_TRACKER has been changed from CRIT to NOTICE
2025-10-26T18:38:51.205249Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591497:4157][/Root] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.205277Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656446:4147][/Root] Path was updated to new version: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.205296Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656454:4151][/Root] Path was updated to new version: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216431Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591497:4157][/Root] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216471Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656454:4151][/Root] Path was updated to new version: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216471Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656446:4147][/Root] Path was updated to new version: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 6) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 1] AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216603Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601770537591561:4226][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565601770537591560:4217], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216781Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656497:4169][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216825Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656455:4152][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565601757652688951:28], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216830Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656754:4194][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565601761947656389:4125], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 5) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216856Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656447:4148][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565601757652688950:27], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216858Z :GRPC_SERVER WARN: SchemeBoardDelete /Root/test_auditlog.py Strong=1
2025-10-26T18:38:51.216865Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601761947656395:30][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565601757652689067:34], state# { Deleted: 0 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 7) DomainId: [OwnerId: 72075186232723360, LocalPathId: 2] AbandonedSchemeShards: there are 0 elements }, new state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186232723360, LocalPathId: 2], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.216871Z :GRPC_SERVER WARN: SchemeBoardDelete /Root/test_auditlog.py Strong=1
2025-10-26T18:38:51.217797Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565601779127526325:4246][[OwnerId: 72075186224037889, LocalPathId: 1]] Set up state: owner# [50000:7565601761947656389:4125], state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T18:38:51.218560Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,7) wasn't found - using supplied 72075186224037894
2025-10-26T18:38:51.218622Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037894) to Hive 72057594037968897
2025-10-26T18:38:51.218717Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,4) wasn't found - using supplied 72075186224037891
2025-10-26T18:38:51.218727Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037891) to Hive 72057594037968897
2025-10-26T18:38:51.218751Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,10) wasn't found - using supplied 72075186224037897
2025-10-26T18:38:51.218756Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037897) to Hive 72057594037968897
2025-10-26T18:38:51.218776Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,1) wasn't found - using supplied 72075186224037888
2025-10-26T18:38:51.218784Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037888) to Hive 72057594037968897
2025-10-26T18:38:51.218818Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,9) wasn't found - using supplied 72075186224037896
2025-10-26T18:38:51.218827Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037896) to Hive 72057594037968897
2025-10-26T18:38:51.218850Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,6) wasn't found - using supplied 72075186224037893
2025-10-26T18:38:51.218857Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037893) to Hive 72057594037968897
2025-10-26T18:38:51.218877Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,3) wasn't found - using supplied 72075186224037890
2025-10-26T18:38:51.218886Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037890) to Hive 72057594037968897
2025-10-26T18:38:51.218919Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,2) wasn't found - using supplied 72075186224037889
2025-10-26T18:38:51.218928Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037889) to Hive 72057594037968897
2025-10-26T18:38:51.218961Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,5) wasn't found - using supplied 72075186224037892
2025-10-26T18:38:51.218991Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037892) to Hive 72057594037968897
2025-10-26T18:38:51.219040Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,8) wasn't found - using supplied 72075186224037895
2025-10-26T18:38:51.219057Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037895) to Hive 72057594037968897
2025-10-26T18:38:51.221444Z :TABLET_MAIN NOTICE: Tablet: 72075186224037894  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.221647Z :TABLET_MAIN NOTICE: Tablet: 72075186224037896  Type: SysViewProcessor, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.222226Z :TABLET_MAIN NOTICE: Tablet: 72075186224037893  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.222241Z :TABLET_MAIN NOTICE: Tablet: 72075186224037897  Type: StatisticsAggregator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.222298Z :TABLET_MAIN NOTICE: Tablet: 72075186224037891  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.222414Z :TABLET_MAIN NOTICE: Tablet: 72075186224037888  Type: Hive, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.222473Z :TABLET_MAIN NOTICE: Tablet: 72075186224037890  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.223553Z :TABLET_MAIN NOTICE: Tablet: 72075186224037889  Type: SchemeShard, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.223783Z :TABLET_MAIN NOTICE: Tablet: 72075186224037892  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.223917Z :TABLET_MAIN NOTICE: Tablet: 72075186224037895  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T18:38:51.352908Z :BS_PROXY NOTICE: Group# 2181038082 HasInvalidGroupId# 0 Bootstrap -> StateEjected Marker# DSP42
2025-10-26T18:38:51.352939Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T18:38:51.354589Z :TABLET_MAIN ERROR: Tablet: 72075186224037898  Type: DataShard, EReason: ReasonBSError, SuggestedGeneration: 1, KnownGeneration: 1, Details: Created as unconfigured in error state (DSPE7). It happens when group doesn't present in BSC Marker# TSYS31
2025-10-26T18:38:51.722534Z :GRPC_SERVER NOTICE: Stop publish endpoints for database: /Root/test_auditlog.py
2025-10-26T18:38:51.722582Z :KQP_PROXY NOTICE: KQP proxy shutdown requested.
2025-10-26T18:38:51.722589Z :TENANT_POOL NOTICE: Forward drain node to local.
2025-10-26T18:38:51.722664Z :LOCAL NOTICE: Forward drain node to local, hive id: 72057594037968897
2025-10-26T18:38:51.722709Z :LOCAL NOTICE: Send drain node to hive: 72057594037968897. Online tablets: 0
2025-10-26T18:38:51.725772Z :LOCAL NOTICE: Drain node result received. Online tablets: 0
2025-10-26T18:38:51.783891Z :KQP_PROXY NOTICE: Cannot create session: system shutdown requested.
2025-10-26T18:38:51.785208Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Cannot create session: system shutdown requested." severity: 1 } } YdbStatus: OVERLOADED }
2025-10-26T18:38:51.823279Z :TX_PROXY WARN: actor# [50000:7565601757652688941:1363] HANDLE TEvClientDestroyed from tablet# 72057594046447617
2025-10-26T18:38:51.823340Z :INTERCONNECT NOTICE: Proxy [50000:7565601757652688905:1] [node 1] ICP32 transit to hold-by-error state Explanation# terminated
2025-10-26T18:38:51.823698Z :BS_NODE ERROR: {NW42@node_warden_pipe.cpp:55} Handle(TEvTabletPipe::TEvClientDestroyed) ClientId# [50000:7565601757652689062:24] ServerId# [1:7565601758728162436:175] TabletId# 72057594037932033 PipeClientId# [50000:7565601757652689062:24]
2025-10-26T18:38:51.824178Z :INTERCONNECT_NETWORK NOTICE: [50000 <-> 1] connection closed by peer
