2025-10-26T19:26:30.615023Z :BLOB_CACHE NOTICE: MaxCacheDataSize: 1048576000 InFlightDataSize: 0
2025-10-26T19:26:30.617834Z :MEMORY_PROFILER NOTICE: Bootstrapped
2025-10-26T19:26:30.745058Z :BS_PROXY NOTICE: EnsureMonitoring Group# 0 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T19:26:30.759229Z :INTERCONNECT ERROR: Proxy [50000:7565614055083342737:1] [node 1] ICP35 event processing took too much time PendingNodeInfo:261(16327486ns) {Configure:101(16311787ns) {ProcessConfigured:131(106015ns) {StartInitialHandshake:153(104344ns) {DropHandshakes:474(2355ns) {DropIncomingHandshake:446(242ns) DropOutgoingHandshake:461(528ns)} GenerateSessionVirtualId:431(260ns) PrepareNewSessionHandshake:481(1520ns) {SwitchToState:178(592ns)}}}}}
2025-10-26T19:26:30.797292Z :BS_PROXY NOTICE: Group# 4294967295 HasInvalidGroupId# 1 Bootstrap -> StateEjected Marker# DSP42
2025-10-26T19:26:30.804440Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Isrt;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.2;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:26:30.804563Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 50000, serve as dynamic node
2025-10-26T19:26:30.804934Z :GRPC_SERVER DEBUG: Subscribe to /Root
2025-10-26T19:26:30.804966Z :GRPC_SERVER DEBUG: Subscribe to /Root/test_auditlog.py
2025-10-26T19:26:30.806608Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Comp;action=conveyor_registered;config=DefaultFractionOfThreadsCount=0.33;QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:26:30.806979Z :GRPC_SERVER NOTICE: Grpc request proxy started, nodeid# 50000, serve as dynamic node
2025-10-26T19:26:30.807505Z :GRPC_SERVER DEBUG: Subscribe to /Root
2025-10-26T19:26:30.808683Z :GRPC_SERVER DEBUG: Subscribe to /Root/test_auditlog.py
2025-10-26T19:26:30.847619Z :PGWIRE ERROR: Failed to bind [::]:5432. Error: Address already in use
2025-10-26T19:26:30.847726Z :TX_CONVEYOR NOTICE: fline=service.cpp:16;name=Scan;action=conveyor_registered;config=QueueSizeLimit=262144;Enabled=1;;
2025-10-26T19:26:30.868631Z :GRPC_SERVER INFO: Subscribed for config changes
2025-10-26T19:26:30.868678Z :GRPC_SERVER DEBUG: Got proxy service configuration
2025-10-26T19:26:30.871931Z :GRPC_SERVER INFO: Subscribed for config changes
2025-10-26T19:26:30.874279Z :GRPC_SERVER DEBUG: Got proxy service configuration
2025-10-26T19:26:30.878450Z :GRPC_SERVER DEBUG: [0x61a00004a480] created request Name# Legacy/SchemeOperation
2025-10-26T19:26:30.878989Z :GRPC_SERVER DEBUG: [0x61a00004aa80] created request Name# Legacy/SchemeOperationStatus
2025-10-26T19:26:30.880254Z :GRPC_SERVER DEBUG: [0x61a00004b080] created request Name# Legacy/SchemeDescribe
2025-10-26T19:26:30.881131Z :GRPC_SERVER DEBUG: [0x61a00004b680] created request Name# Legacy/ChooseProxy
2025-10-26T19:26:30.881520Z :GRPC_SERVER DEBUG: [0x61a00004bc80] created request Name# Legacy/PersQueueRequest
2025-10-26T19:26:30.882001Z :GRPC_SERVER DEBUG: [0x61a00004c280] created request Name# Legacy/SchemeInitRoot
2025-10-26T19:26:30.882349Z :GRPC_SERVER DEBUG: [0x61a00004c880] created request Name# Legacy/ResolveNode
2025-10-26T19:26:30.882733Z :GRPC_SERVER DEBUG: [0x61a00004ce80] created request Name# Legacy/FillNode
2025-10-26T19:26:30.883065Z :GRPC_SERVER DEBUG: [0x61a00004d480] created request Name# Legacy/DrainNode
2025-10-26T19:26:30.883414Z :GRPC_SERVER DEBUG: [0x61a00004da80] created request Name# Legacy/BlobStorageConfig
2025-10-26T19:26:30.883738Z :GRPC_SERVER DEBUG: [0x61a00004e080] created request Name# Legacy/HiveCreateTablet
2025-10-26T19:26:30.884067Z :GRPC_SERVER DEBUG: [0x61a00004e680] created request Name# Legacy/TestShardControl
2025-10-26T19:26:30.884449Z :GRPC_SERVER DEBUG: [0x61a00004ec80] created request Name# Legacy/RegisterNode
2025-10-26T19:26:30.884774Z :GRPC_SERVER DEBUG: [0x61a00004f280] created request Name# Legacy/CmsRequest
2025-10-26T19:26:30.885166Z :GRPC_SERVER DEBUG: [0x61a00009fc80] created request Name# Legacy/ConsoleRequest
2025-10-26T19:26:30.885500Z :GRPC_SERVER DEBUG: [0x61a0000a0280] created request Name# Legacy/InterconnectDebug
2025-10-26T19:26:30.888679Z :GRPC_SERVER DEBUG: [0x61a0000a0880] created request Name# Legacy/TabletStateRequest
2025-10-26T19:26:30.889071Z :GRPC_SERVER DEBUG: [0x61a0000a0e80] created request Name# Legacy/LocalSchemeTx
2025-10-26T19:26:30.889468Z :GRPC_SERVER DEBUG: [0x61a0000a1480] created request Name# Legacy/LocalEnumerateTablets
2025-10-26T19:26:30.889961Z :INTERCONNECT WARN: Handshake [50000:7565614055083342907:10] [node 1] ICH09 Neither CompatibilityInfo nor VersionTag of the peer can be validated, accepting by default
2025-10-26T19:26:30.891523Z :GRPC_SERVER DEBUG: [0x61a0000a1a80] created request Name# Legacy/TabletKillRequest
2025-10-26T19:26:30.896037Z :GRPC_SERVER DEBUG: [0x61a0000a2080] created request Name# CreateSession
2025-10-26T19:26:30.896346Z :GRPC_SERVER DEBUG: [0x61a0000a2680] created request Name# CreateSession
2025-10-26T19:26:30.896542Z :GRPC_SERVER DEBUG: [0x61a0000a2c80] created request Name# CreateSession
2025-10-26T19:26:30.896721Z :GRPC_SERVER DEBUG: [0x61a0000a3280] created request Name# CreateSession
2025-10-26T19:26:30.896923Z :GRPC_SERVER DEBUG: [0x61a0000a3880] created request Name# CreateSession
2025-10-26T19:26:30.897107Z :GRPC_SERVER DEBUG: [0x61a0000a3e80] created request Name# CreateSession
2025-10-26T19:26:30.897276Z :GRPC_SERVER DEBUG: [0x61a0000a4480] created request Name# CreateSession
2025-10-26T19:26:30.897481Z :GRPC_SERVER DEBUG: [0x61a0000a4a80] created request Name# CreateSession
2025-10-26T19:26:30.897739Z :GRPC_SERVER DEBUG: [0x61a0000a5080] created request Name# CreateSession
2025-10-26T19:26:30.897924Z :GRPC_SERVER DEBUG: [0x61a0000a5680] created request Name# CreateSession
2025-10-26T19:26:30.898271Z :GRPC_SERVER DEBUG: [0x61a0000a5c80] created request Name# CreateSession
2025-10-26T19:26:30.899247Z :GRPC_SERVER DEBUG: [0x61a0000a6280] created request Name# CreateSession
2025-10-26T19:26:30.901008Z :GRPC_SERVER DEBUG: [0x61a0000a6880] created request Name# CreateSession
2025-10-26T19:26:30.901342Z :GRPC_SERVER DEBUG: [0x61a0000a6e80] created request Name# CreateSession
2025-10-26T19:26:30.901601Z :GRPC_SERVER DEBUG: [0x61a0000a7480] created request Name# CreateSession
2025-10-26T19:26:30.902224Z :GRPC_SERVER DEBUG: [0x61a0000a7a80] created request Name# CreateSession
2025-10-26T19:26:30.902588Z :GRPC_SERVER DEBUG: [0x61a0000a8080] created request Name# CreateSession
2025-10-26T19:26:30.902843Z :GRPC_SERVER DEBUG: [0x61a0000a8680] created request Name# CreateSession
2025-10-26T19:26:30.903106Z :GRPC_SERVER DEBUG: [0x61a0000a8c80] created request Name# CreateSession
2025-10-26T19:26:30.903363Z :GRPC_SERVER DEBUG: [0x61a0000a9280] created request Name# CreateSession
2025-10-26T19:26:30.903769Z :GRPC_SERVER DEBUG: [0x61a0000a9880] created request Name# KeepAlive
2025-10-26T19:26:30.904001Z :GRPC_SERVER DEBUG: [0x61a0000a9e80] created request Name# KeepAlive
2025-10-26T19:26:30.904212Z :GRPC_SERVER DEBUG: [0x61a0000aa480] created request Name# KeepAlive
2025-10-26T19:26:30.904435Z :GRPC_SERVER DEBUG: [0x61a0000aaa80] created request Name# KeepAlive
2025-10-26T19:26:30.908621Z :GRPC_SERVER DEBUG: [0x61a0000ab080] created request Name# KeepAlive
2025-10-26T19:26:30.908956Z :GRPC_SERVER DEBUG: [0x61a0000ab680] created request Name# KeepAlive
2025-10-26T19:26:30.912446Z :GRPC_SERVER DEBUG: [0x61a0000abc80] created request Name# KeepAlive
2025-10-26T19:26:30.912800Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342914:4148][/Root] Set up state: owner# [50000:7565614055083342782: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-26T19:26:30.913664Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342925:4152][/Root] Set up state: owner# [50000:7565614055083342783: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-26T19:26:30.913754Z :GRPC_SERVER DEBUG: [0x61a0000ac280] created request Name# KeepAlive
2025-10-26T19:26:30.913840Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Set up state: owner# [50000:7565614055083342783: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-26T19:26:30.913934Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Set up state: owner# [50000:7565614055083342890: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-26T19:26:30.914213Z :GRPC_SERVER DEBUG: [0x61a0000ac880] created request Name# KeepAlive
2025-10-26T19:26:30.914442Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root
2025-10-26T19:26:30.914452Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Set up state: owner# [50000:7565614055083342782: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-26T19:26:30.914548Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root
2025-10-26T19:26:30.914552Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root - no SecurityState
2025-10-26T19:26:30.914601Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:30.914628Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root - no SecurityState
2025-10-26T19:26:30.914663Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:30.914673Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:30.914716Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:30.914819Z :GRPC_SERVER DEBUG: [0x61a0000ace80] created request Name# KeepAlive
2025-10-26T19:26:30.916274Z :GRPC_SERVER DEBUG: [0x61a0000ad480] created request Name# KeepAlive
2025-10-26T19:26:30.916871Z :GRPC_SERVER DEBUG: [0x61a0000ada80] created request Name# KeepAlive
2025-10-26T19:26:30.917484Z :GRPC_SERVER DEBUG: [0x61a0000ae080] created request Name# KeepAlive
2025-10-26T19:26:30.917726Z :GRPC_SERVER DEBUG: [0x61a0000ae680] created request Name# KeepAlive
2025-10-26T19:26:30.917931Z :GRPC_SERVER DEBUG: [0x61a0000aec80] created request Name# KeepAlive
2025-10-26T19:26:30.918117Z :GRPC_SERVER DEBUG: [0x61a0000af280] created request Name# KeepAlive
2025-10-26T19:26:30.918355Z :GRPC_SERVER DEBUG: [0x61a0000afe80] created request Name# KeepAlive
2025-10-26T19:26:30.918577Z :GRPC_SERVER DEBUG: [0x61a0000b0480] created request Name# KeepAlive
2025-10-26T19:26:30.918805Z :GRPC_SERVER DEBUG: [0x61a0000b0a80] created request Name# KeepAlive
2025-10-26T19:26:30.918993Z :GRPC_SERVER DEBUG: [0x61a0000b1080] created request Name# KeepAlive
2025-10-26T19:26:30.919366Z :GRPC_SERVER DEBUG: [0x61a0000b1680] created request Name# AlterTable
2025-10-26T19:26:30.919628Z :GRPC_SERVER DEBUG: [0x61a0000b1c80] created request Name# AlterTable
2025-10-26T19:26:30.919805Z :GRPC_SERVER DEBUG: [0x61a0000b2280] created request Name# AlterTable
2025-10-26T19:26:30.920025Z :GRPC_SERVER DEBUG: [0x61a0000b2880] created request Name# AlterTable
2025-10-26T19:26:30.920241Z :GRPC_SERVER DEBUG: [0x61a0000b2e80] created request Name# AlterTable
2025-10-26T19:26:30.920453Z :GRPC_SERVER DEBUG: [0x61a0000b3480] created request Name# AlterTable
2025-10-26T19:26:30.920620Z :GRPC_SERVER DEBUG: [0x61a0000b3a80] created request Name# AlterTable
2025-10-26T19:26:30.924144Z :GRPC_SERVER DEBUG: [0x61a0000b4080] created request Name# AlterTable
2025-10-26T19:26:30.924605Z :GRPC_SERVER DEBUG: [0x61a0000b4680] created request Name# AlterTable
2025-10-26T19:26:30.924820Z :GRPC_SERVER DEBUG: [0x61a0000b4c80] created request Name# AlterTable
2025-10-26T19:26:30.925053Z :GRPC_SERVER DEBUG: [0x61a0000b5280] created request Name# AlterTable
2025-10-26T19:26:30.925298Z :GRPC_SERVER DEBUG: [0x61a0000b5880] created request Name# AlterTable
2025-10-26T19:26:30.925485Z :GRPC_SERVER DEBUG: [0x61a0000b5e80] created request Name# AlterTable
2025-10-26T19:26:30.925470Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342979:4179][/Root/test_auditlog.py/.metadata/cs_index/external] Set up state: owner# [50000:7565614055083342890:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:26:30.925570Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342980:4180][/Root/test_auditlog.py/.metadata/initialization/migrations] Set up state: owner# [50000:7565614055083342890:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:26:30.925696Z :GRPC_SERVER DEBUG: [0x61a0000b6480] created request Name# AlterTable
2025-10-26T19:26:30.925933Z :GRPC_SERVER DEBUG: [0x61a0000b6a80] created request Name# AlterTable
2025-10-26T19:26:30.926153Z :GRPC_SERVER DEBUG: [0x61a0000b7080] created request Name# AlterTable
2025-10-26T19:26:30.926369Z :GRPC_SERVER DEBUG: [0x61a0000b7680] created request Name# AlterTable
2025-10-26T19:26:30.926601Z :GRPC_SERVER DEBUG: [0x61a0000b7c80] created request Name# AlterTable
2025-10-26T19:26:30.926833Z :GRPC_SERVER DEBUG: [0x61a0000b8280] created request Name# AlterTable
2025-10-26T19:26:30.927050Z :GRPC_SERVER DEBUG: [0x61a0000b8880] created request Name# AlterTable
2025-10-26T19:26:30.927599Z :GRPC_SERVER DEBUG: [0x61a0000b8e80] created request Name# CreateTable
2025-10-26T19:26:30.927902Z :GRPC_SERVER DEBUG: [0x61a0000b9480] created request Name# CreateTable
2025-10-26T19:26:30.928227Z :GRPC_SERVER DEBUG: [0x61a0000b9a80] created request Name# CreateTable
2025-10-26T19:26:30.929146Z :GRPC_SERVER DEBUG: [0x61a0000ba080] created request Name# CreateTable
2025-10-26T19:26:30.929445Z :GRPC_SERVER DEBUG: [0x61a0000ba680] created request Name# CreateTable
2025-10-26T19:26:30.929621Z :GRPC_SERVER DEBUG: [0x61a0000bac80] created request Name# CreateTable
2025-10-26T19:26:30.929870Z :GRPC_SERVER DEBUG: [0x61a0000bb280] created request Name# CreateTable
2025-10-26T19:26:30.930053Z :GRPC_SERVER DEBUG: [0x61a0000bb880] created request Name# CreateTable
2025-10-26T19:26:30.933383Z :GRPC_SERVER DEBUG: [0x61a0000bbe80] created request Name# CreateTable
2025-10-26T19:26:30.934151Z :TENANT_POOL NOTICE: TDomainTenantPool(Root) started tenant /Root/test_auditlog.py
2025-10-26T19:26:30.934339Z :GRPC_SERVER DEBUG: [0x61a0000bc480] created request Name# CreateTable
2025-10-26T19:26:30.934696Z :GRPC_SERVER DEBUG: [0x61a0000bca80] created request Name# CreateTable
2025-10-26T19:26:30.934970Z :GRPC_SERVER DEBUG: [0x61a0000bd080] created request Name# CreateTable
2025-10-26T19:26:30.935206Z :GRPC_SERVER DEBUG: [0x61a0000bd680] created request Name# CreateTable
2025-10-26T19:26:30.935495Z :GRPC_SERVER DEBUG: [0x61a0000bdc80] created request Name# CreateTable
2025-10-26T19:26:30.935690Z :GRPC_SERVER DEBUG: [0x61a0000be280] created request Name# CreateTable
2025-10-26T19:26:30.936697Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Set up state: owner# [50000:7565614055083342905:25], 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-26T19:26:30.936749Z :GRPC_SERVER DEBUG: [0x61a0000be880] created request Name# CreateTable
2025-10-26T19:26:30.937088Z :GRPC_SERVER DEBUG: [0x61a0000bee80] created request Name# CreateTable
2025-10-26T19:26:30.937372Z :GRPC_SERVER DEBUG: [0x61a0000bf480] created request Name# CreateTable
2025-10-26T19:26:30.937596Z :GRPC_SERVER DEBUG: [0x61a0000bfa80] created request Name# CreateTable
2025-10-26T19:26:30.937831Z :GRPC_SERVER DEBUG: [0x61a0000af880] created request Name# CreateTable
2025-10-26T19:26:30.938493Z :GRPC_SERVER DEBUG: [0x61a00008fa80] created request Name# DropTable
2025-10-26T19:26:30.938813Z :GRPC_SERVER DEBUG: [0x61a00007f880] created request Name# DropTable
2025-10-26T19:26:30.939163Z :GRPC_SERVER DEBUG: [0x61a00005fa80] created request Name# DropTable
2025-10-26T19:26:30.939500Z :GRPC_SERVER DEBUG: [0x61a00004f880] created request Name# DropTable
2025-10-26T19:26:30.939759Z :GRPC_SERVER DEBUG: [0x61a000012c80] created request Name# DropTable
2025-10-26T19:26:30.939982Z :GRPC_SERVER DEBUG: [0x61a000013280] created request Name# DropTable
2025-10-26T19:26:30.940342Z :GRPC_SERVER DEBUG: [0x61a000013880] created request Name# DropTable
2025-10-26T19:26:30.941787Z :GRPC_SERVER DEBUG: [0x61a000013e80] created request Name# DropTable
2025-10-26T19:26:30.942067Z :GRPC_SERVER DEBUG: [0x61a000014480] created request Name# DropTable
2025-10-26T19:26:30.942418Z :GRPC_SERVER DEBUG: [0x61a000014a80] created request Name# DropTable
2025-10-26T19:26:30.943026Z :GRPC_SERVER DEBUG: [0x61a000015080] created request Name# DropTable
2025-10-26T19:26:30.943573Z :GRPC_SERVER DEBUG: [0x61a000015680] created request Name# DropTable
2025-10-26T19:26:30.943857Z :GRPC_SERVER DEBUG: [0x61a000015c80] created request Name# DropTable
2025-10-26T19:26:30.944094Z :GRPC_SERVER DEBUG: [0x61a000016280] created request Name# DropTable
2025-10-26T19:26:30.944305Z :GRPC_SERVER DEBUG: [0x61a000016880] created request Name# DropTable
2025-10-26T19:26:30.944527Z :GRPC_SERVER DEBUG: [0x61a000016e80] created request Name# DropTable
2025-10-26T19:26:30.944709Z :GRPC_SERVER DEBUG: [0x61a000017480] created request Name# DropTable
2025-10-26T19:26:30.944917Z :GRPC_SERVER DEBUG: [0x61a000017a80] created request Name# DropTable
2025-10-26T19:26:30.945157Z :GRPC_SERVER DEBUG: [0x61a000018080] created request Name# DropTable
2025-10-26T19:26:30.945577Z :GRPC_SERVER DEBUG: [0x61a000018680] created request Name# DropTable
2025-10-26T19:26:30.946150Z :GRPC_SERVER DEBUG: [0x61a000018c80] created request Name# DescribeTable
2025-10-26T19:26:30.946438Z :GRPC_SERVER DEBUG: [0x61a000019280] created request Name# DescribeTable
2025-10-26T19:26:30.946645Z :GRPC_SERVER DEBUG: [0x61a000019880] created request Name# DescribeTable
2025-10-26T19:26:30.946855Z :GRPC_SERVER DEBUG: [0x61a000019e80] created request Name# DescribeTable
2025-10-26T19:26:30.947086Z :GRPC_SERVER DEBUG: [0x61a00001a480] created request Name# DescribeTable
2025-10-26T19:26:30.947569Z :GRPC_SERVER DEBUG: [0x61a00001aa80] created request Name# DescribeTable
2025-10-26T19:26:30.947946Z :GRPC_SERVER DEBUG: [0x61a00001b080] created request Name# DescribeTable
2025-10-26T19:26:30.948214Z :GRPC_SERVER DEBUG: [0x61a00001b680] created request Name# DescribeTable
2025-10-26T19:26:30.948475Z :GRPC_SERVER DEBUG: [0x61a00001bc80] created request Name# DescribeTable
2025-10-26T19:26:30.948691Z :GRPC_SERVER DEBUG: [0x61a00001c280] created request Name# DescribeTable
2025-10-26T19:26:30.952079Z :GRPC_SERVER DEBUG: [0x61a00001c880] created request Name# DescribeTable
2025-10-26T19:26:30.952381Z :GRPC_SERVER DEBUG: [0x61a00001ce80] created request Name# DescribeTable
2025-10-26T19:26:30.952559Z :GRPC_SERVER DEBUG: [0x61a00001d480] created request Name# DescribeTable
2025-10-26T19:26:30.952789Z :GRPC_SERVER DEBUG: [0x61a00001da80] created request Name# DescribeTable
2025-10-26T19:26:30.952967Z :GRPC_SERVER DEBUG: [0x61a00001e080] created request Name# DescribeTable
2025-10-26T19:26:30.953157Z :GRPC_SERVER DEBUG: [0x61a00001e680] created request Name# DescribeTable
2025-10-26T19:26:30.953322Z :GRPC_SERVER DEBUG: [0x61a00001ec80] created request Name# DescribeTable
2025-10-26T19:26:30.953504Z :GRPC_SERVER DEBUG: [0x61a00001f280] created request Name# DescribeTable
2025-10-26T19:26:30.955047Z :GRPC_SERVER DEBUG: [0x61a00002fa80] created request Name# DescribeTable
2025-10-26T19:26:30.955445Z :GRPC_SERVER DEBUG: [0x61a00001f880] created request Name# DescribeTable
2025-10-26T19:26:30.956371Z :GRPC_SERVER DEBUG: [0x61a0000cfc80] created request Name# CopyTable
2025-10-26T19:26:30.956708Z :GRPC_SERVER DEBUG: [0x61a0000d0280] created request Name# CopyTable
2025-10-26T19:26:30.956940Z :GRPC_SERVER DEBUG: [0x61a0000d0880] created request Name# CopyTable
2025-10-26T19:26:30.957181Z :GRPC_SERVER DEBUG: [0x61a0000d0e80] created request Name# CopyTable
2025-10-26T19:26:30.957609Z :GRPC_SERVER DEBUG: [0x61a0000d1480] created request Name# CopyTable
2025-10-26T19:26:30.957873Z :GRPC_SERVER DEBUG: [0x61a0000d1a80] created request Name# CopyTable
2025-10-26T19:26:30.958678Z :GRPC_SERVER DEBUG: [0x61a0000d2080] created request Name# CopyTable
2025-10-26T19:26:30.958998Z :GRPC_SERVER DEBUG: [0x61a0000d2680] created request Name# CopyTable
2025-10-26T19:26:30.959245Z :GRPC_SERVER DEBUG: [0x61a0000d2c80] created request Name# CopyTable
2025-10-26T19:26:30.959707Z :GRPC_SERVER DEBUG: [0x61a0000d3280] created request Name# CopyTable
2025-10-26T19:26:30.959999Z :GRPC_SERVER DEBUG: [0x61a0000d3880] created request Name# CopyTable
2025-10-26T19:26:30.960193Z :GRPC_SERVER DEBUG: [0x61a0000d3e80] created request Name# CopyTable
2025-10-26T19:26:30.960375Z :GRPC_SERVER DEBUG: [0x61a0000d4480] created request Name# CopyTable
2025-10-26T19:26:30.960769Z :GRPC_SERVER DEBUG: [0x61a0000d4a80] created request Name# CopyTable
2025-10-26T19:26:30.961241Z :GRPC_SERVER DEBUG: [0x61a0000d5080] created request Name# CopyTable
2025-10-26T19:26:30.961530Z :GRPC_SERVER DEBUG: [0x61a0000d5680] created request Name# CopyTable
2025-10-26T19:26:30.961827Z :GRPC_SERVER DEBUG: [0x61a0000d5c80] created request Name# CopyTable
2025-10-26T19:26:30.962656Z :GRPC_SERVER DEBUG: [0x61a0000d6280] created request Name# CopyTable
2025-10-26T19:26:30.964821Z :GRPC_SERVER DEBUG: [0x61a0000d6880] created request Name# CopyTable
2025-10-26T19:26:30.965158Z :GRPC_SERVER DEBUG: [0x61a0000d6e80] created request Name# CopyTable
2025-10-26T19:26:30.965778Z :GRPC_SERVER DEBUG: [0x61a0000d7480] created request Name# CopyTables
2025-10-26T19:26:30.966176Z :GRPC_SERVER DEBUG: [0x61a0000d7a80] created request Name# CopyTables
2025-10-26T19:26:30.966599Z :GRPC_SERVER DEBUG: [0x61a0000d8080] created request Name# CopyTables
2025-10-26T19:26:30.966873Z :GRPC_SERVER DEBUG: [0x61a0000d8680] created request Name# CopyTables
2025-10-26T19:26:30.967128Z :GRPC_SERVER DEBUG: [0x61a0000d8c80] created request Name# CopyTables
2025-10-26T19:26:30.968119Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T19:26:30.968798Z :GRPC_SERVER DEBUG: [0x61a0000d9280] created request Name# CopyTables
2025-10-26T19:26:30.969394Z :GRPC_SERVER DEBUG: [0x61a0000d9880] created request Name# CopyTables
2025-10-26T19:26:30.969785Z :GRPC_SERVER DEBUG: [0x61a0000d9e80] created request Name# CopyTables
2025-10-26T19:26:30.970061Z :GRPC_SERVER DEBUG: [0x61a0000da480] created request Name# CopyTables
2025-10-26T19:26:30.970313Z :GRPC_SERVER DEBUG: [0x61a0000daa80] created request Name# CopyTables
2025-10-26T19:26:30.970554Z :GRPC_SERVER DEBUG: [0x61a0000db080] created request Name# CopyTables
2025-10-26T19:26:30.970794Z :GRPC_SERVER DEBUG: [0x61a0000db680] created request Name# CopyTables
2025-10-26T19:26:30.971017Z :GRPC_SERVER DEBUG: [0x61a0000dbc80] created request Name# CopyTables
2025-10-26T19:26:30.971247Z :GRPC_SERVER DEBUG: [0x61a0000dc280] created request Name# CopyTables
2025-10-26T19:26:30.971641Z :GRPC_SERVER DEBUG: [0x61a0000dc880] created request Name# CopyTables
2025-10-26T19:26:30.972009Z :GRPC_SERVER DEBUG: [0x61a0000dce80] created request Name# CopyTables
2025-10-26T19:26:30.972300Z :GRPC_SERVER DEBUG: [0x61a0000dd480] created request Name# CopyTables
2025-10-26T19:26:30.972682Z :GRPC_SERVER DEBUG: [0x61a0000dda80] created request Name# CopyTables
2025-10-26T19:26:30.974292Z :GRPC_SERVER DEBUG: [0x61a0000de080] created request Name# CopyTables
2025-10-26T19:26:30.974544Z :GRPC_SERVER DEBUG: [0x61a0000de680] created request Name# CopyTables
2025-10-26T19:26:30.975392Z :GRPC_SERVER DEBUG: [0x61a0000dec80] created request Name# RenameTables
2025-10-26T19:26:30.979824Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 Marker# DSP57 initialize full monitoring
2025-10-26T19:26:30.980000Z :GRPC_SERVER DEBUG: [0x61a0000df280] created request Name# RenameTables
2025-10-26T19:26:30.980472Z :GRPC_SERVER DEBUG: [0x61a0000dfe80] created request Name# RenameTables
2025-10-26T19:26:30.980958Z :GRPC_SERVER DEBUG: [0x61a0000e0480] created request Name# RenameTables
2025-10-26T19:26:30.981270Z :GRPC_SERVER DEBUG: [0x61a0000e0a80] created request Name# RenameTables
2025-10-26T19:26:30.981540Z :GRPC_SERVER DEBUG: [0x61a0000e1080] created request Name# RenameTables
2025-10-26T19:26:30.981931Z :GRPC_SERVER DEBUG: [0x61a0000e1680] created request Name# RenameTables
2025-10-26T19:26:30.982245Z :GRPC_SERVER DEBUG: [0x61a0000e1c80] created request Name# RenameTables
2025-10-26T19:26:30.982551Z :GRPC_SERVER DEBUG: [0x61a0000e2280] created request Name# RenameTables
2025-10-26T19:26:30.982771Z :GRPC_SERVER DEBUG: [0x61a0000e2880] created request Name# RenameTables
2025-10-26T19:26:30.983359Z :GRPC_SERVER DEBUG: [0x61a0000e2e80] created request Name# RenameTables
2025-10-26T19:26:30.983831Z :GRPC_SERVER DEBUG: [0x61a0000e3480] created request Name# RenameTables
2025-10-26T19:26:30.984085Z :GRPC_SERVER DEBUG: [0x61a0000e3a80] created request Name# RenameTables
2025-10-26T19:26:30.984329Z :GRPC_SERVER DEBUG: [0x61a0000e4080] created request Name# RenameTables
2025-10-26T19:26:30.984563Z :GRPC_SERVER DEBUG: [0x61a0000e4680] created request Name# RenameTables
2025-10-26T19:26:30.984760Z :GRPC_SERVER DEBUG: [0x61a0000e4c80] created request Name# RenameTables
2025-10-26T19:26:30.984962Z :GRPC_SERVER DEBUG: [0x61a0000e5280] created request Name# RenameTables
2025-10-26T19:26:30.985180Z :GRPC_SERVER DEBUG: [0x61a0000e5880] created request Name# RenameTables
2025-10-26T19:26:30.985747Z :GRPC_SERVER DEBUG: [0x61a0000e5e80] created request Name# RenameTables
2025-10-26T19:26:30.986000Z :GRPC_SERVER DEBUG: [0x61a0000e6480] created request Name# RenameTables
2025-10-26T19:26:30.986410Z :GRPC_SERVER DEBUG: [0x61a0000e6a80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.986701Z :GRPC_SERVER DEBUG: [0x61a0000e7080] created request Name# ExplainDataQuery
2025-10-26T19:26:30.987024Z :GRPC_SERVER DEBUG: [0x61a0000e7680] created request Name# ExplainDataQuery
2025-10-26T19:26:30.987370Z :GRPC_SERVER DEBUG: [0x61a0000e7c80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.987722Z :GRPC_SERVER DEBUG: [0x61a0000e8280] created request Name# ExplainDataQuery
2025-10-26T19:26:30.987974Z :GRPC_SERVER DEBUG: [0x61a0000e8880] created request Name# ExplainDataQuery
2025-10-26T19:26:30.988213Z :GRPC_SERVER DEBUG: [0x61a0000e8e80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.988452Z :GRPC_SERVER DEBUG: [0x61a0000e9480] created request Name# ExplainDataQuery
2025-10-26T19:26:30.988951Z :GRPC_SERVER DEBUG: [0x61a0000e9a80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.989169Z :GRPC_SERVER DEBUG: [0x61a0000ea080] created request Name# ExplainDataQuery
2025-10-26T19:26:30.989414Z :GRPC_SERVER DEBUG: [0x61a0000ea680] created request Name# ExplainDataQuery
2025-10-26T19:26:30.989838Z :GRPC_SERVER DEBUG: [0x61a0000eac80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.990083Z :GRPC_SERVER DEBUG: [0x61a0000eb280] created request Name# ExplainDataQuery
2025-10-26T19:26:30.990332Z :GRPC_SERVER DEBUG: [0x61a0000eb880] created request Name# ExplainDataQuery
2025-10-26T19:26:30.990708Z :GRPC_SERVER DEBUG: [0x61a0000ebe80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.990974Z :GRPC_SERVER DEBUG: [0x61a0000ec480] created request Name# ExplainDataQuery
2025-10-26T19:26:30.991178Z :GRPC_SERVER DEBUG: [0x61a0000eca80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.991496Z :GRPC_SERVER DEBUG: [0x61a0000ed080] created request Name# ExplainDataQuery
2025-10-26T19:26:30.991728Z :GRPC_SERVER DEBUG: [0x61a0000ed680] created request Name# ExplainDataQuery
2025-10-26T19:26:30.991948Z :GRPC_SERVER DEBUG: [0x61a0000edc80] created request Name# ExplainDataQuery
2025-10-26T19:26:30.992507Z :GRPC_SERVER DEBUG: [0x61a0000ee280] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.992822Z :GRPC_SERVER DEBUG: [0x61a0000ee880] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.993286Z :GRPC_SERVER DEBUG: [0x61a0000eee80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.993570Z :GRPC_SERVER DEBUG: [0x61a0000ef480] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.995272Z :GRPC_SERVER DEBUG: [0x61a0000f0080] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.995618Z :GRPC_SERVER DEBUG: [0x61a0000f0680] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.995899Z :GRPC_SERVER DEBUG: [0x61a0000f0c80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.996149Z :GRPC_SERVER DEBUG: [0x61a0000f1280] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.996431Z :GRPC_SERVER DEBUG: [0x61a0000f1880] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.996688Z :GRPC_SERVER DEBUG: [0x61a0000f1e80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.997242Z :GRPC_SERVER DEBUG: [0x61a0000f2480] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.997946Z :GRPC_SERVER DEBUG: [0x61a0000f2a80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.998233Z :GRPC_SERVER DEBUG: [0x61a0000f3080] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.998784Z :GRPC_SERVER DEBUG: [0x61a0000f3680] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.999625Z :GRPC_SERVER DEBUG: [0x61a0000f3c80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:30.999938Z :GRPC_SERVER DEBUG: [0x61a0000f4280] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:31.000666Z :GRPC_SERVER DEBUG: [0x61a0000f4880] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:31.000928Z :GRPC_SERVER DEBUG: [0x61a0000f4e80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:31.001148Z :GRPC_SERVER DEBUG: [0x61a0000f5480] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:31.001407Z :GRPC_SERVER DEBUG: [0x61a0000f5a80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:31.001892Z :GRPC_SERVER DEBUG: [0x61a0000f6080] created request Name# BeginTransaction
2025-10-26T19:26:31.002557Z :GRPC_SERVER DEBUG: [0x61a0000f6680] created request Name# BeginTransaction
2025-10-26T19:26:31.002899Z :GRPC_SERVER DEBUG: [0x61a0000f6c80] created request Name# BeginTransaction
2025-10-26T19:26:31.003101Z :GRPC_SERVER DEBUG: [0x61a0000f7280] created request Name# BeginTransaction
2025-10-26T19:26:31.003830Z :GRPC_SERVER DEBUG: [0x61a0000f7880] created request Name# BeginTransaction
2025-10-26T19:26:31.004375Z :GRPC_SERVER DEBUG: [0x61a0000f7e80] created request Name# BeginTransaction
2025-10-26T19:26:31.004617Z :GRPC_SERVER DEBUG: [0x61a0000f8480] created request Name# BeginTransaction
2025-10-26T19:26:31.004842Z :GRPC_SERVER DEBUG: [0x61a0000f8a80] created request Name# BeginTransaction
2025-10-26T19:26:31.005101Z :GRPC_SERVER DEBUG: [0x61a0000f9080] created request Name# BeginTransaction
2025-10-26T19:26:31.006067Z :GRPC_SERVER DEBUG: [0x61a0000f9680] created request Name# BeginTransaction
2025-10-26T19:26:31.007131Z :GRPC_SERVER DEBUG: [0x61a0000f9c80] created request Name# BeginTransaction
2025-10-26T19:26:31.007376Z :GRPC_SERVER DEBUG: [0x61a0000fa280] created request Name# BeginTransaction
2025-10-26T19:26:31.007640Z :GRPC_SERVER DEBUG: [0x61a0000fa880] created request Name# BeginTransaction
2025-10-26T19:26:31.007839Z :GRPC_SERVER DEBUG: [0x61a0000fae80] created request Name# BeginTransaction
2025-10-26T19:26:31.008047Z :GRPC_SERVER DEBUG: [0x61a0000fb480] created request Name# BeginTransaction
2025-10-26T19:26:31.008282Z :GRPC_SERVER DEBUG: [0x61a0000fba80] created request Name# BeginTransaction
2025-10-26T19:26:31.008507Z :GRPC_SERVER DEBUG: [0x61a0000fc080] created request Name# BeginTransaction
2025-10-26T19:26:31.008766Z :GRPC_SERVER DEBUG: [0x61a0000fc680] created request Name# BeginTransaction
2025-10-26T19:26:31.008981Z :GRPC_SERVER DEBUG: [0x61a0000fcc80] created request Name# BeginTransaction
2025-10-26T19:26:31.009181Z :GRPC_SERVER DEBUG: [0x61a0000fd280] created request Name# BeginTransaction
2025-10-26T19:26:31.010045Z :GRPC_SERVER DEBUG: [0x61a0000fd880] created request Name# DescribeTableOptions
2025-10-26T19:26:31.010323Z :GRPC_SERVER DEBUG: [0x61a0000fde80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.010517Z :GRPC_SERVER DEBUG: [0x61a0000fe480] created request Name# DescribeTableOptions
2025-10-26T19:26:31.010689Z :GRPC_SERVER DEBUG: [0x61a0000fea80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.010881Z :GRPC_SERVER DEBUG: [0x61a0000ff080] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011049Z :GRPC_SERVER DEBUG: [0x61a0000ff680] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011242Z :GRPC_SERVER DEBUG: [0x61a0000ffc80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011408Z :GRPC_SERVER DEBUG: [0x61a000100280] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011565Z :GRPC_SERVER DEBUG: [0x61a000100880] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011760Z :GRPC_SERVER DEBUG: [0x61a000100e80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.011927Z :GRPC_SERVER DEBUG: [0x61a000101480] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012092Z :GRPC_SERVER DEBUG: [0x61a000101a80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012302Z :GRPC_SERVER DEBUG: [0x61a000102080] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012462Z :GRPC_SERVER DEBUG: [0x61a000102680] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012606Z :GRPC_SERVER DEBUG: [0x61a000102c80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012771Z :GRPC_SERVER DEBUG: [0x61a000103280] created request Name# DescribeTableOptions
2025-10-26T19:26:31.012947Z :GRPC_SERVER DEBUG: [0x61a000103880] created request Name# DescribeTableOptions
2025-10-26T19:26:31.014073Z :GRPC_SERVER DEBUG: [0x61a000103e80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.018612Z :GRPC_SERVER DEBUG: [0x61a000104480] created request Name# DescribeTableOptions
2025-10-26T19:26:31.021869Z :GRPC_SERVER DEBUG: [0x61a000104a80] created request Name# DescribeTableOptions
2025-10-26T19:26:31.022276Z :GRPC_SERVER DEBUG: [0x61a000105080] created request Name# DeleteSession
2025-10-26T19:26:31.025331Z :GRPC_SERVER DEBUG: [0x61a000105680] created request Name# DeleteSession
2025-10-26T19:26:31.025622Z :GRPC_SERVER DEBUG: [0x61a000105c80] created request Name# DeleteSession
2025-10-26T19:26:31.025799Z :GRPC_SERVER DEBUG: [0x61a000106280] created request Name# DeleteSession
2025-10-26T19:26:31.026009Z :GRPC_SERVER DEBUG: [0x61a000106880] created request Name# DeleteSession
2025-10-26T19:26:31.026696Z :GRPC_SERVER DEBUG: [0x61a000106e80] created request Name# DeleteSession
2025-10-26T19:26:31.026909Z :GRPC_SERVER DEBUG: [0x61a000107480] created request Name# DeleteSession
2025-10-26T19:26:31.027080Z :GRPC_SERVER DEBUG: [0x61a000107a80] created request Name# DeleteSession
2025-10-26T19:26:31.027317Z :GRPC_SERVER DEBUG: [0x61a000108080] created request Name# DeleteSession
2025-10-26T19:26:31.027750Z :GRPC_SERVER DEBUG: [0x61a000108680] created request Name# DeleteSession
2025-10-26T19:26:31.029672Z :GRPC_SERVER DEBUG: [0x61a000108c80] created request Name# DeleteSession
2025-10-26T19:26:31.030904Z :GRPC_SERVER DEBUG: [0x61a000109280] created request Name# DeleteSession
2025-10-26T19:26:31.031140Z :GRPC_SERVER DEBUG: [0x61a000109880] created request Name# DeleteSession
2025-10-26T19:26:31.032083Z :GRPC_SERVER DEBUG: [0x61a000109e80] created request Name# DeleteSession
2025-10-26T19:26:31.038316Z :GRPC_SERVER DEBUG: [0x61a00010a480] created request Name# DeleteSession
2025-10-26T19:26:31.038592Z :GRPC_SERVER DEBUG: [0x61a00010aa80] created request Name# DeleteSession
2025-10-26T19:26:31.039230Z :GRPC_SERVER DEBUG: [0x61a00010b080] created request Name# DeleteSession
2025-10-26T19:26:31.039505Z :GRPC_SERVER DEBUG: [0x61a00010b680] created request Name# DeleteSession
2025-10-26T19:26:31.040015Z :GRPC_SERVER DEBUG: [0x61a00010bc80] created request Name# DeleteSession
2025-10-26T19:26:31.040246Z :GRPC_SERVER DEBUG: [0x61a00010c280] created request Name# DeleteSession
2025-10-26T19:26:31.040611Z :GRPC_SERVER DEBUG: [0x61a00010c880] created request Name# CommitTransaction
2025-10-26T19:26:31.040850Z :GRPC_SERVER DEBUG: [0x61a00010ce80] created request Name# CommitTransaction
2025-10-26T19:26:31.042066Z :GRPC_SERVER DEBUG: [0x61a00010d480] created request Name# CommitTransaction
2025-10-26T19:26:31.042308Z :GRPC_SERVER DEBUG: [0x61a00010da80] created request Name# CommitTransaction
2025-10-26T19:26:31.042556Z :GRPC_SERVER DEBUG: [0x61a00010e080] created request Name# CommitTransaction
2025-10-26T19:26:31.042767Z :GRPC_SERVER DEBUG: [0x61a00010e680] created request Name# CommitTransaction
2025-10-26T19:26:31.043036Z :GRPC_SERVER DEBUG: [0x61a00010ec80] created request Name# CommitTransaction
2025-10-26T19:26:31.043239Z :GRPC_SERVER DEBUG: [0x61a00010f280] created request Name# CommitTransaction
2025-10-26T19:26:31.043461Z :GRPC_SERVER DEBUG: [0x61a00010fe80] created request Name# CommitTransaction
2025-10-26T19:26:31.043740Z :GRPC_SERVER DEBUG: [0x61a000110480] created request Name# CommitTransaction
2025-10-26T19:26:31.043928Z :GRPC_SERVER DEBUG: [0x61a000110a80] created request Name# CommitTransaction
2025-10-26T19:26:31.044160Z :GRPC_SERVER DEBUG: [0x61a000111080] created request Name# CommitTransaction
2025-10-26T19:26:31.044398Z :GRPC_SERVER DEBUG: [0x61a000111680] created request Name# CommitTransaction
2025-10-26T19:26:31.045589Z :GRPC_SERVER DEBUG: [0x61a000111c80] created request Name# CommitTransaction
2025-10-26T19:26:31.045874Z :GRPC_SERVER DEBUG: [0x61a000112280] created request Name# CommitTransaction
2025-10-26T19:26:31.046356Z :GRPC_SERVER DEBUG: [0x61a000112880] created request Name# CommitTransaction
2025-10-26T19:26:31.046573Z :GRPC_SERVER DEBUG: [0x61a000112e80] created request Name# CommitTransaction
2025-10-26T19:26:31.050308Z :GRPC_SERVER DEBUG: [0x61a000113480] created request Name# CommitTransaction
2025-10-26T19:26:31.054074Z :GRPC_SERVER DEBUG: [0x61a000113a80] created request Name# CommitTransaction
2025-10-26T19:26:31.054460Z :GRPC_SERVER DEBUG: [0x61a000114080] created request Name# CommitTransaction
2025-10-26T19:26:31.054915Z :GRPC_SERVER DEBUG: [0x61a000114680] created request Name# RollbackTransaction
2025-10-26T19:26:31.055218Z :GRPC_SERVER DEBUG: [0x61a000114c80] created request Name# RollbackTransaction
2025-10-26T19:26:31.056118Z :GRPC_SERVER DEBUG: [0x61a000115280] created request Name# RollbackTransaction
2025-10-26T19:26:31.056384Z :GRPC_SERVER DEBUG: [0x61a000115880] created request Name# RollbackTransaction
2025-10-26T19:26:31.056636Z :GRPC_SERVER DEBUG: [0x61a000115e80] created request Name# RollbackTransaction
2025-10-26T19:26:31.057110Z :GRPC_SERVER DEBUG: [0x61a000116480] created request Name# RollbackTransaction
2025-10-26T19:26:31.057361Z :GRPC_SERVER DEBUG: [0x61a000116a80] created request Name# RollbackTransaction
2025-10-26T19:26:31.057607Z :GRPC_SERVER DEBUG: [0x61a000117080] created request Name# RollbackTransaction
2025-10-26T19:26:31.057832Z :GRPC_SERVER DEBUG: [0x61a000117680] created request Name# RollbackTransaction
2025-10-26T19:26:31.058087Z :GRPC_SERVER DEBUG: [0x61a000117c80] created request Name# RollbackTransaction
2025-10-26T19:26:31.058287Z :GRPC_SERVER DEBUG: [0x61a000118280] created request Name# RollbackTransaction
2025-10-26T19:26:31.058515Z :GRPC_SERVER DEBUG: [0x61a000118880] created request Name# RollbackTransaction
2025-10-26T19:26:31.061794Z :GRPC_SERVER DEBUG: [0x61a000118e80] created request Name# RollbackTransaction
2025-10-26T19:26:31.062166Z :GRPC_SERVER DEBUG: [0x61a000119480] created request Name# RollbackTransaction
2025-10-26T19:26:31.066191Z :GRPC_SERVER DEBUG: [0x61a000119a80] created request Name# RollbackTransaction
2025-10-26T19:26:31.067835Z :GRPC_SERVER DEBUG: [0x61a00011a080] created request Name# RollbackTransaction
2025-10-26T19:26:31.068058Z :GRPC_SERVER DEBUG: [0x61a00011a680] created request Name# RollbackTransaction
2025-10-26T19:26:31.068258Z :GRPC_SERVER DEBUG: [0x61a00011ac80] created request Name# RollbackTransaction
2025-10-26T19:26:31.070025Z :BS_PROXY_DISCOVER WARN: [a6afeaf53143f528] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.070393Z :BS_PROXY_DISCOVER WARN: [246b7443afed7be8] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.071562Z :BS_PROXY_DISCOVER WARN: [b0924d9c39ef1020] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.071702Z :GRPC_SERVER DEBUG: [0x61a00011b280] created request Name# RollbackTransaction
2025-10-26T19:26:31.071705Z :BS_PROXY_DISCOVER WARN: [8c2d9c9dd5a88b20] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.071832Z :BS_PROXY_DISCOVER WARN: [9f47e16cec5c1f80] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.072092Z :GRPC_SERVER DEBUG: [0x61a00011b880] created request Name# RollbackTransaction
2025-10-26T19:26:31.072126Z :BS_PROXY_DISCOVER WARN: [c9090e4e7214657d] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.074001Z :BS_PROXY_DISCOVER WARN: [6f17e4b9790abcd8] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.074281Z :BS_PROXY_DISCOVER WARN: [1daef597c63be7e5] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.074517Z :BS_PROXY_DISCOVER WARN: [bcf1e1bee8cca48f] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.077461Z :GRPC_SERVER DEBUG: [0x61a00011be80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.077668Z :BS_PROXY_DISCOVER WARN: [2bf6c33530fe3bd8] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.082025Z :GRPC_SERVER DEBUG: [0x61a00011c480] created request Name# PrepareDataQuery
2025-10-26T19:26:31.086438Z :GRPC_SERVER DEBUG: [0x61a00011ca80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.086967Z :GRPC_SERVER DEBUG: [0x61a00011d080] created request Name# PrepareDataQuery
2025-10-26T19:26:31.087222Z :GRPC_SERVER DEBUG: [0x61a00011d680] created request Name# PrepareDataQuery
2025-10-26T19:26:31.087646Z :GRPC_SERVER DEBUG: [0x61a00011dc80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.087818Z :GRPC_SERVER DEBUG: [0x61a00011e280] created request Name# PrepareDataQuery
2025-10-26T19:26:31.087978Z :GRPC_SERVER DEBUG: [0x61a00011e880] created request Name# PrepareDataQuery
2025-10-26T19:26:31.088173Z :GRPC_SERVER DEBUG: [0x61a00011ee80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.088420Z :GRPC_SERVER DEBUG: [0x61a00011f480] created request Name# PrepareDataQuery
2025-10-26T19:26:31.088582Z :GRPC_SERVER DEBUG: [0x61a000120080] created request Name# PrepareDataQuery
2025-10-26T19:26:31.088717Z :GRPC_SERVER DEBUG: [0x61a000120680] created request Name# PrepareDataQuery
2025-10-26T19:26:31.090642Z :GRPC_SERVER DEBUG: [0x61a000120c80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.090853Z :GRPC_SERVER DEBUG: [0x61a000121280] created request Name# PrepareDataQuery
2025-10-26T19:26:31.091032Z :GRPC_SERVER DEBUG: [0x61a000121880] created request Name# PrepareDataQuery
2025-10-26T19:26:31.091200Z :GRPC_SERVER DEBUG: [0x61a000121e80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.094043Z :GRPC_SERVER DEBUG: [0x61a000122480] created request Name# PrepareDataQuery
2025-10-26T19:26:31.094598Z :GRPC_SERVER DEBUG: [0x61a000122a80] created request Name# PrepareDataQuery
2025-10-26T19:26:31.095368Z :GRPC_SERVER DEBUG: [0x61a000123080] created request Name# PrepareDataQuery
2025-10-26T19:26:31.095617Z :GRPC_SERVER DEBUG: [0x61a000123680] created request Name# PrepareDataQuery
2025-10-26T19:26:31.096414Z :GRPC_SERVER DEBUG: [0x61a000123c80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.097064Z :GRPC_SERVER DEBUG: [0x61a000124280] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.097301Z :GRPC_SERVER DEBUG: [0x61a000124880] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.097704Z :GRPC_SERVER DEBUG: [0x61a000124e80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.097923Z :GRPC_SERVER DEBUG: [0x61a000125480] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.098208Z :GRPC_SERVER DEBUG: [0x61a000125a80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.098930Z :GRPC_SERVER DEBUG: [0x61a000126080] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.100945Z :GRPC_SERVER DEBUG: [0x61a000126680] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.101623Z :GRPC_SERVER DEBUG: [0x61a000126c80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.102729Z :GRPC_SERVER DEBUG: [0x61a000127280] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.103038Z :GRPC_SERVER DEBUG: [0x61a000127880] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.103426Z :GRPC_SERVER DEBUG: [0x61a000127e80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.104557Z :GRPC_SERVER DEBUG: [0x61a000128480] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.107014Z :GRPC_SERVER DEBUG: [0x61a000128a80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.107529Z :GRPC_SERVER DEBUG: [0x61a000129080] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.107804Z :GRPC_SERVER DEBUG: [0x61a000129680] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.108073Z :GRPC_SERVER DEBUG: [0x61a000129c80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.108330Z :GRPC_SERVER DEBUG: [0x61a00012a280] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.109052Z :GRPC_SERVER DEBUG: [0x61a00012a880] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.109358Z :GRPC_SERVER DEBUG: [0x61a00012ae80] created request Name# ExecuteDataQuery
2025-10-26T19:26:31.111780Z :GRPC_SERVER DEBUG: [0x61a00012b480] created request Name# BulkUpsert
2025-10-26T19:26:31.122928Z :GRPC_SERVER DEBUG: [0x61a00012ba80] created request Name# BulkUpsert
2025-10-26T19:26:31.123774Z :GRPC_SERVER DEBUG: [0x61a00012c080] created request Name# BulkUpsert
2025-10-26T19:26:31.125342Z :GRPC_SERVER DEBUG: [0x61a00012c680] created request Name# BulkUpsert
2025-10-26T19:26:31.125615Z :GRPC_SERVER DEBUG: [0x61a00012cc80] created request Name# BulkUpsert
2025-10-26T19:26:31.125885Z :GRPC_SERVER DEBUG: [0x61a00012d280] created request Name# BulkUpsert
2025-10-26T19:26:31.126095Z :GRPC_SERVER DEBUG: [0x61a00012d880] created request Name# BulkUpsert
2025-10-26T19:26:31.128921Z :GRPC_SERVER DEBUG: [0x61a00012de80] created request Name# BulkUpsert
2025-10-26T19:26:31.129223Z :GRPC_SERVER DEBUG: [0x61a00012e480] created request Name# BulkUpsert
2025-10-26T19:26:31.129457Z :GRPC_SERVER DEBUG: [0x61a00012ea80] created request Name# BulkUpsert
2025-10-26T19:26:31.131345Z :GRPC_SERVER DEBUG: [0x61a00012f080] created request Name# BulkUpsert
2025-10-26T19:26:31.131841Z :GRPC_SERVER DEBUG: [0x61a00012f680] created request Name# BulkUpsert
2025-10-26T19:26:31.132193Z :GRPC_SERVER DEBUG: [0x61a00013fe80] created request Name# BulkUpsert
2025-10-26T19:26:31.132483Z :GRPC_SERVER DEBUG: [0x61a000140480] created request Name# BulkUpsert
2025-10-26T19:26:31.132883Z :GRPC_SERVER DEBUG: [0x61a000140a80] created request Name# BulkUpsert
2025-10-26T19:26:31.133222Z :GRPC_SERVER DEBUG: [0x61a000141080] created request Name# BulkUpsert
2025-10-26T19:26:31.133763Z :GRPC_SERVER DEBUG: [0x61a000141680] created request Name# BulkUpsert
2025-10-26T19:26:31.134223Z :GRPC_SERVER DEBUG: [0x61a000141c80] created request Name# BulkUpsert
2025-10-26T19:26:31.134489Z :GRPC_SERVER DEBUG: [0x61a000142280] created request Name# BulkUpsert
2025-10-26T19:26:31.137507Z :GRPC_SERVER DEBUG: [0x61a000142880] created request Name# BulkUpsert
2025-10-26T19:26:31.138601Z :GRPC_SERVER DEBUG: [0x61a000142e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.138911Z :GRPC_SERVER DEBUG: [0x61a000143480] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.139181Z :GRPC_SERVER DEBUG: [0x61a000143a80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.140116Z :GRPC_SERVER DEBUG: [0x61a000144080] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.140374Z :GRPC_SERVER DEBUG: [0x61a000144680] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.140878Z :GRPC_SERVER DEBUG: [0x61a000144c80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.141186Z :GRPC_SERVER DEBUG: [0x61a000145280] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.141447Z :GRPC_SERVER DEBUG: [0x61a000145880] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.141728Z :GRPC_SERVER DEBUG: [0x61a000145e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.142224Z :GRPC_SERVER DEBUG: [0x61a000146480] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.142546Z :GRPC_SERVER DEBUG: [0x61a000146a80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.144625Z :GRPC_SERVER DEBUG: [0x61a000147080] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.144958Z :GRPC_SERVER DEBUG: [0x61a000147680] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.145214Z :GRPC_SERVER DEBUG: [0x61a000147c80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.145453Z :GRPC_SERVER DEBUG: [0x61a000148280] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.145866Z :GRPC_SERVER DEBUG: [0x61a000148880] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.146552Z :GRPC_SERVER DEBUG: [0x61a000148e80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.146839Z :GRPC_SERVER DEBUG: [0x61a000149480] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.147107Z :GRPC_SERVER DEBUG: [0x61a000149a80] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.147373Z :GRPC_SERVER DEBUG: [0x61a00014a080] created streaming request Name# StreamExecuteScanQuery
2025-10-26T19:26:31.147878Z :GRPC_SERVER DEBUG: [0x61a00014a680] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.148558Z :GRPC_SERVER DEBUG: [0x61a00014ac80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.148915Z :GRPC_SERVER DEBUG: [0x61a00014b280] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.149163Z :GRPC_SERVER DEBUG: [0x61a00014b880] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.149420Z :GRPC_SERVER DEBUG: [0x61a00014be80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.149616Z :GRPC_SERVER DEBUG: [0x61a00014c480] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.149888Z :GRPC_SERVER DEBUG: [0x61a00014ca80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.150151Z :GRPC_SERVER DEBUG: [0x61a00014d080] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.150418Z :GRPC_SERVER DEBUG: [0x61a00014d680] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.150789Z :GRPC_SERVER DEBUG: [0x61a00014dc80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.151146Z :GRPC_SERVER DEBUG: [0x61a00014e280] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.151687Z :GRPC_SERVER DEBUG: [0x61a00014e880] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.151936Z :GRPC_SERVER DEBUG: [0x61a00014ee80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.152217Z :GRPC_SERVER DEBUG: [0x61a00014f480] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.157956Z :GRPC_SERVER DEBUG: [0x61a000150080] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.158377Z :GRPC_SERVER DEBUG: [0x61a000150680] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.159991Z :GRPC_SERVER DEBUG: [0x61a000150c80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.160275Z :GRPC_SERVER DEBUG: [0x61a000151280] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.162141Z :GRPC_SERVER DEBUG: [0x61a000151880] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.162462Z :GRPC_SERVER DEBUG: [0x61a000151e80] created streaming request Name# StreamReadTable
2025-10-26T19:26:31.163142Z :GRPC_SERVER DEBUG: [0x61a000152480] created request Name# ReadRows
2025-10-26T19:26:31.163678Z :GRPC_SERVER DEBUG: [0x61a000152a80] created request Name# ReadRows
2025-10-26T19:26:31.164066Z :GRPC_SERVER DEBUG: [0x61a000153080] created request Name# ReadRows
2025-10-26T19:26:31.164363Z :GRPC_SERVER DEBUG: [0x61a000153680] created request Name# ReadRows
2025-10-26T19:26:31.164678Z :GRPC_SERVER DEBUG: [0x61a000153c80] created request Name# ReadRows
2025-10-26T19:26:31.164965Z :GRPC_SERVER DEBUG: [0x61a000154280] created request Name# ReadRows
2025-10-26T19:26:31.165201Z :GRPC_SERVER DEBUG: [0x61a000154880] created request Name# ReadRows
2025-10-26T19:26:31.165962Z :GRPC_SERVER DEBUG: [0x61a000154e80] created request Name# ReadRows
2025-10-26T19:26:31.167920Z :GRPC_SERVER DEBUG: [0x61a000155480] created request Name# ReadRows
2025-10-26T19:26:31.168274Z :GRPC_SERVER DEBUG: [0x61a000155a80] created request Name# ReadRows
2025-10-26T19:26:31.168801Z :GRPC_SERVER DEBUG: [0x61a000156080] created request Name# ReadRows
2025-10-26T19:26:31.170001Z :GRPC_SERVER DEBUG: [0x61a000156680] created request Name# ReadRows
2025-10-26T19:26:31.173973Z :GRPC_SERVER DEBUG: [0x61a000156c80] created request Name# ReadRows
2025-10-26T19:26:31.175349Z :GRPC_SERVER DEBUG: [0x61a000157280] created request Name# ReadRows
2025-10-26T19:26:31.175619Z :GRPC_SERVER DEBUG: [0x61a000157880] created request Name# ReadRows
2025-10-26T19:26:31.176067Z :GRPC_SERVER DEBUG: [0x61a000157e80] created request Name# ReadRows
2025-10-26T19:26:31.176477Z :GRPC_SERVER DEBUG: [0x61a000158480] created request Name# ReadRows
2025-10-26T19:26:31.176784Z :GRPC_SERVER DEBUG: [0x61a000158a80] created request Name# ReadRows
2025-10-26T19:26:31.177034Z :GRPC_SERVER DEBUG: [0x61a000159080] created request Name# ReadRows
2025-10-26T19:26:31.177290Z :GRPC_SERVER DEBUG: [0x61a000159680] created request Name# ReadRows
2025-10-26T19:26:31.178254Z :GRPC_SERVER DEBUG: [0x61a000159c80] created request Name# Scan
2025-10-26T19:26:31.178710Z :GRPC_SERVER DEBUG: [0x61a00015a280] created request Name# GetShardLocations
2025-10-26T19:26:31.179171Z :GRPC_SERVER DEBUG: [0x61a00015a880] created request Name# DescribeTable
2025-10-26T19:26:31.182298Z :GRPC_SERVER DEBUG: [0x61a00015ae80] created request Name# CreateSnapshot
2025-10-26T19:26:31.183696Z :GRPC_SERVER DEBUG: [0x61a00015b480] created request Name# RefreshSnapshot
2025-10-26T19:26:31.183804Z :BS_PROXY_DISCOVER WARN: [dcf0cea100d24ac4] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.184007Z :BS_PROXY_DISCOVER WARN: [91aa8d8b41b3a824] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.184134Z :BS_PROXY_DISCOVER WARN: [32d4ca9fae32db2e] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.184145Z :GRPC_SERVER DEBUG: [0x61a00015ba80] created request Name# DiscardSnapshot
2025-10-26T19:26:31.184706Z :BS_PROXY_DISCOVER WARN: [66280474e9f46843] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.185082Z :BS_PROXY_DISCOVER WARN: [335010032f5d963f] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.185334Z :GRPC_SERVER DEBUG: [0x61a00015c080] created request Name# ExecuteYql
2025-10-26T19:26:31.185666Z :BS_PROXY_DISCOVER WARN: [7b617a40c12e1bb9] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.185847Z :GRPC_SERVER DEBUG: [0x61a00015c680] created streaming request Name# StreamExecuteYql
2025-10-26T19:26:31.186375Z :GRPC_SERVER DEBUG: [0x61a00015cc80] created request Name# ExplainYql
2025-10-26T19:26:31.186834Z :GRPC_SERVER DEBUG: [0x61a00015d280] created request Name# MakeDirectory
2025-10-26T19:26:31.187671Z :GRPC_SERVER DEBUG: [0x61a00015d880] created request Name# RemoveDirectory
2025-10-26T19:26:31.188227Z :GRPC_SERVER DEBUG: [0x61a00015de80] created request Name# ListDirectory
2025-10-26T19:26:31.188664Z :GRPC_SERVER DEBUG: [0x61a00015e480] created request Name# DescribePath
2025-10-26T19:26:31.198581Z :GRPC_SERVER DEBUG: [0x61a00015ea80] created request Name# ModifyPermissions
2025-10-26T19:26:31.199209Z :GRPC_SERVER DEBUG: [0x61a00015f080] created request Name# GetOperation
2025-10-26T19:26:31.199820Z :GRPC_SERVER DEBUG: [0x61a00015f680] created request Name# CancelOperation
2025-10-26T19:26:31.201199Z :GRPC_SERVER DEBUG: [0x61a00015fc80] created request Name# ForgetOperation
2025-10-26T19:26:31.206207Z :GRPC_SERVER DEBUG: [0x61a000160280] created request Name# ListOperations
2025-10-26T19:26:31.206607Z :GRPC_SERVER INFO: Updated app config
2025-10-26T19:26:31.206666Z :GRPC_SERVER INFO: Updated app config
2025-10-26T19:26:31.206814Z :GRPC_SERVER DEBUG: [0x61a000160880] created request Name# ExportToYt
2025-10-26T19:26:31.208208Z :GRPC_SERVER DEBUG: [0x61a000160e80] created request Name# ExportToS3
2025-10-26T19:26:31.208768Z :GRPC_SERVER DEBUG: [0x61a000161480] created request Name# ImportFromS3
2025-10-26T19:26:31.215013Z :GRPC_SERVER DEBUG: [0x61a000161a80] created request Name# ImportData
2025-10-26T19:26:31.217483Z :GRPC_SERVER DEBUG: [0x61a000162080] created request Name# Coordination/CreateNode
2025-10-26T19:26:31.218101Z :GRPC_SERVER DEBUG: [0x61a000162680] created request Name# Coordination/AlterNode
2025-10-26T19:26:31.226163Z :BS_PROXY_DISCOVER WARN: [ef9cbe08d576d1d1] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:31.226368Z :BS_PROXY_DISCOVER WARN: [05b62f4a9be03af4] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.230483Z :GRPC_SERVER DEBUG: [0x61a000162c80] created request Name# Coordination/DropNode
2025-10-26T19:26:31.234200Z :GRPC_SERVER DEBUG: [0x61a000163280] created request Name# Coordination/DescribeNode
2025-10-26T19:26:31.234793Z :BS_PROXY_DISCOVER WARN: [fd0d0390d80b7e93] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.337161Z :NET_CLASSIFIER WARN: distributable config is empty, broken or outdated, will use file: /home/runner/.ya/build/build_root/70hy/0010a7/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk1/testing_out_stuff/netData.tsv
2025-10-26T19:26:31.337195Z :NET_CLASSIFIER WARN: will try to initialize from file: /home/runner/.ya/build/build_root/70hy/0010a7/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk1/testing_out_stuff/netData.tsv
2025-10-26T19:26:31.337410Z :NET_CLASSIFIER WARN: successfully initialized from file: /home/runner/.ya/build/build_root/70hy/0010a7/ydb/tests/functional/audit/test-results/py3test/testing_out_stuff/test_auditlog/chunk1/testing_out_stuff/netData.tsv
2025-10-26T19:26:31.337613Z :NET_CLASSIFIER ERROR: got bad distributable configuration
2025-10-26T19:26:31.368776Z :STATISTICS WARN: [72075186224037897] TTxInit::Complete. EnableColumnStatistics=false
2025-10-26T19:26:31.373942Z :BS_PROXY_DISCOVER WARN: [86d9bfbeb3de7959] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:31.375394Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828672, Sender [50000:7565614055083342996:4122], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTablet::TEvBoot
2025-10-26T19:26:31.379620Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828673, Sender [50000:7565614055083342996:4122], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTablet::TEvRestored
2025-10-26T19:26:31.380250Z :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-26T19:26:31.380347Z :FLAT_TX_SCHEMESHARD NOTICE: BorrowedCompactionQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T19:26:31.380386Z :FLAT_TX_SCHEMESHARD NOTICE: StatsBatching config: StatsBatchTimeout# 0.100000s, StatsMaxBatchSize# 100, StatsMaxExecuteTime# 0.010000s
2025-10-26T19:26:31.380429Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: using default configuration
2025-10-26T19:26:31.380484Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxMergeTablePartition, limit 10000
2025-10-26T19:26:31.380510Z :FLAT_TX_SCHEMESHARD NOTICE: OperationsProcessing config: type TxSplitTablePartition, limit 10000
2025-10-26T19:26:31.380663Z :FLAT_TX_SCHEMESHARD NOTICE: BackgroundCleaningQueue configured: Timeout# 15.000000s, Rate# 0, WakeupInterval# 1.000000s, InflightLimit# 10
2025-10-26T19:26:31.381214Z :FLAT_TX_SCHEMESHARD DEBUG: TxInitSchema.Execute
2025-10-26T19:26:31.382917Z :GRPC_SERVER DEBUG: [0x61a000163e80] created request Name# PersQueueService/GetReadSessionsInfo
2025-10-26T19:26:31.383574Z :GRPC_SERVER DEBUG: [0x61a000164480] created request Name# PersQueueService/DropTopic
2025-10-26T19:26:31.384965Z :GRPC_SERVER DEBUG: [0x61a000164a80] created request Name# PersQueueService/CreateTopic
2025-10-26T19:26:31.385517Z :GRPC_SERVER DEBUG: [0x61a000165080] created request Name# PersQueueService/AlterTopic
2025-10-26T19:26:31.386534Z :GRPC_SERVER DEBUG: [0x61a000165680] created request Name# PersQueueService/DescribeTopic
2025-10-26T19:26:31.387047Z :GRPC_SERVER DEBUG: [0x61a000165c80] created request Name# PersQueueService/AddReadRule
2025-10-26T19:26:31.387548Z :GRPC_SERVER DEBUG: [0x61a000166280] created request Name# PersQueueService/RemoveReadRule
2025-10-26T19:26:31.390431Z :GRPC_SERVER DEBUG: [0x61a000166880] created request Name# TopicService/CommitOffset
2025-10-26T19:26:31.391416Z :GRPC_SERVER DEBUG: [0x61a000166e80] created request Name# TopicService/DropTopic
2025-10-26T19:26:31.392685Z :GRPC_SERVER DEBUG: [0x61a000167480] created request Name# TopicService/CreateTopic
2025-10-26T19:26:31.399207Z :GRPC_SERVER DEBUG: [0x61a000167a80] created request Name# TopicService/AlterTopic
2025-10-26T19:26:31.400844Z :GRPC_SERVER DEBUG: [0x61a000168080] created request Name# TopicService/DescribeTopic
2025-10-26T19:26:31.401581Z :GRPC_SERVER DEBUG: [0x61a000168680] created request Name# TopicService/DescribeConsumer
2025-10-26T19:26:31.402382Z :GRPC_SERVER DEBUG: [0x61a000168c80] created request Name# TopicService/DescribePartition
2025-10-26T19:26:31.403172Z :GRPC_SERVER DEBUG: [0x61a000169280] created request Name# UpdateOffsetsInTransaction
2025-10-26T19:26:31.404117Z :GRPC_SERVER DEBUG: [0x61a000169880] created request Name# DiscoverClusters
2025-10-26T19:26:31.404792Z :GRPC_SERVER DEBUG: [0x61a000169e80] created request Name# CreateDatabase
2025-10-26T19:26:31.405376Z :GRPC_SERVER DEBUG: [0x61a00016a480] created request Name# AlterDatabase
2025-10-26T19:26:31.405895Z :GRPC_SERVER DEBUG: [0x61a00016aa80] created request Name# GetDatabaseStatus
2025-10-26T19:26:31.406388Z :GRPC_SERVER DEBUG: [0x61a00016b080] created request Name# ListDatabases
2025-10-26T19:26:31.406788Z :GRPC_SERVER DEBUG: [0x61a00016b680] created request Name# RemoveDatabase
2025-10-26T19:26:31.407223Z :GRPC_SERVER DEBUG: [0x61a00016bc80] created request Name# DescribeDatabaseOptions
2025-10-26T19:26:31.408574Z :GRPC_SERVER DEBUG: [0x61a00016c280] created request Name# GetScaleRecommendation
2025-10-26T19:26:31.409920Z :GRPC_SERVER DEBUG: [0x61a00016c880] created request Name# SetConfig
2025-10-26T19:26:31.410577Z :GRPC_SERVER DEBUG: [0x61a00016ce80] created request Name# ReplaceConfig
2025-10-26T19:26:31.411059Z :GRPC_SERVER DEBUG: [0x61a00016d480] created request Name# DropConfig
2025-10-26T19:26:31.411522Z :GRPC_SERVER DEBUG: [0x61a00016da80] created request Name# AddVolatileConfig
2025-10-26T19:26:31.413331Z :GRPC_SERVER DEBUG: [0x61a00016e080] created request Name# RemoveVolatileConfig
2025-10-26T19:26:31.413882Z :GRPC_SERVER DEBUG: [0x61a00016e680] created request Name# GetConfig
2025-10-26T19:26:31.414358Z :GRPC_SERVER DEBUG: [0x61a00016ec80] created request Name# GetMetadata
2025-10-26T19:26:31.414786Z :GRPC_SERVER DEBUG: [0x61a00016f280] created request Name# GetNodeLabels
2025-10-26T19:26:31.423079Z :GRPC_SERVER DEBUG: [0x61a00016fe80] created request Name# ResolveConfig
2025-10-26T19:26:31.423837Z :GRPC_SERVER DEBUG: [0x61a000170480] created request Name# ResolveAllConfig
2025-10-26T19:26:31.425499Z :GRPC_SERVER DEBUG: [0x61a000170a80] created request Name# WhoAmI
2025-10-26T19:26:31.426027Z :GRPC_SERVER DEBUG: [0x61a000171080] created request Name# NodeRegistration
2025-10-26T19:26:31.426958Z :GRPC_SERVER DEBUG: [0x61a000171680] created request Name# ListEndpoints
2025-10-26T19:26:31.427672Z :GRPC_SERVER DEBUG: [0x61a000171c80] created request Name# RateLimiter/CreateResource
2025-10-26T19:26:31.428160Z :GRPC_SERVER DEBUG: [0x61a000172280] created request Name# RateLimiter/AlterResource
2025-10-26T19:26:31.430709Z :GRPC_SERVER DEBUG: [0x61a000172880] created request Name# RateLimiter/DropResource
2025-10-26T19:26:31.431873Z :GRPC_SERVER DEBUG: [0x61a000172e80] created request Name# RateLimiter/ListResources
2025-10-26T19:26:31.432341Z :GRPC_SERVER DEBUG: [0x61a000173480] created request Name# RateLimiter/DescribeResource
2025-10-26T19:26:31.432785Z :GRPC_SERVER DEBUG: [0x61a000173a80] created request Name# RateLimiter/AcquireResource
2025-10-26T19:26:31.433321Z :GRPC_SERVER DEBUG: [0x61a000174080] created request Name# SelfCheck
2025-10-26T19:26:31.433796Z :GRPC_SERVER DEBUG: [0x61a000174680] created request Name# NodeCheck
2025-10-26T19:26:31.434237Z :GRPC_SERVER DEBUG: [0x61a000174c80] created request Name# Login
2025-10-26T19:26:31.435332Z :GRPC_SERVER DEBUG: [0x61a000175280] created request Name# DescribeStream
2025-10-26T19:26:31.438465Z :GRPC_SERVER DEBUG: [0x61a000175880] created request Name# CreateStream
2025-10-26T19:26:31.439302Z :GRPC_SERVER DEBUG: [0x61a000175e80] created request Name# ListStreams
2025-10-26T19:26:31.440841Z :GRPC_SERVER DEBUG: [0x61a000176480] created request Name# DeleteStream
2025-10-26T19:26:31.441219Z :GRPC_SERVER DEBUG: [0x61a000176a80] created request Name# ListShards
2025-10-26T19:26:31.441570Z :GRPC_SERVER DEBUG: [0x61a000177080] created request Name# PutRecord
2025-10-26T19:26:31.441981Z :GRPC_SERVER DEBUG: [0x61a000177680] created request Name# PutRecords
2025-10-26T19:26:31.442417Z :GRPC_SERVER DEBUG: [0x61a000177c80] created request Name# GetRecords
2025-10-26T19:26:31.442785Z :GRPC_SERVER DEBUG: [0x61a000178280] created request Name# GetShardIterator
2025-10-26T19:26:31.443151Z :GRPC_SERVER DEBUG: [0x61a000178880] created streaming request Name# SubscribeToShard
2025-10-26T19:26:31.443522Z :GRPC_SERVER DEBUG: [0x61a000178e80] created request Name# DescribeLimits
2025-10-26T19:26:31.443881Z :GRPC_SERVER DEBUG: [0x61a000179480] created request Name# DescribeStreamSummary
2025-10-26T19:26:31.444252Z :GRPC_SERVER DEBUG: [0x61a000179a80] created request Name# DecreaseStreamRetentionPeriod
2025-10-26T19:26:31.444617Z :GRPC_SERVER DEBUG: [0x61a00017a080] created request Name# IncreaseStreamRetentionPeriod
2025-10-26T19:26:31.445009Z :GRPC_SERVER DEBUG: [0x61a00017a680] created request Name# UpdateShardCount
2025-10-26T19:26:31.445361Z :GRPC_SERVER DEBUG: [0x61a00017ac80] created request Name# UpdateStreamMode
2025-10-26T19:26:31.451346Z :GRPC_SERVER DEBUG: [0x61a00017b280] created request Name# RegisterStreamConsumer
2025-10-26T19:26:31.452129Z :GRPC_SERVER DEBUG: [0x61a00017b880] created request Name# DeregisterStreamConsumer
2025-10-26T19:26:31.453191Z :GRPC_SERVER DEBUG: [0x61a00017be80] created request Name# DescribeStreamConsumer
2025-10-26T19:26:31.455941Z :GRPC_SERVER DEBUG: [0x61a00017c480] created request Name# ListStreamConsumers
2025-10-26T19:26:31.456376Z :GRPC_SERVER DEBUG: [0x61a00017ca80] created request Name# AddTagsToStream
2025-10-26T19:26:31.456764Z :GRPC_SERVER DEBUG: [0x61a00017d080] created request Name# DisableEnhancedMonitoring
2025-10-26T19:26:31.457646Z :GRPC_SERVER DEBUG: [0x61a00017d680] created request Name# EnableEnhancedMonitoring
2025-10-26T19:26:31.458101Z :GRPC_SERVER DEBUG: [0x61a00017dc80] created request Name# ListTagsForStream
2025-10-26T19:26:31.458521Z :GRPC_SERVER DEBUG: [0x61a00017e280] created request Name# MergeShards
2025-10-26T19:26:31.458920Z :GRPC_SERVER DEBUG: [0x61a00017e880] created request Name# RemoveTagsFromStream
2025-10-26T19:26:31.459266Z :GRPC_SERVER DEBUG: [0x61a00017ee80] created request Name# SplitShard
2025-10-26T19:26:31.461763Z :GRPC_SERVER DEBUG: [0x61a00017f480] created request Name# StartStreamEncryption
2025-10-26T19:26:31.465181Z :GRPC_SERVER DEBUG: [0x61a000180080] created request Name# StopStreamEncryption
2025-10-26T19:26:31.465794Z :GRPC_SERVER DEBUG: [0x61a000180680] created request Name# UpdateStream
2025-10-26T19:26:31.466304Z :GRPC_SERVER DEBUG: [0x61a000180c80] created request Name# SetWriteQuota
2025-10-26T19:26:31.466898Z :GRPC_SERVER DEBUG: [0x61a000181280] created request Name# CreateQuery
2025-10-26T19:26:31.467415Z :GRPC_SERVER DEBUG: [0x61a000181880] created request Name# ListQueries
2025-10-26T19:26:31.467980Z :GRPC_SERVER DEBUG: [0x61a000181e80] created request Name# DescribeQuery
2025-10-26T19:26:31.468422Z :GRPC_SERVER DEBUG: [0x61a000182480] created request Name# GetQueryStatus
2025-10-26T19:26:31.469050Z :GRPC_SERVER DEBUG: [0x61a000182a80] created request Name# ModifyQuery
2025-10-26T19:26:31.469703Z :GRPC_SERVER DEBUG: [0x61a000183080] created request Name# DeleteQuery
2025-10-26T19:26:31.470455Z :GRPC_SERVER DEBUG: [0x61a000183680] created request Name# ControlQuery
2025-10-26T19:26:31.471073Z :GRPC_SERVER DEBUG: [0x61a000183c80] created request Name# GetResultData
2025-10-26T19:26:31.471599Z :GRPC_SERVER DEBUG: [0x61a000184280] created request Name# ListJobs
2025-10-26T19:26:31.472077Z :GRPC_SERVER DEBUG: [0x61a000184880] created request Name# DescribeJob
2025-10-26T19:26:31.472570Z :GRPC_SERVER DEBUG: [0x61a000184e80] created request Name# CreateConnection
2025-10-26T19:26:31.473085Z :GRPC_SERVER DEBUG: [0x61a000185480] created request Name# ListConnections
2025-10-26T19:26:31.473844Z :GRPC_SERVER DEBUG: [0x61a000185a80] created request Name# DescribeConnection
2025-10-26T19:26:31.474414Z :GRPC_SERVER DEBUG: [0x61a000186080] created request Name# ModifyConnection
2025-10-26T19:26:31.475019Z :GRPC_SERVER DEBUG: [0x61a000186680] created request Name# DeleteConnection
2025-10-26T19:26:31.475601Z :GRPC_SERVER DEBUG: [0x61a000186c80] created request Name# TestConnection
2025-10-26T19:26:31.476360Z :GRPC_SERVER DEBUG: [0x61a000187280] created request Name# CreateBinding
2025-10-26T19:26:31.476917Z :GRPC_SERVER DEBUG: [0x61a000187880] created request Name# ListBindings
2025-10-26T19:26:31.477365Z :GRPC_SERVER DEBUG: [0x61a000187e80] created request Name# DescribeBinding
2025-10-26T19:26:31.477812Z :GRPC_SERVER DEBUG: [0x61a000188480] created request Name# ModifyBinding
2025-10-26T19:26:31.478368Z :GRPC_SERVER DEBUG: [0x61a000188a80] created request Name# DeleteBinding
2025-10-26T19:26:31.479080Z :GRPC_SERVER DEBUG: [0x61a000189080] created request Name# PingTask
2025-10-26T19:26:31.479648Z :GRPC_SERVER DEBUG: [0x61a000189680] created request Name# GetTask
2025-10-26T19:26:31.480088Z :GRPC_SERVER DEBUG: [0x61a000189c80] created request Name# WriteTaskResult
2025-10-26T19:26:31.480638Z :GRPC_SERVER DEBUG: [0x61a00018a280] created request Name# NodesHealthCheck
2025-10-26T19:26:31.481091Z :GRPC_SERVER DEBUG: [0x61a00018a880] created request Name# CreateRateLimiterResource
2025-10-26T19:26:31.481524Z :GRPC_SERVER DEBUG: [0x61a00018ae80] created request Name# DeleteRateLimiterResource
2025-10-26T19:26:31.482523Z :GRPC_SERVER DEBUG: [0x61a00018b480] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.483692Z :GRPC_SERVER DEBUG: [0x61a00018ba80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.484022Z :GRPC_SERVER DEBUG: [0x61a00018c080] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.484762Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 268828684, Sender [50000:7565614055083342996:4122], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTablet::TEvFollowerSyncComplete
2025-10-26T19:26:31.485188Z :GRPC_SERVER DEBUG: [0x61a00018c680] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.485635Z :GRPC_SERVER DEBUG: [0x61a00018cc80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.486031Z :GRPC_SERVER DEBUG: [0x61a00018d280] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.486299Z :GRPC_SERVER DEBUG: [0x61a00018d880] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.487249Z :GRPC_SERVER DEBUG: [0x61a00018de80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.487612Z :GRPC_SERVER DEBUG: [0x61a00018e480] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.487870Z :GRPC_SERVER DEBUG: [0x61a00018ea80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.488836Z :GRPC_SERVER DEBUG: [0x61a00018f080] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.489087Z :GRPC_SERVER DEBUG: [0x61a00018f680] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.489390Z :GRPC_SERVER DEBUG: [0x61a00018fc80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.489651Z :GRPC_SERVER DEBUG: [0x61a000190280] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.489887Z :GRPC_SERVER DEBUG: [0x61a000190880] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.490135Z :GRPC_SERVER DEBUG: [0x61a000190e80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.490344Z :GRPC_SERVER DEBUG: [0x61a000191480] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.490593Z :GRPC_SERVER DEBUG: [0x61a000191a80] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.490814Z :GRPC_SERVER DEBUG: [0x61a000192080] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.491005Z :GRPC_SERVER DEBUG: [0x61a000192680] created streaming request Name# ExecuteQuery
2025-10-26T19:26:31.491469Z :GRPC_SERVER DEBUG: [0x61a000192c80] created request Name# ExecuteScript
2025-10-26T19:26:31.491748Z :GRPC_SERVER DEBUG: [0x61a000193280] created request Name# ExecuteScript
2025-10-26T19:26:31.491980Z :GRPC_SERVER DEBUG: [0x61a000193880] created request Name# ExecuteScript
2025-10-26T19:26:31.492225Z :GRPC_SERVER DEBUG: [0x61a000193e80] created request Name# ExecuteScript
2025-10-26T19:26:31.492439Z :GRPC_SERVER DEBUG: [0x61a000194480] created request Name# ExecuteScript
2025-10-26T19:26:31.492638Z :GRPC_SERVER DEBUG: [0x61a000194a80] created request Name# ExecuteScript
2025-10-26T19:26:31.492901Z :GRPC_SERVER DEBUG: [0x61a000195080] created request Name# ExecuteScript
2025-10-26T19:26:31.493133Z :GRPC_SERVER DEBUG: [0x61a000195680] created request Name# ExecuteScript
2025-10-26T19:26:31.493330Z :GRPC_SERVER DEBUG: [0x61a000195c80] created request Name# ExecuteScript
2025-10-26T19:26:31.493613Z :GRPC_SERVER DEBUG: [0x61a000196280] created request Name# ExecuteScript
2025-10-26T19:26:31.499861Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 273481729, Sender [50000:7565614055083342815:4109], Recipient [50000:7565614059378310487:91]: NKikimr::NConsole::TEvConfigsDispatcher::TEvSetConfigSubscriptionResponse
2025-10-26T19:26:31.499924Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, processing event NConsole::TEvConfigsDispatcher::TEvSetConfigSubscriptionResponse
2025-10-26T19:26:31.499938Z :FLAT_TX_SCHEMESHARD NOTICE: Subscription to Console has been set up, schemeshardId: 72075186224037889
2025-10-26T19:26:31.500031Z :FLAT_TX_SCHEMESHARD DEBUG: TxInitSchema.Complete
2025-10-26T19:26:31.500033Z :GRPC_SERVER DEBUG: [0x61a000196880] created request Name# ExecuteScript
2025-10-26T19:26:31.500707Z :GRPC_SERVER DEBUG: [0x61a000196e80] created request Name# ExecuteScript
2025-10-26T19:26:31.501026Z :GRPC_SERVER DEBUG: [0x61a000197480] created request Name# ExecuteScript
2025-10-26T19:26:31.501348Z :GRPC_SERVER DEBUG: [0x61a000197a80] created request Name# ExecuteScript
2025-10-26T19:26:31.501677Z :GRPC_SERVER DEBUG: [0x61a000198080] created request Name# ExecuteScript
2025-10-26T19:26:31.502040Z :GRPC_SERVER DEBUG: [0x61a000198680] created request Name# ExecuteScript
2025-10-26T19:26:31.502399Z :GRPC_SERVER DEBUG: [0x61a000198c80] created request Name# ExecuteScript
2025-10-26T19:26:31.503170Z :GRPC_SERVER DEBUG: [0x61a000199280] created request Name# ExecuteScript
2025-10-26T19:26:31.504798Z :GRPC_SERVER DEBUG: [0x61a000199880] created request Name# ExecuteScript
2025-10-26T19:26:31.505474Z :GRPC_SERVER DEBUG: [0x61a000199e80] created request Name# ExecuteScript
2025-10-26T19:26:31.506056Z :GRPC_SERVER DEBUG: [0x61a00019a480] created request Name# FetchScriptResults
2025-10-26T19:26:31.507398Z :GRPC_SERVER DEBUG: [0x61a00019aa80] created request Name# FetchScriptResults
2025-10-26T19:26:31.509061Z :GRPC_SERVER DEBUG: [0x61a00019b080] created request Name# FetchScriptResults
2025-10-26T19:26:31.509595Z :GRPC_SERVER DEBUG: [0x61a00019b680] created request Name# FetchScriptResults
2025-10-26T19:26:31.509926Z :GRPC_SERVER DEBUG: [0x61a00019bc80] created request Name# FetchScriptResults
2025-10-26T19:26:31.510212Z :GRPC_SERVER DEBUG: [0x61a00019c280] created request Name# FetchScriptResults
2025-10-26T19:26:31.510408Z :GRPC_SERVER DEBUG: [0x61a00019c880] created request Name# FetchScriptResults
2025-10-26T19:26:31.510671Z :GRPC_SERVER DEBUG: [0x61a00019ce80] created request Name# FetchScriptResults
2025-10-26T19:26:31.510906Z :GRPC_SERVER DEBUG: [0x61a00019d480] created request Name# FetchScriptResults
2025-10-26T19:26:31.511126Z :GRPC_SERVER DEBUG: [0x61a00019da80] created request Name# FetchScriptResults
2025-10-26T19:26:31.512466Z :GRPC_SERVER DEBUG: [0x61a00019e080] created request Name# FetchScriptResults
2025-10-26T19:26:31.512773Z :GRPC_SERVER DEBUG: [0x61a00019e680] created request Name# FetchScriptResults
2025-10-26T19:26:31.513109Z :GRPC_SERVER DEBUG: [0x61a00019ec80] created request Name# FetchScriptResults
2025-10-26T19:26:31.513369Z :GRPC_SERVER DEBUG: [0x61a00019f280] created request Name# FetchScriptResults
2025-10-26T19:26:31.513867Z :GRPC_SERVER DEBUG: [0x61a00019fe80] created request Name# FetchScriptResults
2025-10-26T19:26:31.514491Z :GRPC_SERVER DEBUG: [0x61a0001a0480] created request Name# FetchScriptResults
2025-10-26T19:26:31.514749Z :GRPC_SERVER DEBUG: [0x61a0001a0a80] created request Name# FetchScriptResults
2025-10-26T19:26:31.514999Z :GRPC_SERVER DEBUG: [0x61a0001a1080] created request Name# FetchScriptResults
2025-10-26T19:26:31.515202Z :GRPC_SERVER DEBUG: [0x61a0001a1680] created request Name# FetchScriptResults
2025-10-26T19:26:31.515440Z :GRPC_SERVER DEBUG: [0x61a0001a1c80] created request Name# FetchScriptResults
2025-10-26T19:26:31.516163Z :GRPC_SERVER DEBUG: [0x61a0001a2280] created request Name# CreateSession
2025-10-26T19:26:31.518218Z :GRPC_SERVER DEBUG: [0x61a0001a2880] created request Name# CreateSession
2025-10-26T19:26:31.518617Z :GRPC_SERVER DEBUG: [0x61a0001a2e80] created request Name# CreateSession
2025-10-26T19:26:31.518844Z :GRPC_SERVER DEBUG: [0x61a0001a3480] created request Name# CreateSession
2025-10-26T19:26:31.519091Z :GRPC_SERVER DEBUG: [0x61a0001a3a80] created request Name# CreateSession
2025-10-26T19:26:31.519400Z :GRPC_SERVER DEBUG: [0x61a0001a4080] created request Name# CreateSession
2025-10-26T19:26:31.519660Z :GRPC_SERVER DEBUG: [0x61a0001a4680] created request Name# CreateSession
2025-10-26T19:26:31.519936Z :GRPC_SERVER DEBUG: [0x61a0001a4c80] created request Name# CreateSession
2025-10-26T19:26:31.520230Z :GRPC_SERVER DEBUG: [0x61a0001a5280] created request Name# CreateSession
2025-10-26T19:26:31.520485Z :GRPC_SERVER DEBUG: [0x61a0001a5880] created request Name# CreateSession
2025-10-26T19:26:31.520704Z :GRPC_SERVER DEBUG: [0x61a0001a5e80] created request Name# CreateSession
2025-10-26T19:26:31.520951Z :GRPC_SERVER DEBUG: [0x61a0001a6480] created request Name# CreateSession
2025-10-26T19:26:31.521026Z :FLAT_TX_SCHEMESHARD TRACE: StateInit, received event# 273285138, Sender [50000:7565614055083342815:4109], Recipient [50000:7565614059378310487:91]: 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-26T19:26:31.521229Z :GRPC_SERVER DEBUG: [0x61a0001a6a80] created request Name# CreateSession
2025-10-26T19:26:31.521544Z :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-26T19:26:31.521569Z :IMPORT NOTICE: Load table profiles
2025-10-26T19:26:31.521957Z :GRPC_SERVER DEBUG: [0x61a0001a7080] created request Name# CreateSession
2025-10-26T19:26:31.522284Z :GRPC_SERVER DEBUG: [0x61a0001a7680] created request Name# CreateSession
2025-10-26T19:26:31.522505Z :GRPC_SERVER DEBUG: [0x61a0001a7c80] created request Name# CreateSession
2025-10-26T19:26:31.522717Z :GRPC_SERVER DEBUG: [0x61a0001a8280] created request Name# CreateSession
2025-10-26T19:26:31.522919Z :GRPC_SERVER DEBUG: [0x61a0001a8880] created request Name# CreateSession
2025-10-26T19:26:31.523118Z :GRPC_SERVER DEBUG: [0x61a0001a8e80] created request Name# CreateSession
2025-10-26T19:26:31.523342Z :GRPC_SERVER DEBUG: [0x61a0001a9480] created request Name# CreateSession
2025-10-26T19:26:31.523775Z :GRPC_SERVER DEBUG: [0x61a0001a9a80] created request Name# DeleteSession
2025-10-26T19:26:31.524046Z :GRPC_SERVER DEBUG: [0x61a0001aa080] created request Name# DeleteSession
2025-10-26T19:26:31.524276Z :GRPC_SERVER DEBUG: [0x61a0001aa680] created request Name# DeleteSession
2025-10-26T19:26:31.524503Z :GRPC_SERVER DEBUG: [0x61a0001aac80] created request Name# DeleteSession
2025-10-26T19:26:31.525089Z :GRPC_SERVER DEBUG: [0x61a0001ab280] created request Name# DeleteSession
2025-10-26T19:26:31.525387Z :GRPC_SERVER DEBUG: [0x61a0001ab880] created request Name# DeleteSession
2025-10-26T19:26:31.525659Z :GRPC_SERVER DEBUG: [0x61a0001abe80] created request Name# DeleteSession
2025-10-26T19:26:31.525928Z :FLAT_TX_SCHEMESHARD TRACE: Send TEvConfigNotificationResponse: SubscriptionId: 0 ConfigId { }
2025-10-26T19:26:31.525986Z :GRPC_SERVER DEBUG: [0x61a0001ac480] created request Name# DeleteSession
2025-10-26T19:26:31.526251Z :GRPC_SERVER DEBUG: [0x61a0001aca80] created request Name# DeleteSession
2025-10-26T19:26:31.526472Z :FLAT_TX_SCHEMESHARD DEBUG: TTxUpgradeSchema.Execute
2025-10-26T19:26:31.527043Z :FLAT_TX_SCHEMESHARD NOTICE: UpgradeInitState as Uninitialized, schemeshardId: 72075186224037889
2025-10-26T19:26:31.527158Z :GRPC_SERVER DEBUG: [0x61a0001ad080] created request Name# DeleteSession
2025-10-26T19:26:31.527429Z :GRPC_SERVER DEBUG: [0x61a0001ad680] created request Name# DeleteSession
2025-10-26T19:26:31.527920Z :GRPC_SERVER DEBUG: [0x61a0001adc80] created request Name# DeleteSession
2025-10-26T19:26:31.528263Z :GRPC_SERVER DEBUG: [0x61a0001ae280] created request Name# DeleteSession
2025-10-26T19:26:31.529750Z :GRPC_SERVER DEBUG: [0x61a0001ae880] created request Name# DeleteSession
2025-10-26T19:26:31.530046Z :GRPC_SERVER DEBUG: [0x61a0001aee80] created request Name# DeleteSession
2025-10-26T19:26:31.530286Z :GRPC_SERVER DEBUG: [0x61a0001af480] created request Name# DeleteSession
2025-10-26T19:26:31.530798Z :GRPC_SERVER DEBUG: [0x61a0001bfc80] created request Name# DeleteSession
2025-10-26T19:26:31.532872Z :GRPC_SERVER DEBUG: [0x61a0001c0280] created request Name# DeleteSession
2025-10-26T19:26:31.533012Z :FLAT_TX_SCHEMESHARD DEBUG: TTxUpgradeSchema.Complete
2025-10-26T19:26:31.533745Z :FLAT_TX_SCHEMESHARD INFO: Clear TempDirsState with owners number: 0
2025-10-26T19:26:31.534656Z :GRPC_SERVER DEBUG: [0x61a0001c0880] created request Name# DeleteSession
2025-10-26T19:26:31.535375Z :GRPC_SERVER DEBUG: [0x61a0001c0e80] created request Name# DeleteSession
2025-10-26T19:26:31.535473Z :FLAT_TX_SCHEMESHARD NOTICE: TTxInit, SS hasn't been configured yet, state: 1, at schemeshard: 72075186224037889
2025-10-26T19:26:31.535568Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:31.535856Z :GRPC_SERVER DEBUG: [0x61a0001c1480] created streaming request Name# AttachSession
2025-10-26T19:26:31.536152Z :GRPC_SERVER DEBUG: [0x61a0001c1a80] created streaming request Name# AttachSession
2025-10-26T19:26:31.536454Z :GRPC_SERVER DEBUG: [0x61a0001c2080] created streaming request Name# AttachSession
2025-10-26T19:26:31.536663Z :GRPC_SERVER DEBUG: [0x61a0001c2680] created streaming request Name# AttachSession
2025-10-26T19:26:31.536831Z :GRPC_SERVER DEBUG: [0x61a0001c2c80] created streaming request Name# AttachSession
2025-10-26T19:26:31.542412Z :GRPC_SERVER DEBUG: [0x61a0001c3280] created streaming request Name# AttachSession
2025-10-26T19:26:31.544445Z :GRPC_SERVER DEBUG: [0x61a0001c3880] created streaming request Name# AttachSession
2025-10-26T19:26:31.545009Z :GRPC_SERVER DEBUG: [0x61a0001c3e80] created streaming request Name# AttachSession
2025-10-26T19:26:31.545328Z :GRPC_SERVER DEBUG: [0x61a0001c4480] created streaming request Name# AttachSession
2025-10-26T19:26:31.545660Z :GRPC_SERVER DEBUG: [0x61a0001c4a80] created streaming request Name# AttachSession
2025-10-26T19:26:31.545951Z :GRPC_SERVER DEBUG: [0x61a0001c5080] created streaming request Name# AttachSession
2025-10-26T19:26:31.546458Z :GRPC_SERVER DEBUG: [0x61a0001c5680] created streaming request Name# AttachSession
2025-10-26T19:26:31.546759Z :GRPC_SERVER DEBUG: [0x61a0001c5c80] created streaming request Name# AttachSession
2025-10-26T19:26:31.546974Z :GRPC_SERVER DEBUG: [0x61a0001c6280] created streaming request Name# AttachSession
2025-10-26T19:26:31.547182Z :GRPC_SERVER DEBUG: [0x61a0001c6880] created streaming request Name# AttachSession
2025-10-26T19:26:31.548434Z :GRPC_SERVER DEBUG: [0x61a0001c6e80] created streaming request Name# AttachSession
2025-10-26T19:26:31.548704Z :GRPC_SERVER DEBUG: [0x61a0001c7480] created streaming request Name# AttachSession
2025-10-26T19:26:31.548898Z :GRPC_SERVER DEBUG: [0x61a0001c7a80] created streaming request Name# AttachSession
2025-10-26T19:26:31.549799Z :GRPC_SERVER DEBUG: [0x61a0001c8080] created streaming request Name# AttachSession
2025-10-26T19:26:31.554789Z :GRPC_SERVER DEBUG: [0x61a0001c8680] created streaming request Name# AttachSession
2025-10-26T19:26:31.555298Z :GRPC_SERVER DEBUG: [0x61a0001c8c80] created request Name# BeginTransaction
2025-10-26T19:26:31.555533Z :GRPC_SERVER DEBUG: [0x61a0001c9280] created request Name# BeginTransaction
2025-10-26T19:26:31.555817Z :GRPC_SERVER DEBUG: [0x61a0001c9880] created request Name# BeginTransaction
2025-10-26T19:26:31.556112Z :GRPC_SERVER DEBUG: [0x61a0001c9e80] created request Name# BeginTransaction
2025-10-26T19:26:31.556325Z :GRPC_SERVER DEBUG: [0x61a0001ca480] created request Name# BeginTransaction
2025-10-26T19:26:31.556654Z :GRPC_SERVER DEBUG: [0x61a0001caa80] created request Name# BeginTransaction
2025-10-26T19:26:31.556942Z :GRPC_SERVER DEBUG: [0x61a0001cb080] created request Name# BeginTransaction
2025-10-26T19:26:31.557177Z :GRPC_SERVER DEBUG: [0x61a0001cb680] created request Name# BeginTransaction
2025-10-26T19:26:31.558001Z :GRPC_SERVER DEBUG: [0x61a0001cbc80] created request Name# BeginTransaction
2025-10-26T19:26:31.558317Z :GRPC_SERVER DEBUG: [0x61a0001cc280] created request Name# BeginTransaction
2025-10-26T19:26:31.558578Z :GRPC_SERVER DEBUG: [0x61a0001cc880] created request Name# BeginTransaction
2025-10-26T19:26:31.558865Z :GRPC_SERVER DEBUG: [0x61a0001cce80] created request Name# BeginTransaction
2025-10-26T19:26:31.559216Z :GRPC_SERVER DEBUG: [0x61a0001cd480] created request Name# BeginTransaction
2025-10-26T19:26:31.559512Z :GRPC_SERVER DEBUG: [0x61a0001cda80] created request Name# BeginTransaction
2025-10-26T19:26:31.559783Z :GRPC_SERVER DEBUG: [0x61a0001ce080] created request Name# BeginTransaction
2025-10-26T19:26:31.560060Z :GRPC_SERVER DEBUG: [0x61a0001ce680] created request Name# BeginTransaction
2025-10-26T19:26:31.560321Z :GRPC_SERVER DEBUG: [0x61a0001cec80] created request Name# BeginTransaction
2025-10-26T19:26:31.560542Z :GRPC_SERVER DEBUG: [0x61a0001cf280] created request Name# BeginTransaction
2025-10-26T19:26:31.560833Z :GRPC_SERVER DEBUG: [0x61a0001cfe80] created request Name# BeginTransaction
2025-10-26T19:26:31.561076Z :GRPC_SERVER DEBUG: [0x61a0001d0480] created request Name# BeginTransaction
2025-10-26T19:26:31.561621Z :GRPC_SERVER DEBUG: [0x61a0001d0a80] created request Name# CommitTransaction
2025-10-26T19:26:31.562082Z :GRPC_SERVER DEBUG: [0x61a0001d1080] created request Name# CommitTransaction
2025-10-26T19:26:31.562403Z :GRPC_SERVER DEBUG: [0x61a0001d1680] created request Name# CommitTransaction
2025-10-26T19:26:31.562658Z :GRPC_SERVER DEBUG: [0x61a0001d1c80] created request Name# CommitTransaction
2025-10-26T19:26:31.562917Z :GRPC_SERVER DEBUG: [0x61a0001d2280] created request Name# CommitTransaction
2025-10-26T19:26:31.563192Z :GRPC_SERVER DEBUG: [0x61a0001d2880] created request Name# CommitTransaction
2025-10-26T19:26:31.563899Z :GRPC_SERVER DEBUG: [0x61a0001d2e80] created request Name# CommitTransaction
2025-10-26T19:26:31.564184Z :GRPC_SERVER DEBUG: [0x61a0001d3480] created request Name# CommitTransaction
2025-10-26T19:26:31.564503Z :GRPC_SERVER DEBUG: [0x61a0001d3a80] created request Name# CommitTransaction
2025-10-26T19:26:31.564773Z :GRPC_SERVER DEBUG: [0x61a0001d4080] created request Name# CommitTransaction
2025-10-26T19:26:31.565058Z :GRPC_SERVER DEBUG: [0x61a0001d4680] created request Name# CommitTransaction
2025-10-26T19:26:31.565784Z :GRPC_SERVER DEBUG: [0x61a0001d4c80] created request Name# CommitTransaction
2025-10-26T19:26:31.566060Z :GRPC_SERVER DEBUG: [0x61a0001d5280] created request Name# CommitTransaction
2025-10-26T19:26:31.566339Z :GRPC_SERVER DEBUG: [0x61a0001d5880] created request Name# CommitTransaction
2025-10-26T19:26:31.567691Z :GRPC_SERVER DEBUG: [0x61a0001d5e80] created request Name# CommitTransaction
2025-10-26T19:26:31.574272Z :GRPC_SERVER DEBUG: [0x61a0001d6480] created request Name# CommitTransaction
2025-10-26T19:26:31.574585Z :GRPC_SERVER DEBUG: [0x61a0001d6a80] created request Name# CommitTransaction
2025-10-26T19:26:31.574930Z :GRPC_SERVER DEBUG: [0x61a0001d7080] created request Name# CommitTransaction
2025-10-26T19:26:31.575152Z :GRPC_SERVER DEBUG: [0x61a0001d7680] created request Name# CommitTransaction
2025-10-26T19:26:31.575440Z :GRPC_SERVER DEBUG: [0x61a0001d7c80] created request Name# CommitTransaction
2025-10-26T19:26:31.575809Z :GRPC_SERVER DEBUG: [0x61a0001d8280] created request Name# RollbackTransaction
2025-10-26T19:26:31.576041Z :GRPC_SERVER DEBUG: [0x61a0001d8880] created request Name# RollbackTransaction
2025-10-26T19:26:31.576262Z :GRPC_SERVER DEBUG: [0x61a0001d8e80] created request Name# RollbackTransaction
2025-10-26T19:26:31.576543Z :GRPC_SERVER DEBUG: [0x61a0001d9480] created request Name# RollbackTransaction
2025-10-26T19:26:31.576757Z :GRPC_SERVER DEBUG: [0x61a0001d9a80] created request Name# RollbackTransaction
2025-10-26T19:26:31.577007Z :GRPC_SERVER DEBUG: [0x61a0001da080] created request Name# RollbackTransaction
2025-10-26T19:26:31.577222Z :GRPC_SERVER DEBUG: [0x61a0001da680] created request Name# RollbackTransaction
2025-10-26T19:26:31.577456Z :GRPC_SERVER DEBUG: [0x61a0001dac80] created request Name# RollbackTransaction
2025-10-26T19:26:31.577657Z :GRPC_SERVER DEBUG: [0x61a0001db280] created request Name# RollbackTransaction
2025-10-26T19:26:31.578638Z :GRPC_SERVER DEBUG: [0x61a0001db880] created request Name# RollbackTransaction
2025-10-26T19:26:31.578899Z :GRPC_SERVER DEBUG: [0x61a0001dbe80] created request Name# RollbackTransaction
2025-10-26T19:26:31.579117Z :GRPC_SERVER DEBUG: [0x61a0001dc480] created request Name# RollbackTransaction
2025-10-26T19:26:31.579397Z :GRPC_SERVER DEBUG: [0x61a0001dca80] created request Name# RollbackTransaction
2025-10-26T19:26:31.579583Z :GRPC_SERVER DEBUG: [0x61a0001dd080] created request Name# RollbackTransaction
2025-10-26T19:26:31.580131Z :GRPC_SERVER DEBUG: [0x61a0001dd680] created request Name# RollbackTransaction
2025-10-26T19:26:31.580774Z :GRPC_SERVER DEBUG: [0x61a0001ddc80] created request Name# RollbackTransaction
2025-10-26T19:26:31.581015Z :GRPC_SERVER DEBUG: [0x61a0001de280] created request Name# RollbackTransaction
2025-10-26T19:26:31.581272Z :GRPC_SERVER DEBUG: [0x61a0001de880] created request Name# RollbackTransaction
2025-10-26T19:26:31.581533Z :GRPC_SERVER DEBUG: [0x61a0001dee80] created request Name# RollbackTransaction
2025-10-26T19:26:31.581748Z :GRPC_SERVER DEBUG: [0x61a0001df480] created request Name# RollbackTransaction
2025-10-26T19:26:31.582190Z :GRPC_SERVER DEBUG: [0x61a0001e0080] created request Name# KeyValue/CreateVolume
2025-10-26T19:26:31.582980Z :GRPC_SERVER DEBUG: [0x61a0001e0680] created request Name# KeyValue/DropVolume
2025-10-26T19:26:31.583443Z :GRPC_SERVER DEBUG: [0x61a0001e0c80] created request Name# KeyValue/AlterVolume
2025-10-26T19:26:31.583955Z :GRPC_SERVER DEBUG: [0x61a0001e1280] created request Name# KeyValue/DescribeVolume
2025-10-26T19:26:31.584341Z :GRPC_SERVER DEBUG: [0x61a0001e1880] created request Name# KeyValue/ListLocalPartitions
2025-10-26T19:26:31.584747Z :GRPC_SERVER DEBUG: [0x61a0001e1e80] created request Name# KeyValue/AcquireLock
2025-10-26T19:26:31.585173Z :GRPC_SERVER DEBUG: [0x61a0001e2480] created request Name# KeyValue/ExecuteTransaction
2025-10-26T19:26:31.585628Z :GRPC_SERVER DEBUG: [0x61a0001e2a80] created request Name# KeyValue/Read
2025-10-26T19:26:31.586069Z :GRPC_SERVER DEBUG: [0x61a0001e3080] created request Name# KeyValue/ReadRange
2025-10-26T19:26:31.586523Z :GRPC_SERVER DEBUG: [0x61a0001e3680] created request Name# KeyValue/ListRange
2025-10-26T19:26:31.586923Z :GRPC_SERVER DEBUG: [0x61a0001e3c80] created request Name# KeyValue/GetStorageChannelStatus
2025-10-26T19:26:31.607033Z :GRAPH WARN: SVC Error resolving database /Root/test_auditlog.py error RedirectLookupError
2025-10-26T19:26:32.607998Z :GRAPH WARN: SVC Error resolving database /Root/test_auditlog.py error RedirectLookupError
2025-10-26T19:26:32.896033Z :TX_MEDIATOR NOTICE: tablet# 72075186224037894 actor# [50000:7565614059378310354:8193] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T19:26:32.949056Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE TEvConfigure Version# 2
2025-10-26T19:26:32.966148Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T19:26:33.082090Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE TEvConfigure Version# 2
2025-10-26T19:26:33.092094Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 269877761, Sender [50000:7565614067968245221:118], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:33.092163Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:33.092200Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T19:26:33.092282Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 271124999, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:33.092314Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:33.094984Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, received event# 271125001, Sender [1:7565614032432693463:90], Recipient [50000:7565614067968245221:118]
2025-10-26T19:26:33.095035Z :FLAT_TX_SCHEMESHARD TRACE: StateConfigure, processing event TEvSchemeShard::TEvInitTenantSchemeShard
2025-10-26T19:26:33.095708Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T19:26:33.125945Z :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-26T19:26:33.127167Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 0
2025-10-26T19:26:33.127340Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 1
2025-10-26T19:26:33.127370Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 2
2025-10-26T19:26:33.127550Z :TX_MEDIATOR NOTICE: tablet# 72075186224037893 actor# [50000:7565614059378310356:8195] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T19:26:33.127998Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 3
2025-10-26T19:26:33.128082Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 4
2025-10-26T19:26:33.128135Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 5
2025-10-26T19:26:33.128161Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 6
2025-10-26T19:26:33.128213Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 7
2025-10-26T19:26:33.128250Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 8
2025-10-26T19:26:33.128315Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 9
2025-10-26T19:26:33.135099Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T19:26:33.135159Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T19:26:33.136010Z :FLAT_TX_SCHEMESHARD NOTICE: TEvInitTenantSchemeShard DoComplete, status: StatusSuccess, at schemeshard: 72075186224037889
2025-10-26T19:26:33.136205Z :FLAT_TX_SCHEMESHARD DEBUG: Send TEvSyncTenantSchemeShard, to parent: [OwnerId: 72075186232723360, LocalPathId: 2], from: 72075186224037889
2025-10-26T19:26:33.137578Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435079, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvServerlessStorageBilling
2025-10-26T19:26:33.137628Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvServerlessStorageBilling
2025-10-26T19:26:33.137770Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T19:26:33.137835Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 0, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T19:26:33.137979Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T19:26:33.138008Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 0, path id: 1
2025-10-26T19:26:33.138068Z :FLAT_TX_SCHEMESHARD DEBUG: TTxServerlessStorageBilling.Execute
2025-10-26T19:26:33.138093Z :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-26T19:26:33.138115Z :FLAT_TX_SCHEMESHARD DEBUG: TTxServerlessStorageBilling.Complete
2025-10-26T19:26:33.138161Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:33.138298Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274399233, Sender [50000:7565614059378310542:91], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTxAllocatorClient::TEvAllocateResult
2025-10-26T19:26:33.138324Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxAllocatorClient::TEvAllocateResult
2025-10-26T19:26:33.138356Z :FLAT_TX_SCHEMESHARD INFO: Handle: TEvAllocateResult: Cookie# 0, at schemeshard: 72075186224037889
2025-10-26T19:26:33.139220Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 0, is deletion# false, version: 4
2025-10-26T19:26:33.140902Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245251:67] Successful handshake: replica# [1:7565614028137725593:4110]
2025-10-26T19:26:33.140927Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245251:67] Start full sync: replica# [1:7565614028137725593:4110]
2025-10-26T19:26:33.141228Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565614067968245247:4197], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:33.141256Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:33.142264Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186232723360, status: OK, at schemeshard: 72075186224037889
2025-10-26T19:26:33.142440Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565614067968245248:4198], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:33.142462Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:33.142478Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037897, status: OK, at schemeshard: 72075186224037889
2025-10-26T19:26:33.143809Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565614055083342905:25], 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-26T19:26:33.144762Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565614055083342890: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-26T19:26:33.145724Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565614055083342783: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-26T19:26:33.147901Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Path was updated as a replacement from TSS, GSS->TSS: owner# [50000:7565614055083342782: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-26T19:26:33.147945Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:33.148015Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 0, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 4
2025-10-26T19:26:33.148038Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:33.148067Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:33.148151Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:33.149922Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 4 }
2025-10-26T19:26:33.149976Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:33.150067Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 4 PathOwnerId: 72075186224037889, cookie: 0
2025-10-26T19:26:33.150227Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614067968245256:4200][[OwnerId: 72075186232723360, LocalPathId: 2]] Set up state: owner# [50000:7565614055083342890: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-26T19:26:33.279428Z :TX_MEDIATOR NOTICE: tablet# 72075186224037895 actor# [50000:7565614059378310355:8194] HANDLE TEvMediatorConfiguration Version# 2
2025-10-26T19:26:33.284525Z :TX_COORDINATOR NOTICE: tablet# 72075186224037891 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T19:26:33.284558Z :TX_COORDINATOR NOTICE: tablet# 72075186224037890 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T19:26:33.313603Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE TEvConfigure Version# 2
2025-10-26T19:26:33.320452Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037893
2025-10-26T19:26:33.322878Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037895
2025-10-26T19:26:33.323220Z :TX_COORDINATOR NOTICE: tablet# 72075186224037892 HANDLE EvMediatorQueueRestart MediatorId# 72075186224037894
2025-10-26T19:26:33.334726Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614067968245256:4200][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:34.092708Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:34.092747Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:34.092801Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:34.092825Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:35.093759Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:35.093821Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:35.093913Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:35.093932Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:35.287969Z :KQP_PROXY DEBUG: Updated YQL logs priority: 3
2025-10-26T19:26:35.288549Z :KQP_PROXY INFO: Cannot start publishing usage, tenants: /Root/test_auditlog.py, empty
2025-10-26T19:26:35.295734Z :KQP_PROXY DEBUG: Created new session, sessionId: ydb://session/3?node_id=50000&id=M2YwNTNjYzMtYTdlYmM1ZDAtYWQ4ZDZmMzQtZmMwMThkNGU=, workerId: [50000:7565614076558179905:4212], database: , longSession: 0, local sessions count: 1
2025-10-26T19:26:35.295799Z :KQP_PROXY INFO: Cannot start publishing usage, tenants: /Root/test_auditlog.py, empty
2025-10-26T19:26:35.295993Z :KQP_PROXY DEBUG: Ctx: { TraceId: , Database: , DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=M2YwNTNjYzMtYTdlYmM1ZDAtYWQ4ZDZmMzQtZmMwMThkNGU=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 2, targetId: [50000:7565614076558179905:4212]
2025-10-26T19:26:35.296051Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 2 timeout: 300.000000s actor id: [50000:7565614076558179906:137]
2025-10-26T19:26:35.296203Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3466807061
2025-10-26T19:26:35.296282Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3466807061
2025-10-26T19:26:35.296346Z :KQP_PROXY DEBUG: Subscribed for config changes.
2025-10-26T19:26:35.296386Z :KQP_PROXY DEBUG: Updated table service config.
2025-10-26T19:26:35.296416Z :KQP_PROXY DEBUG: Updated YQL logs priority: 3
2025-10-26T19:26:35.296490Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3466807061
2025-10-26T19:26:35.296530Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3466807061
2025-10-26T19:26:35.465182Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: 
2025-10-26T19:26:35.484926Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [50000:7565614076558179907:4181], 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-26T19:26:35.487124Z :KQP_PROXY DEBUG: Forwarded response to sender actor, requestId: 2, sender: [50000:7565614055083342775:4101], selfId: [50000:7565614055083342805:4115], source: [50000:7565614076558179905:4212]
2025-10-26T19:26:35.487193Z :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=50000&id=M2YwNTNjYzMtYTdlYmM1ZDAtYWQ4ZDZmMzQtZmMwMThkNGU=, workerId: [50000:7565614076558179905:4212], local sessions count: 0
2025-10-26T19:26:35.511109Z :GRPC_SERVER DEBUG: [0x61a0000a2080] received request Name# CreateSession ok# true data# operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } }  peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:35.511209Z :GRPC_SERVER DEBUG: [0x61a000032480] created request Name# CreateSession
2025-10-26T19:26:35.511592Z :GRPC_SERVER DEBUG: [0x61a0000a2080] received request without user token Name# CreateSession data# operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } }  peer# ipv4:127.0.0.1:46616 database# /Root/test_auditlog.py
2025-10-26T19:26:35.512142Z :GRPC_SERVER DEBUG: Got grpc request# CreateSessionRequest, traceId# 01k8gzs7zq76sjx7rtf14yf3ax, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:46616, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 2.985569s
2025-10-26T19:26:35.512439Z :KQP_PROXY DEBUG: TraceId: "01k8gzs7zq76sjx7rtf14yf3ax", Request has 2.985265s seconds to be completed
2025-10-26T19:26:35.514504Z :KQP_PROXY DEBUG: TraceId: "01k8gzs7zq76sjx7rtf14yf3ax", Created new session, sessionId: ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=, workerId: [50000:7565614076558179913:4145], database: /Root/test_auditlog.py, longSession: 1, local sessions count: 1
2025-10-26T19:26:35.514603Z :KQP_PROXY DEBUG: Received create session request, trace_id: 01k8gzs7zq76sjx7rtf14yf3ax
2025-10-26T19:26:35.514807Z :GRPC_SERVER DEBUG: [0x61a0000a2080] 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=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=" } }  peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:35.515330Z :GRPC_SERVER DEBUG: [0x61a0000a2080] finished request Name# CreateSession ok# true peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:35.526374Z :GRPC_SERVER DEBUG: [0x61a0000ee280] received request Name# ExecuteSchemeQuery ok# true data# session_id: "ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=" 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:46616
2025-10-26T19:26:35.526469Z :GRPC_SERVER DEBUG: [0x61a000031e80] created request Name# ExecuteSchemeQuery
2025-10-26T19:26:35.526806Z :GRPC_SERVER DEBUG: [0x61a0000ee280] received request without user token Name# ExecuteSchemeQuery data# session_id: "ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=" 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:46616 database# /Root/test_auditlog.py
2025-10-26T19:26:35.527105Z :GRPC_SERVER DEBUG: Got grpc request# ExecuteSchemeQueryRequest, traceId# 01k8gzs806245hh49z68hf8q3t, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:46616, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.997624s
2025-10-26T19:26:35.527443Z :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gzs806245hh49z68hf8q3t, Database: /Root/test_auditlog.py, DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 600.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 4, targetId: [50000:7565614076558179913:4145]
2025-10-26T19:26:35.527485Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 4 timeout: 600.000000s actor id: [50000:7565614076558179916:146]
2025-10-26T19:26:35.540424Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: /Root/test_auditlog.py/test-table
2025-10-26T19:26:35.542059Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179919:4144][/Root/test_auditlog.py/test-table] Set up state: owner# [50000:7565614055083342890:4125], state# { Deleted: 1 Strong: 1 Version: <Invalid> DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:26:35.553757Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179926:4158][/Root] Set up state: owner# [50000:7565614055083342890: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-26T19:26:35.556885Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565614076558179933:128], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.556939Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.556958Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T19:26:35.557035Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271122432, Sender [50000:7565614076558179925:4157], Recipient [50000:7565614059378310487:91]: {TEvModifySchemeTransaction txid# 281474976720657 TabletId# 72075186224037889}
2025-10-26T19:26:35.557067Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvModifySchemeTransaction
2025-10-26T19:26:35.563657Z :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-26T19:26:35.564181Z :FLAT_TX_SCHEMESHARD NOTICE: TCreateTable Propose, path: /Root/test_auditlog.py/test-table, opId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.564373Z :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-26T19:26:35.564995Z :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-26T19:26:35.565050Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason transaction target path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 0
2025-10-26T19:26:35.565086Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new shard created for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 1
2025-10-26T19:26:35.565243Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason new path created for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 2
2025-10-26T19:26:35.565273Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 1 -> 2
2025-10-26T19:26:35.566471Z :FLAT_TX_SCHEMESHARD NOTICE: IgniteOperation, opId: 281474976720657:0, propose status:StatusAccepted, reason: , at schemeshard: 72075186224037889
2025-10-26T19:26:35.566533Z :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-26T19:26:35.566630Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.566706Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 11
2025-10-26T19:26:35.566796Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T19:26:35.570644Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPropose Complete, txId: 281474976720657, response: Status: StatusAccepted TxId: 281474976720657 SchemeshardId: 72075186224037889 PathId: 2, at schemeshard: 72075186224037889
2025-10-26T19:26:35.570994Z :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-26T19:26:35.571033Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.571074Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T19:26:35.571366Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.571392Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.571438Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T19:26:35.571455Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T19:26:35.571609Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 2]
2025-10-26T19:26:35.571698Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T19:26:35.571720Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 1
2025-10-26T19:26:35.571745Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 2
2025-10-26T19:26:35.571797Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.571832Z :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976720657:0 ProgressState, operation type: TxCreateTable, at tablet72075186224037889
2025-10-26T19:26:35.572117Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 281474976720657, is deletion# false, version: 5
2025-10-26T19:26:35.572207Z :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-26T19:26:35.572231Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], cookie# 281474976720657, is deletion# false, version: 1
2025-10-26T19:26:35.572256Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.572309Z :KQP_GATEWAY DEBUG: Received TEvProposeTransactionStatus for scheme request, TxId: 281474976720657, status: ExecInProgress, scheme shard status: 1
2025-10-26T19:26:35.572347Z :KQP_GATEWAY DEBUG: Sent TEvNotifyTxCompletion request, TxId: 281474976720657
2025-10-26T19:26:35.572582Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565614076558179933:128], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.572619Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.572637Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T19:26:35.573624Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565614076558179939:125], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.573666Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.573701Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T19:26:35.574005Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342905:25], 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-26T19:26:35.574027Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:35.574173Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342782: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-26T19:26:35.574294Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342783: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-26T19:26:35.574423Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124996, Sender [50000:7565614076558179924:4156], Recipient [50000:7565614059378310487:91]: NKikimrScheme.TEvNotifyTxCompletion TxId: 281474976720657
2025-10-26T19:26:35.574451Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvNotifyTxCompletion
2025-10-26T19:26:35.574497Z :FLAT_TX_SCHEMESHARD DEBUG: NotifyTxCompletion operation in-flight, txId: 281474976720657, at schemeshard: 72075186224037889
2025-10-26T19:26:35.574524Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: false
2025-10-26T19:26:35.574562Z :FLAT_TX_SCHEMESHARD INFO: NotifyTxCompletion transaction is registered, txId: 281474976720657, at schemeshard: 72075186224037889
2025-10-26T19:26:35.574843Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179919:4144][/Root/test_auditlog.py/test-table] Update to non-empty state: owner# [50000:7565614055083342890: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-26T19:26:35.575169Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:35.575299Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:35.575318Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:35.575395Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:35.575427Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 5
2025-10-26T19:26:35.575448Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], version# 1
2025-10-26T19:26:35.575502Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 5 }
2025-10-26T19:26:35.575517Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:35.575570Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 5 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.575655Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 5 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.575675Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T19:26:35.575693Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 1], version: 5
2025-10-26T19:26:35.575712Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 12
2025-10-26T19:26:35.575822Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.576045Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 2] Version: 1 }
2025-10-26T19:26:35.576061Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:35.576135Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 1 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.576213Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 1 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.576223Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T19:26:35.576236Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 2], version: 1
2025-10-26T19:26:35.576248Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 4
2025-10-26T19:26:35.576307Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: true
2025-10-26T19:26:35.576317Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.577419Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.577485Z :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-26T19:26:35.577659Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 0, tablet: 72075186224037888
2025-10-26T19:26:35.577677Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByShardIdx, TxId: 281474976720657, shardIdx: 72075186224037889:11, partId: 0
2025-10-26T19:26:35.578066Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565614076558179943:4160], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.578093Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.578123Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037888, status: OK, at schemeshard: 72075186224037889
2025-10-26T19:26:35.580201Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.580229Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.580310Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.580320Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.591184Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698113, Sender [50000:7565614059378310360:4128], Recipient [50000:7565614059378310487:91]: {EvCreateTabletReply Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888}
2025-10-26T19:26:35.591222Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvHive::TEvCreateTabletReply
2025-10-26T19:26:35.591322Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvCreateTabletReply at schemeshard: 72075186224037889 message: Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888
2025-10-26T19:26:35.591352Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByShardIdx, TxId: 281474976720657, shardIdx: 72075186224037889:11, partId: 0
2025-10-26T19:26:35.591502Z :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-26T19:26:35.591547Z :FLAT_TX_SCHEMESHARD INFO: TCreateParts opId# 281474976720657:0 HandleReply TEvCreateTabletReply, at tabletId: 72075186224037889
2025-10-26T19:26:35.591601Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateParts opId# 281474976720657:0 HandleReply TEvCreateTabletReply, message: Status: OK Owner: 72075186224037889 OwnerIdx: 11 TabletID: 72075186224037898 Origin: 72075186224037888
2025-10-26T19:26:35.591694Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 2 -> 3
2025-10-26T19:26:35.591795Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.591826Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037888 cookie: 72075186224037889:11
2025-10-26T19:26:35.596726Z :BS_PROXY_DISCOVER WARN: [122e4f9d33d10a51] Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD01
2025-10-26T19:26:35.596783Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvHive::TEvCreateTabletReply> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.596800Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.596819Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T19:26:35.596977Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.597014Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.597139Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.597186Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState at tabletId# 72075186224037889
2025-10-26T19:26:35.597265Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037898 seqNo: 1:1
2025-10-26T19:26:35.627460Z :BS_PROXY_DISCOVER WARN: [1c8cc14d2fe82822] Die. Result# TEvDiscoverResult {Status# NODATA BlockedGeneration# 0 Id# [0:0:0:0:0:0:0] Size# 0 MinGeneration# 0} Marker# BSD05
2025-10-26T19:26:35.641001Z :FLAT_TX_SCHEMESHARD DEBUG: TCreateTable TConfigureParts operationId#281474976720657:0 ProgressState Propose modify scheme on datashard datashardId: 72075186224037898 message: TxKind: TX_KIND_SCHEME SourceDeprecated { RawX1: 7565614059378310487 RawX2: 4718347992170587 } 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-26T19:26:35.641177Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.644807Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.644862Z :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-26T19:26:35.645002Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 0, tablet: 72075186224037898
2025-10-26T19:26:35.703522Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565614076558179980:4166], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.703562Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.703589Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037898, status: OK, at schemeshard: 72075186224037889
2025-10-26T19:26:35.706464Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179988:4164][[OwnerId: 72075186224037889, LocalPathId: 1]] Set up state: owner# [50000:7565614076558179987:4161], 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-26T19:26:35.707733Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 268698119, Sender [50000:7565614059378310360:4128], Recipient [50000:7565614059378310487:91]: {EvTabletCreationResult Status: OK TabletID: 72075186224037898}
2025-10-26T19:26:35.711761Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [50000:7565614076558179962:94], Recipient [50000:7565614059378310487:91]: NKikimrTxDataShard.TEvProposeTransactionResult TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: PREPARED TxId: 281474976720657 MinStep: 1 MaxStep: 18446744073709551615 PrepareArriveTime: 1761506795704530 ExecLatency: 0 ProposeLatency: 3 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 453 } }
2025-10-26T19:26:35.711805Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-10-26T19:26:35.711943Z :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: 1761506795704530 ExecLatency: 0 ProposeLatency: 3 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 453 } }
2025-10-26T19:26:35.711975Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T19:26:35.712187Z :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: 1761506795704530 ExecLatency: 0 ProposeLatency: 3 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 453 } }
2025-10-26T19:26:35.712230Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TConfigureParts operationId#281474976720657:0 HandleReply TEvProposeTransactionResult at tabletId# 72075186224037889
2025-10-26T19:26:35.712355Z :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: 1761506795704530 ExecLatency: 0 ProposeLatency: 3 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 453 } }
2025-10-26T19:26:35.712399Z :FLAT_TX_SCHEMESHARD INFO: TEvProposeTransactionResult at tablet: 72075186224037889
2025-10-26T19:26:35.712492Z :FLAT_TX_SCHEMESHARD DEBUG: CollectProposeTransactionResults accept TEvProposeTransactionResult, shard: 72075186224037898, shardIdx: 72075186224037889:11, operationId: 281474976720657:0, left await: 0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.712512Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 3 -> 128
2025-10-26T19:26:35.712569Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.712598Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:0 from tablet: 72075186224037889 to tablet: 72075186224037898 cookie: 72075186224037889:11
2025-10-26T19:26:35.715747Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.715775Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.715810Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T19:26:35.715963Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.716001Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.716046Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.716079Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId#281474976720657:0 HandleReply ProgressState at tablet: 72075186224037889
2025-10-26T19:26:35.716110Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.716143Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToPropose , TxId: 281474976720657 ready parts: 1/1
2025-10-26T19:26:35.720506Z :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-26T19:26:35.727510Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.727555Z :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-26T19:26:35.727711Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation RegisterRelationByTabletId, TxId: 281474976720657, partId: 4294967295, tablet: 72075186224037890
2025-10-26T19:26:35.728298Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877760, Sender [50000:7565614076558179999:4170], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.728321Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvClientConnected
2025-10-26T19:26:35.729163Z :FLAT_TX_SCHEMESHARD TRACE: Handle TEvClientConnected, tabletId: 72075186224037890, status: OK, at schemeshard: 72075186224037889
2025-10-26T19:26:35.729316Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [50000:7565614059378310358:10234], Recipient [50000:7565614059378310487:91]: NKikimrTx.TEvProposeTransactionStatus Status: 16 StepId: 1761506795010 TxId: 281474976720657
2025-10-26T19:26:35.738796Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269091328, Sender [50000:7565614059378310358:10234], Recipient [50000:7565614059378310487:91]: NKikimrTx.TEvProposeTransactionStatus Status: 17 StepId: 1761506795770 TxId: 281474976720657
2025-10-26T19:26:35.739707Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565614076558180011:168], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.739737Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.739766Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T19:26:35.739820Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269287424, Sender [50000:7565614067968245246:4138], Recipient [50000:7565614059378310487:91]: {TEvPlanStep step# 1761506795770 MediatorId# 72075186224037893 TabletID 72075186224037889}
2025-10-26T19:26:35.739848Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTxProcessing::TEvPlanStep
2025-10-26T19:26:35.739908Z :FLAT_TX_SCHEMESHARD NOTICE: TTxOperationPlanStep Execute, stepId: 1761506795770, transactions count in step: 1, at schemeshard: 72075186224037889
2025-10-26T19:26:35.740073Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationPlanStep Execute, message: Transactions { TxId: 281474976720657 AckTo { RawX1: 7565614063673277894 RawX2: 214748364800114 } } Step: 1761506795770 MediatorID: 72075186224037893 TabletID: 72075186224037889, at schemeshard: 72075186224037889
2025-10-26T19:26:35.740137Z :FLAT_TX_SCHEMESHARD INFO: TCreateTable TPropose operationId#281474976720657:0 HandleReply TEvOperationPlan at tablet: 72075186224037889, stepId: 1761506795770
2025-10-26T19:26:35.740280Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 128 -> 129
2025-10-26T19:26:35.740457Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.740519Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 11
2025-10-26T19:26:35.740571Z :FLAT_TX_SCHEMESHARD DEBUG: IncrementPathDbRefCount reason publish path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T19:26:35.740613Z :FLAT_TX_SCHEMESHARD TRACE: Ack tablet strongly msg opId: 281474976720657:4294967295 from tablet: 72075186224037889 to tablet: 0 cookie: 0:281474976720657
2025-10-26T19:26:35.747814Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.747857Z :FLAT_TX_SCHEMESHARD TRACE: Ack coordinator stepId#1761506795770 first txId#281474976720657 countTxs#1
2025-10-26T19:26:35.747890Z :FLAT_TX_SCHEMESHARD TRACE: Ack mediator stepId#1761506795770
2025-10-26T19:26:35.747927Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T19:26:35.748149Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.748178Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.748254Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T19:26:35.748272Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T19:26:35.748436Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 281474976720657, path id: [OwnerId: 72075186224037889, LocalPathId: 2]
2025-10-26T19:26:35.748727Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T19:26:35.748747Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 1
2025-10-26T19:26:35.748778Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 281474976720657, path id: 2
2025-10-26T19:26:35.748828Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.748907Z :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976720657:0 ProgressState at tablet: 72075186224037889
2025-10-26T19:26:35.748975Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.748998Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 281474976720657, is deletion# false, version: 6
2025-10-26T19:26:35.749142Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], cookie# 281474976720657, is deletion# false, version: 3
2025-10-26T19:26:35.751405Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:35.751492Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342782: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-26T19:26:35.751629Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179988:4164][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565614076558179987:4161], 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-26T19:26:35.751662Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:35.751722Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342905:25], 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-26T19:26:35.751810Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342783: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-26T19:26:35.751839Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:35.751965Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:35.752002Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179919:4144][/Root/test_auditlog.py/test-table] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:35.752066Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:35.752096Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 6
2025-10-26T19:26:35.752118Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 281474976720657, pathId# [OwnerId: 72075186224037889, LocalPathId: 2], version# 3
2025-10-26T19:26:35.752295Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 6 }
2025-10-26T19:26:35.752333Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:35.752411Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 6 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.752474Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 6 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.752485Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T19:26:35.752504Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 1], version: 6
2025-10-26T19:26:35.752522Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 1] was 12
2025-10-26T19:26:35.752598Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.752802Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 2] Version: 3 }
2025-10-26T19:26:35.752847Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:35.753186Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 3 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.753277Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Execute, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 2 Version: 3 PathOwnerId: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.753307Z :FLAT_TX_SCHEMESHARD INFO: Operation in-flight, at schemeshard: 72075186224037889, txId: 281474976720657
2025-10-26T19:26:35.753336Z :FLAT_TX_SCHEMESHARD INFO: AckPublish, at schemeshard: 72075186224037889, txId: 281474976720657, pathId: [OwnerId: 72075186224037889, LocalPathId: 2], version: 3
2025-10-26T19:26:35.753353Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove publishing for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 4
2025-10-26T19:26:35.753424Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 0/1, is published: true
2025-10-26T19:26:35.753438Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.754496Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.754813Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269550080, Sender [50000:7565614076558179962:94], Recipient [50000:7565614059378310487:91]: NKikimrTxDataShard.TEvProposeTransactionResult TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761506795770 OrderId: 281474976720657 ExecLatency: 1 ProposeLatency: 13 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1886 } }
2025-10-26T19:26:35.754864Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvProposeTransactionResult
2025-10-26T19:26:35.754958Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvProposeTransactionResult, at schemeshard: 72075186224037889, message: TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761506795770 OrderId: 281474976720657 ExecLatency: 1 ProposeLatency: 13 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1886 } }
2025-10-26T19:26:35.754987Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T19:26:35.755140Z :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: 1761506795770 OrderId: 281474976720657 ExecLatency: 1 ProposeLatency: 13 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1886 } }
2025-10-26T19:26:35.755259Z :FLAT_TX_SCHEMESHARD INFO: Unexpected message: tablet# 72075186224037889, ev# TxKind: TX_KIND_SCHEME Origin: 72075186224037898 Status: COMPLETE TxId: 281474976720657 Step: 1761506795770 OrderId: 281474976720657 ExecLatency: 1 ProposeLatency: 13 DomainCoordinators: 72075186224037890 DomainCoordinators: 72075186224037891 DomainCoordinators: 72075186224037892 TxStats { PerShardStats { ShardId: 72075186224037898 CpuTimeUsec: 1886 } }
2025-10-26T19:26:35.755325Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.755623Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877761, Sender [50000:7565614076558180044:196], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.755670Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerConnected
2025-10-26T19:26:35.755690Z :FLAT_TX_SCHEMESHARD TRACE: Pipe server connected, at tablet: 72075186224037889
2025-10-26T19:26:35.755825Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269551620, Sender [50000:7565614076558179962:94], Recipient [50000:7565614059378310487:91]: NKikimrTxDataShard.TEvSchemaChanged Source { RawX1: 7565614076558179962 RawX2: 4718347992170590 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T19:26:35.755865Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvDataShard::TEvSchemaChanged
2025-10-26T19:26:35.755935Z :FLAT_TX_SCHEMESHARD DEBUG: Handle TEvSchemaChanged, tabletId: 72075186224037889, at schemeshard: 72075186224037889, message: Source { RawX1: 7565614076558179962 RawX2: 4718347992170590 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T19:26:35.755959Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation FindRelatedPartByTabletId, TxId: 281474976720657, tablet: 72075186224037898, partId: 0
2025-10-26T19:26:35.756082Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889, message: Source { RawX1: 7565614076558179962 RawX2: 4718347992170590 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T19:26:35.756126Z :FLAT_TX_SCHEMESHARD INFO: NTableState::TProposedWaitParts operationId# 281474976720657:0 HandleReply TEvSchemaChanged at tablet: 72075186224037889
2025-10-26T19:26:35.756222Z :FLAT_TX_SCHEMESHARD DEBUG: NTableState::TProposedWaitParts operationId# 281474976720657:0 HandleReply TEvSchemaChanged at tablet: 72075186224037889 message: Source { RawX1: 7565614076558179962 RawX2: 4718347992170590 } Origin: 72075186224037898 State: 2 TxId: 281474976720657 Step: 0 Generation: 1
2025-10-26T19:26:35.756271Z :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-26T19:26:35.756297Z :FLAT_TX_SCHEMESHARD INFO: all shard schema changes has been received, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.756320Z :FLAT_TX_SCHEMESHARD DEBUG: send schema changes ack message, operation: 281474976720657:0, datashard: 72075186224037898, at schemeshard: 72075186224037889
2025-10-26T19:26:35.756348Z :FLAT_TX_SCHEMESHARD INFO: Change state for txid 281474976720657:0 129 -> 240
2025-10-26T19:26:35.756523Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.759159Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.759186Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.759261Z :FLAT_TX_SCHEMESHARD DEBUG: TTxAckPublishToSchemeBoard Complete, at schemeshard: 72075186224037889, cookie: 281474976720657
2025-10-26T19:26:35.759271Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.759348Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvProposeTransactionResult> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.759367Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.761827Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationReply<NKikimr::TEvDataShard::TEvSchemaChanged> complete, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.761853Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.761884Z :FLAT_TX_SCHEMESHARD TRACE: Activate send for 281474976720657:0
2025-10-26T19:26:35.761978Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [50000:7565614076558179962:94] msg type: 269552132 msg: NKikimrTxDataShard.TEvSchemaChangedResult TxId: 281474976720657 at schemeshard: 72075186224037889
2025-10-26T19:26:35.762166Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 2146435072, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.762200Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvPrivate::TEvProgressOperation
2025-10-26T19:26:35.762248Z :FLAT_TX_SCHEMESHARD DEBUG: TTxOperationProgress Execute, operationId: 281474976720657:0, at schemeshard: 72075186224037889
2025-10-26T19:26:35.762278Z :FLAT_TX_SCHEMESHARD INFO: [72075186224037889] TDone opId# 281474976720657:0ProgressState
2025-10-26T19:26:35.762385Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:35.762423Z :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976720657:0 progress is 1/1
2025-10-26T19:26:35.762442Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T19:26:35.762476Z :FLAT_TX_SCHEMESHARD INFO: Part operation is done id#281474976720657:0 progress is 1/1
2025-10-26T19:26:35.762503Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T19:26:35.762528Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToNotify, TxId: 281474976720657, ready parts: 1/1, is published: true
2025-10-26T19:26:35.762607Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation DoNotify send TEvNotifyTxCompletionResult to actorId: [50000:7565614076558179924:4156] message: TxId: 281474976720657
2025-10-26T19:26:35.762645Z :FLAT_TX_SCHEMESHARD DEBUG: TOperation IsReadyToDone  TxId: 281474976720657 ready parts: 1/1
2025-10-26T19:26:35.762683Z :FLAT_TX_SCHEMESHARD NOTICE: Operation and all the parts is done, operation id: 281474976720657:0
2025-10-26T19:26:35.762698Z :FLAT_TX_SCHEMESHARD DEBUG: RemoveTx for txid 281474976720657:0
2025-10-26T19:26:35.762864Z :FLAT_TX_SCHEMESHARD DEBUG: DecrementPathDbRefCount reason remove txstate target path for pathId [OwnerId: 72075186224037889, LocalPathId: 2] was 3
2025-10-26T19:26:35.768294Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:35.768409Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [50000:7565614076558179924:4156] msg type: 271124998 msg: NKikimrScheme.TEvNotifyTxCompletionResult TxId: 281474976720657 at schemeshard: 72075186224037889
2025-10-26T19:26:35.768489Z :KQP_GATEWAY DEBUG: Received TEvNotifyTxCompletionResult for scheme request, TxId: 281474976720657
2025-10-26T19:26:35.768517Z :KQP_GATEWAY DEBUG: Successful completion of scheme request, TxId: 281474976720657
2025-10-26T19:26:35.768641Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565614076558180044:196], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.768670Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.768686Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T19:26:35.768834Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 269877764, Sender [50000:7565614076558179939:125], Recipient [50000:7565614059378310487:91]: NKikimr::TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.768863Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvTabletPipe::TEvServerDisconnected
2025-10-26T19:26:35.768880Z :FLAT_TX_SCHEMESHARD TRACE: Server pipe is reset, at schemeshard: 72075186224037889
2025-10-26T19:26:35.771671Z :KQP_PROXY DEBUG: TraceId: "01k8gzs806245hh49z68hf8q3t", Forwarded response to sender actor, requestId: 4, sender: [50000:7565614076558179914:4181], selfId: [50000:7565614055083342805:4115], source: [50000:7565614076558179913:4145]
2025-10-26T19:26:35.771843Z :GRPC_SERVER DEBUG: [0x61a0000ee280] issuing response Name# ExecuteSchemeQuery data# operation { ready: true status: SUCCESS }  peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:35.772318Z :GRPC_SERVER DEBUG: [0x61a0000ee280] finished request Name# ExecuteSchemeQuery ok# true peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:35.780046Z :GRPC_SERVER DEBUG: [0x61a000123c80] received request Name# ExecuteDataQuery ok# true data# session_id: "ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=" 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:46616
2025-10-26T19:26:35.780130Z :GRPC_SERVER DEBUG: [0x61a000031880] created request Name# ExecuteDataQuery
2025-10-26T19:26:35.780536Z :GRPC_SERVER DEBUG: [0x61a000123c80] received request without user token Name# ExecuteDataQuery data# session_id: "ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=" 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:46616 database# /Root/test_auditlog.py
2025-10-26T19:26:35.780746Z :GRPC_SERVER DEBUG: Got grpc request# ExecuteDataQueryRequest, traceId# 01k8gzs8846dchexe40vgv3d3j, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:46616, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.997971s
2025-10-26T19:26:35.781089Z :KQP_PROXY DEBUG: Ctx: { TraceId: 01k8gzs8846dchexe40vgv3d3j, Database: /Root/test_auditlog.py, DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=NzNiMTQyOTYtZTRlOWY5NjMtZGRlZjgwYjgtYjJlNGJlM2Q=, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 600.000000s cancelAfter: 600.000000s. Send request to target, requestId: 5, targetId: [50000:7565614076558179913:4145]
2025-10-26T19:26:35.781123Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 5 timeout: 300.000000s actor id: [50000:7565614076558180055:150]
2025-10-26T19:26:35.793108Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: /Root/test_auditlog.py/test-table
2025-10-26T19:26:36.042855Z :KQP_PROXY DEBUG: TraceId: "01k8gzs8846dchexe40vgv3d3j", Forwarded response to sender actor, requestId: 5, sender: [50000:7565614076558180053:4155], selfId: [50000:7565614055083342805:4115], source: [50000:7565614076558179913:4145]
2025-10-26T19:26:36.043159Z :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\03201k8gzs8fm0svvge343a2newsq" } }  peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:36.043873Z :GRPC_SERVER DEBUG: [0x61a000123c80] finished request Name# ExecuteDataQuery ok# true peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:36.094078Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:36.094114Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:36.094174Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:36.094189Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:36.297304Z :KQP_PROXY DEBUG: Received node white board pool stats: 0.3388287908
2025-10-26T19:26:36.489323Z :KQP_PROXY DEBUG: Created new session, sessionId: ydb://session/3?node_id=50000&id=Zjk1NDMxN2QtNzZlMmNhOTYtYjk2ZWFmOTEtZTdlNTg0MQ==, workerId: [50000:7565614080853147406:4233], database: , longSession: 0, local sessions count: 2
2025-10-26T19:26:36.489477Z :KQP_PROXY DEBUG: Ctx: { TraceId: , Database: , DatabaseId: , SessionId: ydb://session/3?node_id=50000&id=Zjk1NDMxN2QtNzZlMmNhOTYtYjk2ZWFmOTEtZTdlNTg0MQ==, CurrentExecutionId: , CustomerSuppliedId: , PoolId: }. TEvQueryRequest, set timer for: 300.000000s timeout: 0.000000s cancelAfter: 0.000000s. Send request to target, requestId: 6, targetId: [50000:7565614080853147406:4233]
2025-10-26T19:26:36.489510Z :KQP_PROXY DEBUG: Scheduled timeout timer for requestId: 6 timeout: 300.000000s actor id: [50000:7565614080853147407:105]
2025-10-26T19:26:36.518188Z :KQP_GATEWAY DEBUG: Load table metadata from cache by path, request Path: 
2025-10-26T19:26:36.521522Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [50000:7565614080853147408:4141], 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-26T19:26:36.522564Z :KQP_PROXY DEBUG: Forwarded response to sender actor, requestId: 6, sender: [50000:7565614055083342775:4101], selfId: [50000:7565614055083342805:4115], source: [50000:7565614080853147406:4233]
2025-10-26T19:26:36.522617Z :KQP_PROXY DEBUG: Session closed, sessionId: ydb://session/3?node_id=50000&id=Zjk1NDMxN2QtNzZlMmNhOTYtYjk2ZWFmOTEtZTdlNTg0MQ==, workerId: [50000:7565614080853147406:4233], local sessions count: 1
2025-10-26T19:26:36.755942Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125004, Sender [1:7565614032432693463:90], Recipient [50000:7565614059378310487:91]
2025-10-26T19:26:36.755985Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvUpdateTenantSchemeShard
2025-10-26T19:26:36.756050Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614067968245256:4200][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:36.756124Z :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-26T19:26:36.756313Z :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-26T19:26:36.756483Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnExecute at tablet# 72075186224037889
2025-10-26T19:26:36.756508Z :FLAT_TX_SCHEMESHARD DEBUG: Cannot publish paths for unknown operation id#0
2025-10-26T19:26:36.761899Z :FLAT_TX_SCHEMESHARD TRACE: TSideEffects ApplyOnComplete at tablet# 72075186224037889
2025-10-26T19:26:36.762115Z :FLAT_TX_SCHEMESHARD TRACE: Send  to actor: [1:7565614032432693463:90] 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-26T19:26:36.762247Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoExecute, at schemeshard: 72075186224037889
2025-10-26T19:26:36.762266Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard DescribePath, at schemeshard: 72075186224037889, txId: 0, path id: [OwnerId: 72075186224037889, LocalPathId: 1]
2025-10-26T19:26:36.762425Z :FLAT_TX_SCHEMESHARD INFO: TTxPublishToSchemeBoard DoComplete, at schemeshard: 72075186224037889
2025-10-26T19:26:36.762449Z :FLAT_TX_SCHEMESHARD DEBUG: TTxPublishToSchemeBoard Send, to populator: [50000:7565614067968245249:4199], at schemeshard: 72075186224037889, txId: 0, path id: 1
2025-10-26T19:26:36.762520Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Update description: owner# 72075186224037889, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], cookie# 0, is deletion# false, version: 7
2025-10-26T19:26:36.763723Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:36.763868Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342782: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-26T19:26:36.763908Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342783: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-26T19:26:36.763910Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Path was updated to new version: owner# [50000:7565614055083342905:25], 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-26T19:26:36.763981Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179988:4164][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565614076558179987:4161], 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-26T19:26:36.764146Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:36.764261Z :SCHEME_BOARD_POPULATOR NOTICE: [50000:7565614067968245249:4199] Ack update: ack to# [50000:7565614059378310487:91], cookie# 0, pathId# [OwnerId: 72075186224037889, LocalPathId: 1], version# 7
2025-10-26T19:26:36.764293Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:36.764294Z :GRPC_SERVER DEBUG: SchemeBoardUpdate /Root/test_auditlog.py
2025-10-26T19:26:36.764361Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 274137603, Sender [50000:7565614067968245249:4199], Recipient [50000:7565614059378310487:91]: NKikimrSchemeBoard.TEvUpdateAck { Owner: 72075186224037889 Generation: 1 PathId: [OwnerId: 72075186224037889, LocalPathId: 1] Version: 7 }
2025-10-26T19:26:36.764383Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event NSchemeBoard::NSchemeshardEvents::TEvUpdateAck
2025-10-26T19:26:36.764405Z :GRPC_SERVER DEBUG: Can't update SecurityState for /Root/test_auditlog.py - no SecurityState
2025-10-26T19:26:36.764447Z :FLAT_TX_SCHEMESHARD INFO: Handle TEvUpdateAck, at schemeshard: 72075186224037889, msg: Owner: 72075186224037889 Generation: 1 LocalPathId: 1 Version: 7 PathOwnerId: 72075186224037889, cookie: 0
2025-10-26T19:26:37.053299Z :GRPC_SERVER DEBUG: [0x61a00016c880] 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:46616
2025-10-26T19:26:37.053394Z :GRPC_SERVER DEBUG: [0x61a000031280] created request Name# SetConfig
2025-10-26T19:26:37.053789Z :GRPC_SERVER DEBUG: [0x61a00016c880] received request without user token Name# SetConfig 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:46616 database# /Root/test_auditlog.py
2025-10-26T19:26:37.054001Z :GRPC_SERVER DEBUG: Got grpc request# SetConfigRequest, traceId# 01k8gzs9fx1ppmv1p0v4cmbp3q, sdkBuildInfo# ydb-python-sdk/3.12.3, state# AS_NOT_PERFORMED, database# /Root/test_auditlog.py, peer# ipv4:127.0.0.1:46616, grpcInfo# python-library grpc-python/1.54.2 grpc-c/31.0.0 (linux; chttp2), timeout# 600.995708s
2025-10-26T19:26:37.064856Z :GRPC_SERVER DEBUG: [0x61a00016c880] issuing response Name# SetConfig data# operation { ready: true status: SUCCESS }  peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:37.065343Z :GRPC_SERVER DEBUG: [0x61a00016c880] finished request Name# SetConfig ok# true peer# ipv4:127.0.0.1:46616
2025-10-26T19:26:37.094515Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271125000, Sender [0:0:0], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:37.094554Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvWakeupToMeasureSelfResponseTime
2025-10-26T19:26:37.094600Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, received event# 271124999, Sender [50000:7565614059378310487:91], Recipient [50000:7565614059378310487:91]: NKikimr::NSchemeShard::TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:37.094614Z :FLAT_TX_SCHEMESHARD TRACE: StateWork, processing event TEvSchemeShard::TEvMeasureSelfResponseTime
2025-10-26T19:26:37.166345Z :KQP_PROXY DEBUG: Updated table service config.
2025-10-26T19:26:37.166397Z :KQP_PROXY DEBUG: Updated YQL logs priority to current level: 3
2025-10-26T19:26:37.173824Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_DATASHARD has been changed from ERROR to NOTICE
2025-10-26T19:26:37.173858Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component FLAT_TX_SCHEMESHARD has been changed from TRACE to NOTICE
2025-10-26T19:26:37.173868Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component HIVE has been changed from ERROR to NOTICE
2025-10-26T19:26:37.173884Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_PROXY has been changed from CRIT to NOTICE
2025-10-26T19:26:37.173896Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component TX_PROXY_SCHEME_CACHE has been changed from CRIT to NOTICE
2025-10-26T19:26:37.173907Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component GRPC_SERVER has been changed from DEBUG to NOTICE
2025-10-26T19:26:37.173918Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component GRPC_PROXY has been changed from DEBUG to NOTICE
2025-10-26T19:26:37.173931Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component CMS_TENANTS has been changed from ERROR to NOTICE
2025-10-26T19:26:37.173942Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_PROXY has been changed from DEBUG to NOTICE
2025-10-26T19:26:37.173954Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_WORKER has been changed from ERROR to NOTICE
2025-10-26T19:26:37.173969Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_GATEWAY has been changed from DEBUG to NOTICE
2025-10-26T19:26:37.173981Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_YQL has been changed from ERROR to NOTICE
2025-10-26T19:26:37.173994Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_COMPILE_ACTOR has been changed from ERROR to NOTICE
2025-10-26T19:26:37.174004Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component KQP_SESSION has been changed from ERROR to NOTICE
2025-10-26T19:26:37.174021Z :CMS_CONFIGS NOTICE: TLogSettingsConfigurator: Priority for the component PERSQUEUE_CLUSTER_TRACKER has been changed from CRIT to NOTICE
2025-10-26T19:26:37.546401Z :KQP_YQL NOTICE: TraceId: 01k8gzs9yn9qpnpm5x13pxjz5g, SessionId: CompileActor 2025-10-26 19:26:37.546 NOTE  ydbd(pid=1877652, tid=0x00007F3A6C97F640) [common provider] yql_provider_gateway.cpp:21: <main>: Error: Type annotation, code: 1030
2025-10-26T19:26:37.546444Z :KQP_YQL NOTICE: TraceId: 01k8gzs9yn9qpnpm5x13pxjz5g, SessionId: CompileActor 2025-10-26 19:26:37.546 NOTE  ydbd(pid=1877652, tid=0x00007F3A6C97F640) [common provider] yql_provider_gateway.cpp:21: <main>:3:16: Error: At function: KiReadTable!
2025-10-26T19:26:37.546478Z :KQP_YQL NOTICE: TraceId: 01k8gzs9yn9qpnpm5x13pxjz5g, SessionId: CompileActor 2025-10-26 19:26:37.546 NOTE  ydbd(pid=1877652, tid=0x00007F3A6C97F640) [common provider] yql_provider_gateway.cpp:21: <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-26T19:26:37.547885Z :KQP_COMPILE_ACTOR ERROR: Compilation failed, self: [50000:7565614085148114744:4171], 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-26T19:26:37.549733Z :KQP_SESSION WARN: SessionId: ydb://session/3?node_id=50000&id=NzVjNDE1NTYtODIyOTAzNGEtZTdhNGZhNjItNjU2ZTI5OTQ=, ActorId: [50000:7565614085148114742:4217], ActorState: ExecuteState, TraceId: 01k8gzs9yn9qpnpm5x13pxjz5g, ReplyQueryCompileError, status SCHEME_ERROR remove tx with tx_id: 
2025-10-26T19:26:37.550348Z :PERSQUEUE_CLUSTER_TRACKER ERROR: failed to list clusters: { Response { QueryIssues { message: "Type annotation" issue_code: 1030 severity: 1 issues { position { row: 3 column: 16 } message: "At function: KiReadTable!" end_position { row: 3 column: 16 } severity: 1 issues { position { row: 3 column: 16 } message: "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." end_position { row: 3 column: 16 } issue_code: 2003 severity: 1 } } } TxMeta { } } YdbStatus: SCHEME_ERROR ConsumedRu: 1 }
2025-10-26T19:26:37.606292Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342925:4152][/Root] Path was updated to new version: owner# [50000:7565614055083342783: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-26T19:26:37.606362Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342914:4148][/Root] Path was updated to new version: owner# [50000:7565614055083342782: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-26T19:26:37.606640Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179926:4158][/Root] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:37.623550Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342914:4148][/Root] Path was updated to new version: owner# [50000:7565614055083342782: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-26T19:26:37.623611Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342925:4152][/Root] Path was updated to new version: owner# [50000:7565614055083342783: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-26T19:26:37.623722Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179926:4158][/Root] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:37.623727Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614076558179988:4164][[OwnerId: 72075186224037889, LocalPathId: 1]] Path was updated to new version: owner# [50000:7565614076558179987:4161], 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-26T19:26:37.624647Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342926:4153][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565614055083342783: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-26T19:26:37.624664Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342988:28][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565614055083342905:25], 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-26T19:26:37.624699Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614067968245256:4200][[OwnerId: 72075186232723360, LocalPathId: 2]] Path was updated to new version: owner# [50000:7565614055083342890: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-26T19:26:37.624785Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342915:4149][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565614055083342782: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-26T19:26:37.624812Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614055083342958:4169][/Root/test_auditlog.py] Path was deleted: owner# [50000:7565614055083342890: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-26T19:26:37.624819Z :GRPC_SERVER WARN: SchemeBoardDelete /Root/test_auditlog.py Strong=1
2025-10-26T19:26:37.624946Z :GRPC_SERVER WARN: SchemeBoardDelete /Root/test_auditlog.py Strong=1
2025-10-26T19:26:37.630309Z :SCHEME_BOARD_SUBSCRIBER NOTICE: [main][50000:7565614085148114759:4212][[OwnerId: 72075186224037889, LocalPathId: 1]] Set up state: owner# [50000:7565614055083342890:4125], state# { Deleted: 1 Strong: 1 Version: (PathId: [OwnerId: 72075186224037889, LocalPathId: 1], Version: 18446744073709551615) DomainId: <Invalid> AbandonedSchemeShards: there are 0 elements }
2025-10-26T19:26:37.632509Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,7) wasn't found - using supplied 72075186224037894
2025-10-26T19:26:37.632553Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037894) to Hive 72057594037968897
2025-10-26T19:26:37.632688Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,4) wasn't found - using supplied 72075186224037891
2025-10-26T19:26:37.632701Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037891) to Hive 72057594037968897
2025-10-26T19:26:37.632751Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,10) wasn't found - using supplied 72075186224037897
2025-10-26T19:26:37.632777Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037897) to Hive 72057594037968897
2025-10-26T19:26:37.632842Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,1) wasn't found - using supplied 72075186224037888
2025-10-26T19:26:37.632855Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037888) to Hive 72057594037968897
2025-10-26T19:26:37.632895Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,9) wasn't found - using supplied 72075186224037896
2025-10-26T19:26:37.632905Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037896) to Hive 72057594037968897
2025-10-26T19:26:37.632946Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,6) wasn't found - using supplied 72075186224037893
2025-10-26T19:26:37.632958Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037893) to Hive 72057594037968897
2025-10-26T19:26:37.632997Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,3) wasn't found - using supplied 72075186224037890
2025-10-26T19:26:37.633011Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037890) to Hive 72057594037968897
2025-10-26T19:26:37.633087Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,2) wasn't found - using supplied 72075186224037889
2025-10-26T19:26:37.633100Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037889) to Hive 72057594037968897
2025-10-26T19:26:37.633140Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,5) wasn't found - using supplied 72075186224037892
2025-10-26T19:26:37.633151Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037892) to Hive 72057594037968897
2025-10-26T19:26:37.633194Z :HIVE WARN: HIVE#72075186224037888 THive::TTxDeleteTablet tablet (72075186232723360,8) wasn't found - using supplied 72075186224037895
2025-10-26T19:26:37.633203Z :HIVE NOTICE: HIVE#72075186224037888 Forwarding TabletRequest(TabletID 72075186224037895) to Hive 72057594037968897
2025-10-26T19:26:37.643550Z :TABLET_MAIN NOTICE: Tablet: 72075186224037894  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.643554Z :TABLET_MAIN NOTICE: Tablet: 72075186224037891  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.643661Z :TABLET_MAIN NOTICE: Tablet: 72075186224037896  Type: SysViewProcessor, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.643740Z :TABLET_MAIN NOTICE: Tablet: 72075186224037897  Type: StatisticsAggregator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.643806Z :TABLET_MAIN NOTICE: Tablet: 72075186224037892  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.644550Z :TABLET_MAIN NOTICE: Tablet: 72075186224037889  Type: SchemeShard, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.644602Z :TABLET_MAIN NOTICE: Tablet: 72075186224037895  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.644627Z :TABLET_MAIN NOTICE: Tablet: 72075186224037890  Type: Coordinator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.644659Z :TABLET_MAIN NOTICE: Tablet: 72075186224037888  Type: Hive, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.644738Z :TABLET_MAIN NOTICE: Tablet: 72075186224037893  Type: Mediator, EReason: ReasonPill, SuggestedGeneration: 1, KnownGeneration: 1 Marker# TSYS31
2025-10-26T19:26:37.750360Z :BS_PROXY NOTICE: Group# 2181038082 HasInvalidGroupId# 0 Bootstrap -> StateEjected Marker# DSP42
2025-10-26T19:26:37.750402Z :BS_PROXY NOTICE: EnsureMonitoring Group# 2181038082 IsLimitedKeyless# 0 fullIfPossible# 0 Marker# DSP58
2025-10-26T19:26:37.752636Z :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-26T19:26:38.124046Z :TENANT_POOL NOTICE: Forward drain node to local.
2025-10-26T19:26:38.124069Z :KQP_PROXY NOTICE: KQP proxy shutdown requested.
2025-10-26T19:26:38.124115Z :GRPC_SERVER NOTICE: Stop publish endpoints for database: /Root/test_auditlog.py
2025-10-26T19:26:38.124149Z :LOCAL NOTICE: Forward drain node to local, hive id: 72057594037968897
2025-10-26T19:26:38.124184Z :LOCAL NOTICE: Send drain node to hive: 72057594037968897. Online tablets: 0
2025-10-26T19:26:38.127340Z :LOCAL NOTICE: Drain node result received. Online tablets: 0
2025-10-26T19:26:38.224994Z :INTERCONNECT NOTICE: Proxy [50000:7565614055083342737:1] [node 1] ICP32 transit to hold-by-error state Explanation# terminated
2025-10-26T19:26:38.225208Z :TX_PROXY WARN: actor# [50000:7565614055083342773:1363] HANDLE TEvClientDestroyed from tablet# 72057594046447617
2025-10-26T19:26:38.225746Z :BS_NODE ERROR: {NW42@node_warden_pipe.cpp:55} Handle(TEvTabletPipe::TEvClientDestroyed) ClientId# [50000:7565614055083342901:23] ServerId# [1:7565614058202497848:273] TabletId# 72057594037932033 PipeClientId# [50000:7565614055083342901:23]
2025-10-26T19:26:38.230027Z :INTERCONNECT_NETWORK NOTICE: [50000 <-> 1] connection closed by peer
