{"level":"info","ts":"2026-07-17T16:03:12.563059742Z","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-17T16:03:12.563255835Z","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-17T16:03:12.907428855Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:12.907517386Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:12.907553947Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:12.908124318Z","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-17T16:03:12.908408853Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:12.908462584Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:12.908542686Z","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-17T16:03:12.908567976Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":"localhost:8010","hasTLS":false}
{"level":"info","ts":"2026-07-17T16:03:12.908954583Z","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-17T16:03:12.908980314Z","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-17T16:03:12.909004674Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":8000","hasTLS":true}
{"level":"info","ts":"2026-07-17T16:03:12.909076436Z","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-17T16:03:12.909210588Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":9187","hasTLS":false}
{"level":"info","ts":"2026-07-17T16:03:12.909355301Z","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-17T16:03:12.909414832Z","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-17T16:03:12.909654847Z","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-17T16:03:12.909721918Z","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-17T16:03:12.913082653Z","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-17T16:03:13.109832845Z","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-17T16:03:13.109888996Z","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-17T16:03:13.110009978Z","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-17T16:03:13.110058729Z","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-17T16:03:13.11011834Z","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-17T16:03:13.110133971Z","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-17T16:03:13.110366805Z","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-17T16:03:13.110374015Z","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-17T16:03:13.110699021Z","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-17T16:03:13.110743522Z","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-17T16:03:13.110805873Z","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-17T16:03:13.110874835Z","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-17T16:03:13.123231812Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T16:03:13.125310361Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T16:03:13.131846047Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T16:03:13.134129791Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T16:03:13.139545304Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T16:03:13.144365287Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T16:03:13.146810364Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"pg_hba.conf"}
{"level":"info","ts":"2026-07-17T16:03:13.146904866Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","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-17T16:03:13.153230957Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"custom.conf"}
{"level":"info","ts":"2026-07-17T16:03:13.153552593Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1","isReplicaCluster":false}
{"level":"info","ts":"2026-07-17T16:03:13.153576483Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.191748395Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-1","reason":"postmaster start up"}
{"level":"info","ts":"2026-07-17T16:03:13.194489198Z","logger":"pg_controldata","msg":"pg_control version number:            1800\nCatalog version number:               202506291\nDatabase system identifier:           7663528121255915547\nDatabase cluster state:               shut down\npg_control last modified:             Fri Jul 17 16:03:06 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 16:03:06 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:            9fb1a73145a3515263e1a655591b3447e0d5edfdda71b002c671cb68bb907e42\n","pipe":"stdout","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.195906526Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-1","postMasterPID":35}
{"level":"info","ts":"2026-07-17T16:03:13.196559208Z","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-17T16:03:13.213123586Z","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":"420da4cc-76cd-4d88-aa09-8e915a5c4816","instance":"keycloak-db-1","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.228820856Z","logger":"postgres","msg":"2026-07-17 16:03:13.228 UTC [35] LOG:  redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.228880427Z","logger":"postgres","msg":"2026-07-17 16:03:13.228 UTC [35] HINT:  Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.229558651Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.228 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"1","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.229746744Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.228 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"2","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.229760464Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.229 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"3","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.229770695Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.229 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"4","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.229990249Z","logger":"postgres","msg":"2026-07-17 16:03:13.228 UTC [35] LOG:  ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.230002239Z","logger":"postgres","msg":"2026-07-17 16:03:13.228 UTC [35] HINT:  Future log output will go to log destination \"csvlog\".","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:03:13.233347423Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.233 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"5","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.242140522Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.242 UTC","process_id":"43","session_id":"6a5a5241.2b","session_line_num":"1","session_start_time":"2026-07-17 16:03:13 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system was shut down at 2026-07-17 16:03:06 UTC","backend_type":"startup","query_id":"0"}}
{"level":"info","ts":"2026-07-17T16:03:13.248460583Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:13.248 UTC","process_id":"35","session_id":"6a5a5241.23","session_line_num":"6","session_start_time":"2026-07-17 16:03:13 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-17T16:03:13.307149958Z","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":"11c6c603-9f9a-4cbb-a5b7-1daece632ff9","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T16:03:13.474330554Z","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":"f5169b65-59c5-4e37-9b68-68536ec5cd10","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T16:03:29.817852631Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:29.817 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"1","session_start_time":"2026-07-17 16:03:13 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-17T16:03:31.985305728Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:31.984 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"2","session_start_time":"2026-07-17 16:03:13 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.111 s, sync=0.006 s, total=2.168 s; sync files=21, longest=0.002 s, average=0.001 s; distance=16384 kB, estimate=16384 kB; lsn=0/3000080, redo lsn=0/3000028","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T16:03:55.043777141Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:55.043 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"3","session_start_time":"2026-07-17 16:03:13 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-17T16:03:55.118620786Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:03:55.118 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"4","session_start_time":"2026-07-17 16:03:13 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.075 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-17T16:04:12.040481361Z","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":"6a73b8a2-176a-4e3d-8652-64bac6ae3fb0","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:04:12.140892316Z","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":"6a73b8a2-176a-4e3d-8652-64bac6ae3fb0","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T16:04:42.913993385Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:42.913 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"798","connection_from":"10.0.0.21:45568","session_id":"6a5a5299.31e","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 16:04:41 UTC","virtual_transaction_id":"10/28","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-17T16:04:43.940928533Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:43.940 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"799","connection_from":"10.0.0.21:59624","session_id":"6a5a529b.31f","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 16:04:43 UTC","virtual_transaction_id":"11/22","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-17T16:08:55.259311211Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:08:55.258 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"5","session_start_time":"2026-07-17 16:03:13 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-17T16:11:24.501224958Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:11:24.500 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"6","session_start_time":"2026-07-17 16:03:13 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 1504 buffers (9.2%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=149.147 s, sync=0.076 s, total=149.243 s; sync files=876, longest=0.003 s, average=0.001 s; distance=26815 kB, estimate=32172 kB; lsn=0/7000098, redo lsn=0/6A2FF08","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T16:13:55.600126257Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:13:55.599 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"7","session_start_time":"2026-07-17 16:03:13 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-17T16:13:55.896359315Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:13:55.896 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"8","session_start_time":"2026-07-17 16:03:13 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.232 s, sync=0.001 s, total=0.297 s; sync files=1, longest=0.001 s, average=0.001 s; distance=5961 kB, estimate=29551 kB; lsn=0/8000060, redo lsn=0/7002418","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T16:43:55.504829298Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:43:55.504 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"9","session_start_time":"2026-07-17 16:03:13 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-17T16:43:55.733097294Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:43:55.731 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"10","session_start_time":"2026-07-17 16:03:13 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.203 s, sync=0.002 s, total=0.228 s; sync files=3, longest=0.001 s, average=0.001 s; distance=32775 kB, estimate=32775 kB; lsn=0/90040B8, redo lsn=0/9004060","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T16:48:55.864892088Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:48:55.864 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"11","session_start_time":"2026-07-17 16:03:13 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-17T16:48:56.367838592Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:48:56.367 UTC","process_id":"41","session_id":"6a5a5241.29","session_line_num":"12","session_start_time":"2026-07-17 16:03:13 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.435 s, sync=0.004 s, total=0.504 s; sync files=4, longest=0.003 s, average=0.001 s; distance=16385 kB, estimate=31136 kB; lsn=0/B000060, redo lsn=0/A0044C0","backend_type":"checkpointer","query_id":"0"}}