{"level":"info","ts":"2026-07-17T14:33:43.631799586Z","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:43.632274228Z","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:43.980333281Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:43.980441603Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:43.980476524Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:43.981334695Z","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:43.981328945Z","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:43.981441108Z","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:43.98233531Z","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:43.982409742Z","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:43.984692098Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:43.984811441Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:43.985343434Z","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:43.984977265Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":"localhost:8010","hasTLS":false} {"level":"info","ts":"2026-07-17T14:33:43.985336354Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":":8000","hasTLS":true} {"level":"info","ts":"2026-07-17T14:33:43.985771106Z","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:43.985475927Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-2","address":":9187","hasTLS":false} {"level":"info","ts":"2026-07-17T14:33:43.986159995Z","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:43.987753364Z","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:44.184798866Z","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:44.184845767Z","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:44.185191186Z","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:44.185247327Z","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:44.185308679Z","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:44.185439162Z","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:44.188534668Z","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:44.18858676Z","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:44.18903434Z","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:44.189083382Z","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:44.189117962Z","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:44.189124613Z","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:44.199769606Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:33:44.202020382Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:33:44.207677673Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:33:44.209645771Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:33:44.213939397Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:33:44.217967887Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","logging_pod":"keycloak-db-2","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:33:44.218155901Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","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:44.225022562Z","msg":"Updated replication settings","logging_pod":"keycloak-db-2","filename":"override.conf"} {"level":"info","ts":"2026-07-17T14:33:44.246424323Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-2","reason":"postmaster start up"} {"level":"info","ts":"2026-07-17T14:33:44.248161565Z","logger":"pg_controldata","msg":"pg_control version number: 1800\nCatalog version number: 202506291\nDatabase system identifier: 7663504958506807323\nDatabase cluster state: in production\npg_control last modified: Fri Jul 17 14:33:37 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:35 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: 4075f513ded4a1d1f01107ddadfe56a0addf958bfced3510f2a517c2ede49ea0\n","pipe":"stdout","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.249361195Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-2","postMasterPID":32} {"level":"info","ts":"2026-07-17T14:33:44.261212689Z","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":"5f9be77e-f35c-4a03-8d13-07eb8d3f420f","instance":"keycloak-db-2","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.279239655Z","logger":"postgres","msg":"2026-07-17 14:33:44.279 UTC [32] LOG: redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.279318037Z","logger":"postgres","msg":"2026-07-17 14:33:44.279 UTC [32] HINT: Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.280375283Z","logger":"postgres","msg":"2026-07-17 14:33:44.279 UTC [32] LOG: ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.280396514Z","logger":"postgres","msg":"2026-07-17 14:33:44.279 UTC [32] 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:44.280469396Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.279 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:44.280886596Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.279 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"2","session_start_time":"2026-07-17 14:33:44 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:44.280910706Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.279 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"3","session_start_time":"2026-07-17 14:33:44 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:44.280926787Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.279 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"4","session_start_time":"2026-07-17 14:33:44 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:44.284471794Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.284 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"5","session_start_time":"2026-07-17 14:33:44 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:44.290079653Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.289 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:37 UTC","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:33:44.427645001Z","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:44.531565716Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.531 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"2","session_start_time":"2026-07-17 14:33:44 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:44.604962625Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.604 UTC","user_name":"postgres","database_name":"postgres","process_id":"65","connection_from":"[local]","session_id":"6a5a3d48.41","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:44.606222126Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.606 UTC","user_name":"postgres","database_name":"postgres","process_id":"66","connection_from":"[local]","session_id":"6a5a3d48.42","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:44.606693247Z","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":"5715d142-f526-4c14-acb8-85c21666609d","instance":"keycloak-db-2","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:33:44.618612062Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.618 UTC","user_name":"postgres","database_name":"postgres","process_id":"67","connection_from":"[local]","session_id":"6a5a3d48.43","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:44.675125633Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.674 UTC","user_name":"postgres","database_name":"postgres","process_id":"68","connection_from":"[local]","session_id":"6a5a3d48.44","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:44.681597373Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.681 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"3","session_start_time":"2026-07-17 14:33:44 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:44.690446322Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.690 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"4","session_start_time":"2026-07-17 14:33:44 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:44.843209557Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.843 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"5","session_start_time":"2026-07-17 14:33:44 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:44.843289159Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.843 UTC","process_id":"39","session_id":"6a5a3d48.27","session_line_num":"6","session_start_time":"2026-07-17 14:33:44 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:44.843309909Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:44.843 UTC","process_id":"32","session_id":"6a5a3d48.20","session_line_num":"6","session_start_time":"2026-07-17 14:33:44 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:45.004516242Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:33:45.003 UTC","process_id":"103","session_id":"6a5a3d48.67","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:15.013124274Z","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":"be01da75-5168-46b2-947b-9aee7481a771","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:15.013184576Z","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":"be01da75-5168-46b2-947b-9aee7481a771","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:15.022965178Z","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":"ce464a6d-c562-4204-a10a-681abebdce21","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:34:15.023101002Z","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":"ce464a6d-c562-4204-a10a-681abebdce21","databaseName":"keycloak","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T14:38:44.389028762Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:38:44.388 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"1","session_start_time":"2026-07-17 14:33:44 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:34.356544688Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:41:34.356 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"2","session_start_time":"2026-07-17 14:33:44 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"restartpoint complete: wrote 1696 buffers (10.4%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=169.895 s, sync=0.061 s, total=169.968 s; sync files=763, longest=0.006 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:34.356758444Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:41:34.356 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"3","session_start_time":"2026-07-17 14:33:44 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:54.857604+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:43:44.454485235Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:44.454 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"4","session_start_time":"2026-07-17 14:33:44 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:44.670778179Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:44.670 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"5","session_start_time":"2026-07-17 14:33:44 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.203 s, sync=0.004 s, total=0.217 s; sync files=3, longest=0.002 s, average=0.002 s; distance=26768 kB, estimate=32168 kB; lsn=0/7000098, redo lsn=0/6A240E0","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:43:44.670939413Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 14:43:44.670 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"6","session_start_time":"2026-07-17 14:33:44 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/6A240E0","detail":"Last completed transaction was at log time 2026-07-17 14:38:54.857604+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:02:12.415499034Z","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:13.186811816Z","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:22.415237606Z","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":"error","ts":"2026-07-17T15:06:32.417987367Z","msg":"Unexpected error when reading response body","error":"context deadline exceeded","stacktrace":"k8s.io/client-go/rest.(*Request).transformResponse\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1196\nk8s.io/client-go/rest.(*Request).Do.func1\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1137\nk8s.io/client-go/rest.(*Request).request.func3.1\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1107\nk8s.io/client-go/rest.(*Request).request.func3\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1114\nk8s.io/client-go/rest.(*Request).request\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1116\nk8s.io/client-go/rest.(*Request).Do\n\tpkg/mod/k8s.io/client-go@v0.36.2/rest/request.go:1136\nsigs.k8s.io/controller-runtime/pkg/client.(*typedClient).Get\n\tpkg/mod/sigs.k8s.io/controller-runtime@v0.24.1/pkg/client/typed_client.go:187\nsigs.k8s.io/controller-runtime/pkg/client.(*client).Get\n\tpkg/mod/sigs.k8s.io/controller-runtime@v0.24.1/pkg/client/client.go:385\ngithub.com/cloudnative-pg/cloudnative-pg/pkg/management/postgres/webserver/probes.(*ClusterCache).tryGetLatestClusterWithTimeout\n\tpkg/management/postgres/webserver/probes/cache.go:63\ngithub.com/cloudnative-pg/cloudnative-pg/pkg/management/postgres/webserver/probes.(*executor).IsHealthy\n\tpkg/management/postgres/webserver/probes/checker.go:94\ngithub.com/cloudnative-pg/cloudnative-pg/pkg/management/postgres/webserver.(*remoteWebserverEndpoints).isServerReady\n\tpkg/management/postgres/webserver/remote.go:255\nnet/http.HandlerFunc.ServeHTTP\n\t/opt/hostedtoolcache/go/1.26.4/x64/src/net/http/server.go:2286\nnet/http.(*ServeMux).ServeHTTP\n\t/opt/hostedtoolcache/go/1.26.4/x64/src/net/http/server.go:2828\nnet/http.serverHandler.ServeHTTP\n\t/opt/hostedtoolcache/go/1.26.4/x64/src/net/http/server.go:3311\nnet/http.initALPNRequest.ServeHTTP\n\t/opt/hostedtoolcache/go/1.26.4/x64/src/net/http/server.go:3984\nnet/http.(*http2serverConn).runHandler\n\t/opt/hostedtoolcache/go/1.26.4/x64/src/net/http/h2_bundle.go:6412"} {"level":"info","ts":"2026-07-17T15:06:32.418619952Z","msg":"readiness probe using cached cluster definition due to API server connectivity issue","apiServerReachable":false,"apiServerErr":"unexpected error when reading response body. Please retry. Original error: context deadline exceeded","logging_pod":"keycloak-db-2"} {"level":"info","ts":"2026-07-17T15:06:42.414764071Z","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:52.414841965Z","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:02.415568816Z","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:12.415948889Z","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:22.414554907Z","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:32.414703954Z","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:42.4144313Z","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:14:00.991364309Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:00.990 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"7","session_start_time":"2026-07-17 14:33:44 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:01.522574048Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:01.522 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"8","session_start_time":"2026-07-17 14:33:44 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=0.517 s, sync=0.006 s, total=0.532 s; sync files=5, longest=0.006 s, average=0.002 s; distance=22403 kB, estimate=31191 kB; lsn=0/9000060, redo lsn=0/8004E88","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:14:01.52264675Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-2","record":{"log_time":"2026-07-17 15:14:01.522 UTC","process_id":"37","session_id":"6a5a3d48.25","session_line_num":"9","session_start_time":"2026-07-17 14:33:44 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"recovery restart point at 0/8004E88","detail":"Last completed transaction was at log time 2026-07-17 15:13:56.144261+00.","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T15:16:42.41516671Z","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:22:22.415915183Z","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:23:22.416158955Z","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"}