{"level":"info","ts":"2026-07-17T14:33:40.824577006Z","msg":"OS distribution is supported","logger":"instance-manager","logging_pod":"keycloak-db-2","entry":{"version":"13 (trixie)","deprecatedFrom":"2028-08-09T00:00:00Z","supportedUntil":"2030-06-30T00:00:00Z"}} {"level":"info","ts":"2026-07-17T14:33:40.82474891Z","msg":"Starting CloudNativePG Instance Manager","logger":"instance-manager","logging_pod":"keycloak-db-2","version":"1.28.4","build":{"Version":"1.28.4","Commit":"f74344b4d","Date":"2026-06-29"},"skipNameValidation":false} {"level":"info","ts":"2026-07-17T14:33:41.161246642Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.161327044Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.161350705Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.162034363Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.162082214Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.162135275Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.162271328Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":"localhost:8010","hasTLS":false} {"level":"info","ts":"2026-07-17T14:33:41.162497374Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":":8000","hasTLS":true} {"level":"info","ts":"2026-07-17T14:33:41.162612547Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.162859583Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.162851862Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":":9187","hasTLS":false} {"level":"info","ts":"2026-07-17T14:33:41.162897984Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Publication"} {"level":"info","ts":"2026-07-17T14:33:41.162857493Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Database"} {"level":"info","ts":"2026-07-17T14:33:41.163073638Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.16438283Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.164426711Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Subscription"} {"level":"info","ts":"2026-07-17T14:33:41.164471992Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.36369303Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.363753032Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.363797463Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database"} {"level":"info","ts":"2026-07-17T14:33:41.363829274Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.363729001Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication"} {"level":"info","ts":"2026-07-17T14:33:41.363778703Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.363854454Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.363796983Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.365686579Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:33:41.36573562Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription"} {"level":"info","ts":"2026-07-17T14:33:41.365765481Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.365770931Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","worker count":1} {"level":"info","ts":"2026-07-17T14:33:41.376905015Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:33:41.379098459Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:33:41.384469881Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:33:41.38687273Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:33:41.391761031Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:33:41.39625221Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:33:41.396491306Z","msg":"Detected running images","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","logging_pod":"keycloak-db-2","runningImages":["harbor.atmosphere.dev/ghcr.io/cloudnative-pg/postgresql:18.4-202606221003-minimal-trixie@sha256:538f1b327b8dc7621a94aac79c9c3e5c50dfa29115a6c291e19372a5b876f415"]} {"level":"info","ts":"2026-07-17T14:33:41.402426142Z","msg":"Updated replication settings","logging_pod":"keycloak-db-2","filename":"override.conf"} {"level":"info","ts":"2026-07-17T14:33:41.423770927Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-2","reason":"postmaster start up"} {"level":"info","ts":"2026-07-17T14:33:41.425340776Z","logger":"pg_controldata","msg":"pg_control version number: 1800\nCatalog version number: 202506291\nDatabase system identifier: 7663504941808078876\nDatabase cluster state: in production\npg_control last modified: Fri Jul 17 14:33:33 2026\nLatest checkpoint location: 0/30000B8\nLatest checkpoint's REDO location: 0/3000028\nLatest checkpoint's REDO WAL file: 000000010000000000000003\nLatest checkpoint's TimeLineID: 1\nLatest checkpoint's PrevTimeLineID: 1\nLatest checkpoint's full_page_writes: on\nLatest checkpoint's NextXID: 0:759\nLatest checkpoint's NextOID: 24578\nLatest checkpoint's NextMultiXactId: 1\nLatest checkpoint's NextMultiOffset: 0\nLatest checkpoint's oldestXID: 744\nLatest checkpoint's oldestXID's DB: 1\nLatest checkpoint's oldestActiveXID: 759\nLatest checkpoint's oldestMultiXid: 1\nLatest checkpoint's oldestMulti's DB: 1\nLatest checkpoint's oldestCommitTsXid:0\nLatest checkpoint's newestCommitTsXid:0\nTime of latest checkpoint: Fri Jul 17 14:33:31 2026\nFake LSN counter for unlogged rels: 0/3E8\nMinimum recovery ending location: 0/0\nMin recovery ending loc's timeline: 0\nBackup start location: 0/0\nBackup end location: 0/0\nEnd-of-backup record required: no\nwal_level setting: logical\nwal_log_hints setting: on\nmax_connections setting: 100\nmax_worker_processes setting: 60\nmax_wal_senders setting: 10\nmax_prepared_xacts setting: 0\nmax_locks_per_xact setting: 64\ntrack_commit_timestamp setting: off\nMaximum data alignment: 8\nDatabase block size: 8192\nBlocks per segment of large relation: 131072\nWAL block size: 8192\nBytes per WAL segment: 16777216\nMaximum length of identifiers: 64\nMaximum columns in an index: 32\nMaximum size of a TOAST chunk: 1996\nSize of a large-object chunk: 2048\nDate/time type storage: 64-bit integers\nFloat8 argument passing: by value\nData page checksum version: 1\nDefault char data signedness: signed\nMock authentication nonce: 2f9cefeb7b5ff04030c18057c6fd26688f3f36f049be44cbb71f08e1eccc94a0\n","pipe":"stdout","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.42675519Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-2","postMasterPID":30} {"level":"info","ts":"2026-07-17T14:33:41.436775367Z","msg":"Instance is still down, will retry in 1 second","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"6ce83c5c-338e-4274-8e40-8eced297a62c","instance":"keycloak-db-2","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.454287058Z","logger":"postgres","msg":"2026-07-17 14:33:41.454 UTC [30] LOG: redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.454331349Z","logger":"postgres","msg":"2026-07-17 14:33:41.454 UTC [30] HINT: Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.454984414Z","logger":"postgres","msg":"2026-07-17 14:33:41.454 UTC [30] LOG: ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.455002665Z","logger":"postgres","msg":"2026-07-17 14:33:41.454 UTC [30] HINT: Future log output will go to log destination \"csvlog\".","source":"/controller/log/postgres","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.455100757Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.454 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"ending log output to stderr","hint":"Future log output will go to log destination \"csvlog\".","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.455434965Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.454 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"2","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"starting PostgreSQL 18.4 (Debian 18.4-1.pgdg13+1) on x86_64-pc-linux-gnu, compiled by gcc (Debian 14.2.0-19) 14.2.0, 64-bit","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.455496677Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.454 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"3","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"listening on IPv4 address \"0.0.0.0\", port 5432","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.455526468Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.454 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"4","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"listening on IPv6 address \"::\", port 5432","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.460434478Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.460 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"5","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"listening on Unix socket \"/controller/run/.s.PGSQL.5432\"","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.468158879Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.467 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system was interrupted; last known up at 2026-07-17 14:33:33 UTC","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.601445825Z","logger":"wal-restore","msg":"Refusing to restore future timeline history file","logging_pod":"keycloak-db-2","walName":"00000002.history","fileTimeline":2,"clusterTimeline":1} {"level":"info","ts":"2026-07-17T14:33:41.704380466Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.704 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"2","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"starting backup recovery with redo LSN 0/3000028, checkpoint LSN 0/30000B8, on timeline ID 1","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.780109438Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.779 UTC","user_name":"postgres","database_name":"postgres","process_id":"66","connection_from":"[local]","session_id":"6a5a3d45.42","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"57P03","message":"the database system is starting up","backend_type":"client backend","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.792075392Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.791 UTC","user_name":"postgres","database_name":"postgres","process_id":"67","connection_from":"[local]","session_id":"6a5a3d45.43","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"57P03","message":"the database system is starting up","backend_type":"client backend","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.792123873Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.792 UTC","user_name":"postgres","database_name":"postgres","process_id":"68","connection_from":"[local]","session_id":"6a5a3d45.44","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"57P03","message":"the database system is starting up","backend_type":"client backend","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.792437171Z","msg":"Instance is still down, will retry in 1 second","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"c8a126de-d19b-41ce-b556-a83c2f331e66","instance":"keycloak-db-2","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:41.84772815Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.847 UTC","user_name":"postgres","database_name":"postgres","process_id":"69","connection_from":"[local]","session_id":"6a5a3d45.45","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"57P03","message":"the database system is starting up","backend_type":"client backend","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.848174691Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.847 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"3","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"entering standby mode","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:41.852686242Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:41.852 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"4","session_start_time":"2026-07-17 14:33:41 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"redo starts at 0/3000028","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:42.000751113Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:42.000 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"5","session_start_time":"2026-07-17 14:33:41 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"completed backup recovery with redo LSN 0/3000028 and end LSN 0/3000158","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:42.000901846Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:42.000 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"6","session_start_time":"2026-07-17 14:33:41 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"consistent recovery state reached at 0/3000158","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:42.001126502Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:42.000 UTC","process_id":"30","session_id":"6a5a3d45.1e","session_line_num":"6","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system is ready to accept read-only connections","backend_type":"postmaster","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:42.154841671Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:42.154 UTC","process_id":"99","session_id":"6a5a3d46.63","session_line_num":"1","session_start_time":"2026-07-17 14:33:42 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"started streaming WAL from primary at 0/4000000 on timeline 1","backend_type":"walreceiver","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:13.534608919Z","logger":"database_reconciler","msg":"Reconciling database","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"83b82c1a-a01f-4d48-a7a8-f61fd4f2bf31","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:13.534670171Z","logger":"database_reconciler","msg":"Reconciliation loop of database exited","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"83b82c1a-a01f-4d48-a7a8-f61fd4f2bf31","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:13.543549949Z","logger":"database_reconciler","msg":"Reconciling database","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9be1ef23-b7ca-4d6d-adb2-1cbcbb3234c5","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:13.54358088Z","logger":"database_reconciler","msg":"Reconciliation loop of database exited","logger":"instance-manager","logging_pod":"keycloak-db-2","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9be1ef23-b7ca-4d6d-adb2-1cbcbb3234c5","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:38:41.56796005Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:38:41.567 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"1","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:41:31.23355333Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:41:31.233 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"2","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 1694 buffers (10.3%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=169.598 s, sync=0.058 s, total=169.666 s; sync files=758, longest=0.002 s, average=0.001 s; distance=32768 kB, estimate=32768 kB; lsn=0/5000080, redo lsn=0/5000028","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:41:31.233624762Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:41:31.233 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"3","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/5000028","detail":"Last completed transaction was at log time 2026-07-17 14:38:41.703965+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:43:41.332880441Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:41.332 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"4","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:43:41.558866915Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:41.558 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"5","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 2 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.204 s, sync=0.002 s, total=0.226 s; sync files=2, longest=0.001 s, average=0.001 s; distance=26737 kB, estimate=32164 kB; lsn=0/7000098, redo lsn=0/6A1C458","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:43:41.558937337Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:41.558 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"6","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/6A1C458","detail":"Last completed transaction was at log time 2026-07-17 14:38:41.703965+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:45:19.612642259Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:48:41.651689056Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:48:41.651 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"7","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:48:41.66202974Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:48:41.661 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"8","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 0 buffers (0.0%), wrote 0 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.011 s; sync files=0, longest=0.000 s, average=0.000 s; distance=6039 kB, estimate=29552 kB; lsn=0/8000060, redo lsn=0/7002418","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:48:41.662186135Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:48:41.661 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"9","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/7002418","detail":"Last completed transaction was at log time 2026-07-17 14:38:41.703965+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:50:19.613688856Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:56:59.612721506Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:05:59.612831318Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:06:19.613516854Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:06:39.612406316Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:06:49.612026967Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:06:59.611718108Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:07:09.612903067Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:07:19.613558052Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:07:29.612399193Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:07:39.624784679Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:07:46.611402472Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:07:46.611 UTC","process_id":"99","session_id":"6a5a3d46.63","session_line_num":"2","session_start_time":"2026-07-17 14:33:42 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"08006","message":"could not receive data from WAL stream: SSL connection has been closed unexpectedly","backend_type":"walreceiver","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:07:46.894736695Z","logger":"wal-restore","msg":"Refusing to restore future timeline history file","logging_pod":"keycloak-db-2","walName":"00000002.history","fileTimeline":2,"clusterTimeline":1} {"level":"info","ts":"2026-07-17T15:07:47.149585415Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:07:47.149 UTC","process_id":"37","session_id":"6a5a3d45.25","session_line_num":"7","session_start_time":"2026-07-17 14:33:41 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"invalid record length at 0/9001630: expected at least 24, got 0","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:07:47.164452042Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:07:47.164 UTC","process_id":"928","session_id":"6a5a4543.3a0","session_line_num":"1","session_start_time":"2026-07-17 15:07:47 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"started streaming WAL from primary at 0/9000000 on timeline 1","backend_type":"walreceiver","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:09:13.157611104Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:09:13.156 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"10","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:09:14.073852296Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:09:14.073 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"11","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 9 buffers (0.1%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.905 s, sync=0.004 s, total=0.917 s; sync files=10, longest=0.002 s, average=0.001 s; distance=32790 kB, estimate=32790 kB; lsn=0/A000098, redo lsn=0/9007DB0","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:09:14.073917038Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:09:14.073 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"12","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/9007DB0","detail":"Last completed transaction was at log time 2026-07-17 15:08:23.691878+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:14:13.128923749Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:13.128 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"13","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:14:13.352106495Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:13.351 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"14","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 2 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.210 s, sync=0.002 s, total=0.224 s; sync files=3, longest=0.001 s, average=0.001 s; distance=16368 kB, estimate=31148 kB; lsn=0/A0041D8, redo lsn=0/A004180","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:14:13.352188078Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:13.351 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"15","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/A004180","detail":"Last completed transaction was at log time 2026-07-17 15:11:14.503054+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:16:39.613707787Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:19:09.612106928Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:19:13.448667621Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:19:13.448 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"16","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint starting: time","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:19:16.765491839Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:19:16.765 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"17","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 5 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=1.205 s, sync=0.081 s, total=3.317 s; sync files=5, longest=0.040 s, average=0.017 s; distance=16384 kB, estimate=29671 kB; lsn=0/C000060, redo lsn=0/B0044F8","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:19:16.76553982Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:19:16.765 UTC","process_id":"35","session_id":"6a5a3d45.23","session_line_num":"18","session_start_time":"2026-07-17 14:33:41 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/B0044F8","detail":"Last completed transaction was at log time 2026-07-17 15:14:14.536098+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:20:09.611578067Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:20:39.617181288Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"Get \"https://10.96.0.1:443/apis/postgresql.cnpg.io/v1/namespaces/auth-system/clusters/keycloak-db\": context deadline exceeded","logging_pod":"keycloak-db-2"}