{"level":"info","ts":"2026-07-17T14:33:20.459427237Z","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:20.45955545Z","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:20.806703852Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:20.806780294Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:20.806806314Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:20.807378449Z","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:20.807543053Z","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:20.807629235Z","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:20.807747768Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:20.807767008Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:20.807812369Z","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:20.807878741Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":"localhost:8010","hasTLS":false}
{"level":"info","ts":"2026-07-17T14:33:20.808002784Z","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:20.808109387Z","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:20.808176468Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":8000","hasTLS":true}
{"level":"info","ts":"2026-07-17T14:33:20.808565168Z","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:20.808618029Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":9187","hasTLS":false}
{"level":"info","ts":"2026-07-17T14:33:20.808571868Z","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:20.809150232Z","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:20.812270688Z","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:21.009050606Z","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:21.009107498Z","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:21.00920686Z","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:21.009319763Z","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:21.009873766Z","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:21.009891006Z","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:21.009909927Z","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:21.009963978Z","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:21.01002099Z","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:21.01004117Z","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:21.01003649Z","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:21.010088341Z","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:21.021668894Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T14:33:21.023474909Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"}
{"level":"info","ts":"2026-07-17T14:33:21.027600119Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T14:33:21.029512566Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"}
{"level":"info","ts":"2026-07-17T14:33:21.035032151Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T14:33:21.039370786Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"}
{"level":"info","ts":"2026-07-17T14:33:21.041083829Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"pg_hba.conf"}
{"level":"info","ts":"2026-07-17T14:33:21.04115203Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","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:21.047559577Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"custom.conf"}
{"level":"info","ts":"2026-07-17T14:33:21.047853544Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1","isReplicaCluster":false}
{"level":"info","ts":"2026-07-17T14:33:21.047871054Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.086533819Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-1","reason":"postmaster start up"}
{"level":"info","ts":"2026-07-17T14:33:21.088570819Z","logger":"pg_controldata","msg":"pg_control version number:            1800\nCatalog version number:               202506291\nDatabase system identifier:           7663504958506807323\nDatabase cluster state:               shut down\npg_control last modified:             Fri Jul 17 14:33:13 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:13 2026\nFake LSN counter for unlogged rels:   0/3E8\nMinimum recovery ending location:     0/0\nMin recovery ending loc's timeline:   0\nBackup start location:                0/0\nBackup end location:                  0/0\nEnd-of-backup record required:        no\nwal_level setting:                    logical\nwal_log_hints setting:                on\nmax_connections setting:              100\nmax_worker_processes setting:         60\nmax_wal_senders setting:              10\nmax_prepared_xacts setting:           0\nmax_locks_per_xact setting:           64\ntrack_commit_timestamp setting:       off\nMaximum data alignment:               8\nDatabase block size:                  8192\nBlocks per segment of large relation: 131072\nWAL block size:                       8192\nBytes per WAL segment:                16777216\nMaximum length of identifiers:        64\nMaximum columns in an index:          32\nMaximum size of a TOAST chunk:        1996\nSize of a large-object chunk:         2048\nDate/time type storage:               64-bit integers\nFloat8 argument passing:              by value\nData page checksum version:           1\nDefault char data signedness:         signed\nMock authentication nonce:            4075f513ded4a1d1f01107ddadfe56a0addf958bfced3510f2a517c2ede49ea0\n","pipe":"stdout","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.089954082Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-1","postMasterPID":33}
{"level":"info","ts":"2026-07-17T14:33:21.090331832Z","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:21.098785849Z","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":"cfa1ee7a-d2e8-4b07-be65-7be5499b34b7","instance":"keycloak-db-1","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.136970241Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.135 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"1","session_start_time":"2026-07-17 14:33:21 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:21.137239567Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.135 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"2","session_start_time":"2026-07-17 14:33:21 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:21.137260008Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.135 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"3","session_start_time":"2026-07-17 14:33:21 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:21.137275028Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.135 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"4","session_start_time":"2026-07-17 14:33:21 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:21.137480683Z","logger":"postgres","msg":"2026-07-17 14:33:21.135 UTC [33] LOG:  ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.137505484Z","logger":"postgres","msg":"2026-07-17 14:33:21.135 UTC [33] 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:21.148158644Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.141 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"5","session_start_time":"2026-07-17 14:33:21 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:21.148278117Z","logger":"postgres","msg":"2026-07-17 14:33:21.135 UTC [33] LOG:  redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.148313138Z","logger":"postgres","msg":"2026-07-17 14:33:21.135 UTC [33] HINT:  Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:33:21.155296209Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.155 UTC","process_id":"40","session_id":"6a5a3d31.28","session_line_num":"1","session_start_time":"2026-07-17 14:33:21 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system was shut down at 2026-07-17 14:33:13 UTC","backend_type":"startup","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:33:21.160141528Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:21.159 UTC","process_id":"33","session_id":"6a5a3d31.21","session_line_num":"6","session_start_time":"2026-07-17 14:33:21 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:21.216591097Z","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":"96c2db00-b274-467b-ba02-4987de1af91c","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T14:33:21.380822729Z","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":"1d79328a-1515-4d64-8dd8-dfaa5c8635cf","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]}
{"level":"info","ts":"2026-07-17T14:33:35.68609176Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:35.685 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"1","session_start_time":"2026-07-17 14:33:21 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:37.809831811Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:37.809 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"2","session_start_time":"2026-07-17 14:33:21 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.124 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:58.861756862Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:58.861 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"3","session_start_time":"2026-07-17 14:33:21 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:58.943019435Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:33:58.942 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"4","session_start_time":"2026-07-17 14:33:21 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.082 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:15.013130034Z","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":"9eb1ce34-f97c-4565-8d81-69bff6703fc9","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:34:15.109026819Z","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":"9eb1ce34-f97c-4565-8d81-69bff6703fc9","databaseName":"keycloak","logging_pod":"keycloak-db-1"}
{"level":"info","ts":"2026-07-17T14:34:44.019167715Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:34:44.018 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"741","connection_from":"10.0.0.16:47966","session_id":"6a5a3d82.2e5","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 14:34:42 UTC","virtual_transaction_id":"57/26","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:45.065971382Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:34:45.065 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"742","connection_from":"10.0.0.16:47980","session_id":"6a5a3d85.2e6","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 14:34:45 UTC","virtual_transaction_id":"58/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:58.076850405Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:38:58.076 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"5","session_start_time":"2026-07-17 14:33:21 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:28.539298759Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 14:41:28.539 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"6","session_start_time":"2026-07-17 14:33:21 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 1507 buffers (9.2%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=150.379 s, sync=0.061 s, total=150.463 s; sync files=881, longest=0.001 s, average=0.001 s; distance=26768 kB, estimate=32168 kB; lsn=0/7000098, redo lsn=0/6A240E0","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T14:50:19.215454852Z","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:05:59.214564495Z","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:19.214975021Z","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:49.214315354Z","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:59.217193839Z","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:09.215602402Z","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:19.221482Z","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:29.215157217Z","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:39.215647012Z","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:09.214638852Z","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:29.215062328Z","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:59.279676195Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:13:59.279 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"7","session_start_time":"2026-07-17 14:33:21 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:59.841041016Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 15:13:59.840 UTC","process_id":"38","session_id":"6a5a3d31.26","session_line_num":"8","session_start_time":"2026-07-17 14:33:21 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.457 s, sync=0.004 s, total=0.562 s; sync files=4, longest=0.002 s, average=0.001 s; distance=22403 kB, estimate=31191 kB; lsn=0/9000060, redo lsn=0/8004E88","backend_type":"checkpointer","query_id":"0"}}
{"level":"info","ts":"2026-07-17T15:16:39.214740822Z","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:23:19.214778071Z","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:24:09.214573388Z","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"}