{"level":"info","ts":"2026-07-17T14:34:02.978586433Z","msg":"OS distribution is supported","logger":"instance-manager","logging_pod":"keycloak-db-3","entry":{"version":"13 (trixie)","deprecatedFrom":"2028-08-09T00:00:00Z","supportedUntil":"2030-06-30T00:00:00Z"}} {"level":"info","ts":"2026-07-17T14:34:02.978778738Z","msg":"Starting CloudNativePG Instance Manager","logger":"instance-manager","logging_pod":"keycloak-db-3","version":"1.28.4","build":{"Version":"1.28.4","Commit":"f74344b4d","Date":"2026-06-29"},"skipNameValidation":false} {"level":"info","ts":"2026-07-17T14:34:03.323270338Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.32334013Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.32336225Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.323767581Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.324346265Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.325323689Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.325579255Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-3","address":":8000","hasTLS":true} {"level":"info","ts":"2026-07-17T14:34:03.326103117Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.3261946Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Publication"} {"level":"info","ts":"2026-07-17T14:34:03.326132918Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.326406565Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-3","address":"localhost:8010","hasTLS":false} {"level":"info","ts":"2026-07-17T14:34:03.326514468Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Subscription"} {"level":"info","ts":"2026-07-17T14:34:03.326486558Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.32657612Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-3","address":":9187","hasTLS":false} {"level":"info","ts":"2026-07-17T14:34:03.326769425Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Database"} {"level":"info","ts":"2026-07-17T14:34:03.327357939Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.32781464Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.52713426Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.527207882Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.528016221Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication"} {"level":"info","ts":"2026-07-17T14:34:03.528055322Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.528051762Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database"} {"level":"info","ts":"2026-07-17T14:34:03.528079843Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.528073953Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription"} {"level":"info","ts":"2026-07-17T14:34:03.528132774Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.528088343Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.528171736Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.529440367Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"} {"level":"info","ts":"2026-07-17T14:34:03.529479738Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1} {"level":"info","ts":"2026-07-17T14:34:03.539467214Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:34:03.541762579Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T14:34:03.54664739Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:34:03.548771222Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T14:34:03.554759349Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:34:03.561907945Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T14:34:03.562265754Z","msg":"Detected running images","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","logging_pod":"keycloak-db-3","runningImages":["harbor.atmosphere.dev/ghcr.io/cloudnative-pg/postgresql:18.4-202606221003-minimal-trixie@sha256:538f1b327b8dc7621a94aac79c9c3e5c50dfa29115a6c291e19372a5b876f415"]} {"level":"info","ts":"2026-07-17T14:34:03.569822589Z","msg":"Updated replication settings","logging_pod":"keycloak-db-3","filename":"override.conf"} {"level":"info","ts":"2026-07-17T14:34:03.591286787Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-3","reason":"postmaster start up"} {"level":"info","ts":"2026-07-17T14:34:03.593053001Z","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:57 2026\nLatest checkpoint location: 0/5000080\nLatest checkpoint's REDO location: 0/5000028\nLatest checkpoint's REDO WAL file: 000000010000000000000005\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:57 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-3"} {"level":"info","ts":"2026-07-17T14:34:03.593810099Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-3","postMasterPID":29} {"level":"info","ts":"2026-07-17T14:34:03.604857671Z","msg":"Instance is still down, will retry in 1 second","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"16dc11e1-032f-40fe-9c6c-539eb884e8cc","instance":"keycloak-db-3","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.620619799Z","logger":"postgres","msg":"2026-07-17 14:34:03.620 UTC [29] LOG: redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.62068153Z","logger":"postgres","msg":"2026-07-17 14:34:03.620 UTC [29] HINT: Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.621254004Z","logger":"postgres","msg":"2026-07-17 14:34:03.620 UTC [29] LOG: ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.621464769Z","logger":"postgres","msg":"2026-07-17 14:34:03.620 UTC [29] HINT: Future log output will go to log destination \"csvlog\".","source":"/controller/log/postgres","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.621328066Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.620 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:34:03.621647714Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.620 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"2","session_start_time":"2026-07-17 14:34:03 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:34:03.621665204Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.620 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"3","session_start_time":"2026-07-17 14:34:03 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:34:03.621675855Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.620 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"4","session_start_time":"2026-07-17 14:34:03 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:34:03.624907054Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.624 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"5","session_start_time":"2026-07-17 14:34:03 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:34:03.631649939Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.631 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:57 UTC","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:03.767037468Z","logger":"wal-restore","msg":"Refusing to restore future timeline history file","logging_pod":"keycloak-db-3","walName":"00000002.history","fileTimeline":2,"clusterTimeline":1} {"level":"info","ts":"2026-07-17T14:34:03.86964679Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.869 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"2","session_start_time":"2026-07-17 14:34:03 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"starting backup recovery with redo LSN 0/5000028, checkpoint LSN 0/5000080, on timeline ID 1","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:03.951498954Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.951 UTC","user_name":"postgres","database_name":"postgres","process_id":"60","connection_from":"[local]","session_id":"6a5a3d5b.3c","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:34:03.951807781Z","msg":"Instance is still down, will retry in 1 second","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8eb06551-2fc1-45b9-a59b-63f724b5e22d","instance":"keycloak-db-3","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:03.969552297Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.969 UTC","user_name":"postgres","database_name":"postgres","process_id":"61","connection_from":"[local]","session_id":"6a5a3d5b.3d","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:34:03.982722951Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:03.982 UTC","user_name":"postgres","database_name":"postgres","process_id":"62","connection_from":"[local]","session_id":"6a5a3d5b.3e","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:34:04.00993978Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.009 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"3","session_start_time":"2026-07-17 14:34:03 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:34:04.015803705Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.015 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"4","session_start_time":"2026-07-17 14:34:03 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"redo starts at 0/5000028","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:04.036490203Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.036 UTC","user_name":"postgres","database_name":"postgres","process_id":"74","connection_from":"[local]","session_id":"6a5a3d5c.4a","session_line_num":"1","session_start_time":"2026-07-17 14:34:04 UTC","transaction_id":"0","error_severity":"FATAL","sql_state_code":"57P03","message":"the database system is not yet accepting connections","detail":"Consistent recovery state has not been yet reached.","backend_type":"client backend","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:04.157346004Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.157 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"5","session_start_time":"2026-07-17 14:34:03 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"completed backup recovery with redo LSN 0/5000028 and end LSN 0/5000120","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:04.157436956Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.157 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"6","session_start_time":"2026-07-17 14:34:03 UTC","virtual_transaction_id":"193/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"consistent recovery state reached at 0/5000120","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:04.157458297Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.157 UTC","process_id":"29","session_id":"6a5a3d5b.1d","session_line_num":"6","session_start_time":"2026-07-17 14:34:03 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:34:04.314707403Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:34:04.314 UTC","process_id":"88","session_id":"6a5a3d5c.58","session_line_num":"1","session_start_time":"2026-07-17 14:34:04 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"started streaming WAL from primary at 0/6000000 on timeline 1","backend_type":"walreceiver","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:34:13.534327552Z","logger":"database_reconciler","msg":"Reconciling database","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9e758ebe-1312-4189-956d-6be2786010d3","databaseName":"keycloak","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:13.534378034Z","logger":"database_reconciler","msg":"Reconciliation loop of database exited","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9e758ebe-1312-4189-956d-6be2786010d3","databaseName":"keycloak","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:13.544078352Z","logger":"database_reconciler","msg":"Reconciling database","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"bda221ff-1716-4cce-8dff-d7208bc9b95a","databaseName":"keycloak","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:34:13.544117013Z","logger":"database_reconciler","msg":"Reconciliation loop of database exited","logger":"instance-manager","logging_pod":"keycloak-db-3","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"bda221ff-1716-4cce-8dff-d7208bc9b95a","databaseName":"keycloak","logging_pod":"keycloak-db-3"} {"level":"info","ts":"2026-07-17T14:38:21.786774099Z","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-3"} {"level":"info","ts":"2026-07-17T14:41:33.854008111Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:41:33.853 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"1","session_start_time":"2026-07-17 14:34:03 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:44:23.348559354Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:44:23.348 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"2","session_start_time":"2026-07-17 14:34:03 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.428 s, sync=0.058 s, total=169.495 s; sync files=758, longest=0.002 s, average=0.001 s; distance=26737 kB, estimate=26737 kB; lsn=0/7000098, redo lsn=0/6A1C458","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:44:23.348618465Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:44:23.348 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"3","session_start_time":"2026-07-17 14:34:03 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:46:33.443157948Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:46:33.442 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"4","session_start_time":"2026-07-17 14:34:03 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:46:33.455523782Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:46:33.455 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"5","session_start_time":"2026-07-17 14:34:03 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.013 s; sync files=0, longest=0.000 s, average=0.000 s; distance=6039 kB, estimate=24667 kB; lsn=0/8000060, redo lsn=0/7002418","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T14:46:33.455558543Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 14:46:33.455 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"6","session_start_time":"2026-07-17 14:34:03 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-17T15:06:01.787411621Z","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-3"} {"level":"info","ts":"2026-07-17T15:06:11.788573239Z","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-3"} {"level":"info","ts":"2026-07-17T15:06:21.786833346Z","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-3"} {"level":"info","ts":"2026-07-17T15:06:41.78740223Z","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-3"} {"level":"info","ts":"2026-07-17T15:06:51.786072326Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:01.790104255Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:11.78546575Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:21.7878945Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:31.786705129Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:41.787071698Z","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-3"} {"level":"info","ts":"2026-07-17T15:07:46.611499914Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:07:46.611 UTC","process_id":"88","session_id":"6a5a3d5c.58","session_line_num":"2","session_start_time":"2026-07-17 14:34:04 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.744105847Z","logger":"wal-restore","msg":"Refusing to restore future timeline history file","logging_pod":"keycloak-db-3","walName":"00000002.history","fileTimeline":2,"clusterTimeline":1} {"level":"info","ts":"2026-07-17T15:07:46.98890726Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:07:46.988 UTC","process_id":"36","session_id":"6a5a3d5b.24","session_line_num":"7","session_start_time":"2026-07-17 14:34:03 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.002198567Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:07:47.001 UTC","process_id":"745","session_id":"6a5a4542.2e9","session_line_num":"1","session_start_time":"2026-07-17 15:07:46 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:04.708944201Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:09:04.708 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"7","session_start_time":"2026-07-17 14:34:03 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:05.627312847Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:09:05.626 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"8","session_start_time":"2026-07-17 14:34:03 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.904 s, sync=0.006 s, total=0.919 s; sync files=10, longest=0.003 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:05.627374938Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:09:05.626 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"9","session_start_time":"2026-07-17 14:34:03 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:04.733188275Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:14:04.726 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"10","session_start_time":"2026-07-17 14:34:03 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:05.108646826Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:14:05.108 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"11","session_start_time":"2026-07-17 14:34:03 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.003 s, total=0.382 s; sync files=3, longest=0.002 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:05.108954903Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:14:05.108 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"12","session_start_time":"2026-07-17 14:34:03 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:19:04.208615469Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:19:04.208 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"13","session_start_time":"2026-07-17 14:34:03 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:11.785575402Z","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-3"} {"level":"info","ts":"2026-07-17T15:19:12.201551795Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:19:12.201 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"14","session_start_time":"2026-07-17 14:34:03 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.994 s, sync=0.493 s, total=7.993 s; sync files=5, longest=0.218 s, average=0.099 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:12.201619816Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-3","record":{"log_time":"2026-07-17 15:19:12.201 UTC","process_id":"34","session_id":"6a5a3d5b.22","session_line_num":"15","session_start_time":"2026-07-17 14:34:03 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"}}