{"level":"info","ts":"2026-07-17T14:33:16.674659187Z","msg":"OS distribution is supported","logger":"instance-manager","logging_pod":"keycloak-db-1","entry":{"version":"13 (trixie)","deprecatedFrom":"2028-08-09T00:00:00Z","supportedUntil":"2030-06-30T00:00:00Z"}}
{"level":"info","ts":"2026-07-17T14:33:16.67481973Z","msg":"Starting CloudNativePG Instance Manager","logger":"instance-manager","logging_pod":"keycloak-db-1","version":"1.28.4","build":{"Version":"1.28.4","Commit":"f74344b4d","Date":"2026-06-29"},"skipNameValidation":false}
{"level":"info","ts":"2026-07-17T14:33:17.01018479Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.010263482Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.010284823Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.010836156Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.01135493Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.01137318Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Publication"}
{"level":"info","ts":"2026-07-17T14:33:17.011542874Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.011591655Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.011598605Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":"localhost:8010","hasTLS":false}
{"level":"info","ts":"2026-07-17T14:33:17.011651037Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Subscription"}
{"level":"info","ts":"2026-07-17T14:33:17.011464852Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","source":"kind source: *v1.Database"}
{"level":"info","ts":"2026-07-17T14:33:17.01180626Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":8000","hasTLS":true}
{"level":"info","ts":"2026-07-17T14:33:17.010968959Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.011611656Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.011955374Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.011753959Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":9187","hasTLS":false}
{"level":"info","ts":"2026-07-17T14:33:17.012512578Z","msg":"Starting EventSource","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","source":"kind source: *v1.Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.015296926Z","msg":"Installed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"pg_ident.conf"}
{"level":"info","ts":"2026-07-17T14:33:17.212419473Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.212545506Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.213413018Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication"}
{"level":"info","ts":"2026-07-17T14:33:17.213445018Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-publication","controllerGroup":"postgresql.cnpg.io","controllerKind":"Publication","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.213462549Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.213477199Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-external-server","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.213473139Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database"}
{"level":"info","ts":"2026-07-17T14:33:17.21352213Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.213533611Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription"}
{"level":"info","ts":"2026-07-17T14:33:17.213540531Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-subscription","controllerGroup":"postgresql.cnpg.io","controllerKind":"Subscription","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.213617163Z","msg":"Starting Controller","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster"}
{"level":"info","ts":"2026-07-17T14:33:17.213684134Z","msg":"Starting workers","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-tablespaces","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","worker count":1}
{"level":"info","ts":"2026-07-17T14:33:17.229234045Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T14:33:17.231601633Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T14:33:17.238084942Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T14:33:17.240533863Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T14:33:17.245359331Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T14:33:17.251370428Z","msg":"Refreshed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T14:33:17.25629727Z","msg":"Installed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"pg_hba.conf"}
{"level":"info","ts":"2026-07-17T14:33:17.256471674Z","msg":"Detected running images","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","runningImages":["harbor.atmosphere.dev/ghcr.io/cloudnative-pg/postgresql:18.4-202606221003-minimal-trixie@sha256:538f1b327b8dc7621a94aac79c9c3e5c50dfa29115a6c291e19372a5b876f415"]}
{"level":"info","ts":"2026-07-17T14:33:17.264552812Z","msg":"Installed configuration file","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"custom.conf"}
{"level":"info","ts":"2026-07-17T14:33:17.264978983Z","msg":"Cluster status","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1","isReplicaCluster":false}
{"level":"info","ts":"2026-07-17T14:33:17.265033974Z","msg":"First primary instance bootstrap, marking myself as primary","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.303961349Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-1","reason":"postmaster start up"}
{"level":"info","ts":"2026-07-17T14:33:17.306004419Z","logger":"pg_controldata","msg":"pg_control version number:            1800\nCatalog version number:               202506291\nDatabase system identifier:           7663504941808078876\nDatabase cluster state:               shut down\npg_control last modified:             Fri Jul 17 14:33:09 2026\nLatest checkpoint location:           0/2000028\nLatest checkpoint's REDO location:    0/2000028\nLatest checkpoint's REDO WAL file:    000000010000000000000002\nLatest checkpoint's TimeLineID:       1\nLatest checkpoint's PrevTimeLineID:   1\nLatest checkpoint's full_page_writes: on\nLatest checkpoint's NextXID:          0:754\nLatest checkpoint's NextOID:          16386\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:  0\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:09 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-1"}
{"level":"info","ts":"2026-07-17T14:33:17.306812269Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-1","postMasterPID":29}
{"level":"info","ts":"2026-07-17T14:33:17.307149937Z","msg":"DB not available, will retry","logger":"instance-manager","logging_pod":"keycloak-db-1","err":"failed to connect to `user=postgres database=postgres`: /controller/run/.s.PGSQL.5432 (/controller/run): dial error: dial unix /controller/run/.s.PGSQL.5432: connect: no such file or directory"}
{"level":"info","ts":"2026-07-17T14:33:17.3198594Z","msg":"Instance is still down, will retry in 1 second","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"8f0ad3b1-1390-42ca-b7b5-4a54cae2740b","instance":"keycloak-db-1","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.33581832Z","logger":"postgres","msg":"2026-07-17 14:33:17.335 UTC [29] LOG:  redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.335878662Z","logger":"postgres","msg":"2026-07-17 14:33:17.335 UTC [29] HINT:  Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.336331944Z","logger":"postgres","msg":"2026-07-17 14:33:17.335 UTC [29] LOG:  ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.336349334Z","logger":"postgres","msg":"2026-07-17 14:33:17.335 UTC [29] HINT:  Future log output will go to log destination \"csvlog\".","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:17.336356574Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.335 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"1","session_start_time":"2026-07-17 14:33:17 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:17.336528889Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.335 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"2","session_start_time":"2026-07-17 14:33:17 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:17.336540919Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.336 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"3","session_start_time":"2026-07-17 14:33:17 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:17.336550629Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.336 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"4","session_start_time":"2026-07-17 14:33:17 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:17.340208089Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.340 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"5","session_start_time":"2026-07-17 14:33:17 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:17.346410171Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.346 UTC","process_id":"37","session_id":"6a5a3d2d.25","session_line_num":"1","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system was shut down at 2026-07-17 14:33:09 UTC","backend_type":"startup","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:17.352601123Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:17.351 UTC","process_id":"29","session_id":"6a5a3d2d.1d","session_line_num":"6","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system is ready to accept connections","backend_type":"postmaster","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:17.403172213Z","msg":"Triggered a managed role reconciliation","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"52f66b13-b8ad-4c30-bbc3-05f0aebe30cd","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T14:33:17.585155141Z","msg":"Triggered a managed role reconciliation","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-cluster","controllerGroup":"postgresql.cnpg.io","controllerKind":"Cluster","Cluster":{"name":"keycloak-db","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak-db","reconcileID":"ce329630-d0df-4673-9bfe-d2e9c933cbd7","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T14:33:31.883126925Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:31.882 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"1","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: force wait","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:34.00567029Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:34.005 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"2","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 21 buffers (0.1%), wrote 3 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=2.109 s, sync=0.006 s, total=2.123 s; sync files=21, longest=0.002 s, average=0.001 s; distance=16384 kB, estimate=16384 kB; lsn=0/30000B8, redo lsn=0/3000028","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:57.041269912Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:57.041 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"3","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: force wait","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:57.13801364Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:57.137 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"4","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint 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.097 s; sync files=0, longest=0.000 s, average=0.000 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:34:13.53382163Z","logger":"database_reconciler","msg":"Reconciling database","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9dbd3af3-7d59-4bec-b5c0-5173a3f6331f","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:34:13.634503045Z","logger":"database_reconciler","msg":"Reconciliation loop of database exited","logger":"instance-manager","logging_pod":"keycloak-db-1","controller":"instance-database","controllerGroup":"postgresql.cnpg.io","controllerKind":"Database","Database":{"name":"keycloak","namespace":"auth-system"},"namespace":"auth-system","name":"keycloak","reconcileID":"9dbd3af3-7d59-4bec-b5c0-5173a3f6331f","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:34:41.279665747Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:34:41.278 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"761","connection_from":"10.0.0.124:56322","session_id":"6a5a3d80.2f9","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 14:34:40 UTC","virtual_transaction_id":"78/24","transaction_id":"0","error_severity":"ERROR","sql_state_code":"42P01","message":"relation \"migration_model\" does not exist","query":"SELECT ID, VERSION FROM MIGRATION_MODEL ORDER BY UPDATE_TIME DESC","query_pos":"25","application_name":"PostgreSQL JDBC Driver","backend_type":"client backend","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:34:42.221091935Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:34:42.220 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"762","connection_from":"10.0.0.124:56338","session_id":"6a5a3d82.2fa","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 14:34:42 UTC","virtual_transaction_id":"79/18","transaction_id":"0","error_severity":"ERROR","sql_state_code":"42P01","message":"relation \"public.databasechangeloglock\" does not exist","query":"SELECT COUNT(*) FROM public.databasechangeloglock","query_pos":"22","application_name":"PostgreSQL JDBC Driver","backend_type":"client backend","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:38:57.272613372Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:38:57.272 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"5","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: time","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:41:26.372285583Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:41:26.371 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"6","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 1503 buffers (9.2%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=149.018 s, sync=0.066 s, total=149.100 s; sync files=876, 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:57.472591113Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:43:57.472 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"7","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: time","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:43:57.845735214Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:43:57.843 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"8","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 2 buffers (0.0%), wrote 0 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.268 s, sync=0.001 s, total=0.372 s; sync files=1, longest=0.001 s, average=0.001 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-17T15:05:55.47426817Z","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-1"}
{"level":"info","ts":"2026-07-17T15:06:25.474435834Z","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-1"}
{"level":"info","ts":"2026-07-17T15:06:45.474661758Z","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-1"}
{"level":"info","ts":"2026-07-17T15:06:55.475611581Z","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-1"}
{"level":"info","ts":"2026-07-17T15:07:05.474561415Z","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-1"}
{"level":"info","ts":"2026-07-17T15:07:15.476990004Z","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-1"}
{"level":"info","ts":"2026-07-17T15:07:25.475315302Z","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-1"}
{"level":"info","ts":"2026-07-17T15:07:35.474650705Z","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-1"}
{"level":"info","ts":"2026-07-17T15:07:44.098332725Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:07:44.098 UTC","user_name":"streaming_replica","process_id":"350","connection_from":"10.0.0.77:53290","session_id":"6a5a3d46.15e","session_line_num":"1","command_tag":"streaming 0/9001630","session_start_time":"2026-07-17 14:33:42 UTC","virtual_transaction_id":"181/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"terminating walsender process due to replication timeout","query":"START_REPLICATION SLOT \"_cnpg_keycloak_db_2\" 0/4000000 TIMELINE 1","application_name":"keycloak-db-2","backend_type":"walsender","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:07:44.232384753Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:07:44.230 UTC","user_name":"streaming_replica","process_id":"623","connection_from":"10.0.0.109:33192","session_id":"6a5a3d5c.26f","session_line_num":"1","command_tag":"streaming 0/9001630","session_start_time":"2026-07-17 14:34:04 UTC","virtual_transaction_id":"185/0","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"terminating walsender process due to replication timeout","query":"START_REPLICATION SLOT \"_cnpg_keycloak_db_3\" 0/6000000 TIMELINE 1","application_name":"keycloak-db-3","backend_type":"walsender","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:07:45.47528992Z","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-1"}
{"level":"info","ts":"2026-07-17T15:08:57.449329357Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:08:57.449 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"9","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: time","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:08:58.453450879Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:08:58.453 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"10","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 8 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.909 s, sync=0.080 s, total=1.005 s; sync files=9, longest=0.077 s, average=0.009 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:11:35.474897265Z","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-1"}
{"level":"info","ts":"2026-07-17T15:13:57.544047687Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:13:57.543 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"11","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: time","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:13:57.763373887Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:13:57.763 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"12","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 2 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.202 s, sync=0.003 s, total=0.220 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:17:45.475157492Z","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-1"}
{"level":"info","ts":"2026-07-17T15:18:57.920572261Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:18:57.920 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"13","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint starting: time","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:18:58.58222921Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:18:58.582 UTC","process_id":"35","session_id":"6a5a3d2d.23","session_line_num":"14","session_start_time":"2026-07-17 14:33:17 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 4 buffers (0.0%), wrote 1 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=0.528 s, sync=0.004 s, total=0.662 s; sync files=4, longest=0.002 s, average=0.001 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:05.474359809Z","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-1"}
{"level":"info","ts":"2026-07-17T15:19:55.475270974Z","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-1"}
{"level":"info","ts":"2026-07-17T15:20:25.475277306Z","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-1"}
{"level":"info","ts":"2026-07-17T15:20:35.474388145Z","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-1"}