{"level":"info","ts":"2026-07-17T16:04:02.283887312Z","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:04:02.284029916Z","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:04:02.629929284Z","msg":"starting tablespace manager","logger":"instance-manager","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.630005626Z","msg":"starting external server manager","logger":"instance-manager","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.630042497Z","msg":"starting controller-runtime manager","logger":"instance-manager","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.631120583Z","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:04:02.631128074Z","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:04:02.63220847Z","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:04:02.632916637Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":9187","hasTLS":false} {"level":"info","ts":"2026-07-17T16:04:02.632790064Z","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:04:02.633110542Z","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:04:02.632672641Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":"localhost:8010","hasTLS":false} {"level":"info","ts":"2026-07-17T16:04:02.633263226Z","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:04:02.633681596Z","msg":"Starting webserver","logger":"instance-manager","logging_pod":"keycloak-db-1","address":":8000","hasTLS":true} {"level":"info","ts":"2026-07-17T16:04:02.633725277Z","logger":"roles_reconciler","msg":"starting up the runnable","logger":"instance-manager","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.633789789Z","logger":"roles_reconciler","msg":"setting up RoleSynchronizer loop","logger":"instance-manager","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.633867061Z","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:04:02.634192199Z","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:04:02.634450885Z","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:04:02.637257433Z","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:04:02.834077647Z","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:04:02.834048756Z","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:04:02.834176689Z","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:04:02.834150348Z","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:04:02.836494476Z","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:04:02.836565687Z","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:04:02.836540697Z","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:04:02.836645769Z","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:04:02.83668766Z","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:04:02.83666263Z","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:04:02.836974837Z","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:04:02.837001018Z","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:04:02.848865218Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.crt","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T16:04:02.85099434Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server.key","secret":"keycloak-db-server"} {"level":"info","ts":"2026-07-17T16:04:02.85710159Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.crt","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T16:04:02.859224602Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/streaming_replica.key","secret":"keycloak-db-replication"} {"level":"info","ts":"2026-07-17T16:04:02.865113045Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/client-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T16:04:02.87101109Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","filename":"/controller/certificates/server-ca.crt","secret":"keycloak-db-ca"} {"level":"info","ts":"2026-07-17T16:04:02.873962752Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"pg_hba.conf"} {"level":"info","ts":"2026-07-17T16:04:02.874074184Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","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:04:02.879526628Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","pgdata":"/var/lib/postgresql/data/pgdata","filename":"custom.conf"} {"level":"info","ts":"2026-07-17T16:04:02.879931728Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1","isReplicaCluster":false} {"level":"info","ts":"2026-07-17T16:04:02.879958449Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","logging_pod":"keycloak-db-1","currentPrimary":"","targetPrimary":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.921296449Z","msg":"Extracting pg_controldata information","logger":"instance-manager","logging_pod":"keycloak-db-1","reason":"postmaster start up"} {"level":"info","ts":"2026-07-17T16:04:02.922819727Z","logger":"pg_controldata","msg":"pg_control version number: 1800\nCatalog version number: 202506291\nDatabase system identifier: 7663528315128741914\nDatabase cluster state: shut down\npg_control last modified: Fri Jul 17 16:03:52 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:52 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: c02648db0f1362b74af03a3f8a5de60f3e25ae8120a0287a2c99a3a3099d3e5a\n","pipe":"stdout","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.923886093Z","msg":"postmaster started","logger":"instance-manager","logging_pod":"keycloak-db-1","postMasterPID":33} {"level":"info","ts":"2026-07-17T16:04:02.924256092Z","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:04:02.937243689Z","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":"5ef910a7-7de2-47e5-a95d-c98dcdb7c35c","instance":"keycloak-db-1","cluster":"keycloak-db","namespace":"auth-system","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.954133982Z","logger":"postgres","msg":"2026-07-17 16:04:02.953 UTC [33] LOG: redirecting log output to logging collector process","pipe":"stderr","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.954209604Z","logger":"postgres","msg":"2026-07-17 16:04:02.953 UTC [33] HINT: Future log output will appear in directory \"/controller/log\".","pipe":"stderr","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.95526678Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.954 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"1","session_start_time":"2026-07-17 16:04:02 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:04:02.955654029Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.954 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"2","session_start_time":"2026-07-17 16:04:02 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:04:02.95568487Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.954 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"3","session_start_time":"2026-07-17 16:04:02 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:04:02.955706441Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.954 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"4","session_start_time":"2026-07-17 16:04:02 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:04:02.955750322Z","logger":"postgres","msg":"2026-07-17 16:04:02.954 UTC [33] LOG: ending log output to stderr","source":"/controller/log/postgres","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:04:02.955765582Z","logger":"postgres","msg":"2026-07-17 16:04:02.954 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-17T16:04:02.958621052Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.958 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"5","session_start_time":"2026-07-17 16:04:02 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:04:02.965531641Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.965 UTC","process_id":"41","session_id":"6a5a5272.29","session_line_num":"1","session_start_time":"2026-07-17 16:04:02 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"database system was shut down at 2026-07-17 16:03:52 UTC","backend_type":"startup","query_id":"0"}} {"level":"info","ts":"2026-07-17T16:04:02.971969139Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:02.971 UTC","process_id":"33","session_id":"6a5a5272.21","session_line_num":"6","session_start_time":"2026-07-17 16:04:02 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:04:03.026987534Z","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":"c8daf85c-5df3-4e06-982b-f88993067581","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]} {"level":"info","ts":"2026-07-17T16:04:03.195139176Z","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":"34368e3e-dd40-43ea-adba-3b64a58b9e82","logging_pod":"keycloak-db-1","pending-roles":["keycloak"]} {"level":"info","ts":"2026-07-17T16:04:17.540501093Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:17.540 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"1","session_start_time":"2026-07-17 16:04:02 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:04:19.666610553Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:19.666 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"2","session_start_time":"2026-07-17 16:04:02 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.127 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-17T16:04:43.767879357Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:43.767 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"3","session_start_time":"2026-07-17 16:04:02 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:04:43.942973419Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:04:43.942 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"4","session_start_time":"2026-07-17 16:04:02 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.175 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:05:03.754020638Z","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":"8ad096ac-3825-4776-85ef-fdf595747ba9","databaseName":"keycloak","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:05:03.86311522Z","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":"8ad096ac-3825-4776-85ef-fdf595747ba9","databaseName":"keycloak","logging_pod":"keycloak-db-1"} {"level":"info","ts":"2026-07-17T16:05:35.23978967Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:05:35.239 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"785","connection_from":"10.0.0.215:33636","session_id":"6a5a52ce.311","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 16:05:34 UTC","virtual_transaction_id":"1/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-17T16:05:36.209834854Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:05:36.209 UTC","user_name":"keycloak","database_name":"keycloak","process_id":"786","connection_from":"10.0.0.215:56426","session_id":"6a5a52d0.312","session_line_num":"1","command_tag":"PARSE","session_start_time":"2026-07-17 16:05:36 UTC","virtual_transaction_id":"2/21","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:05:40.385143177Z","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-17T16:09:43.079633994Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:09:43.079 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"5","session_start_time":"2026-07-17 16:04:02 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:12:13.106302241Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:12:13.106 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"6","session_start_time":"2026-07-17 16:04:02 UTC","transaction_id":"0","error_severity":"LOG","sql_state_code":"00000","message":"checkpoint complete: wrote 1502 buffers (9.2%), wrote 2 SLRU buffers; 0 WAL file(s) added, 0 removed, 0 recycled; write=149.941 s, sync=0.069 s, total=150.027 s; sync files=876, longest=0.001 s, average=0.001 s; distance=26860 kB, estimate=32177 kB; lsn=0/7000098, redo lsn=0/6A3B2E8","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T16:14:43.180039621Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:14:43.179 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"7","session_start_time":"2026-07-17 16:04:02 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:14:43.452326303Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:14:43.452 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"8","session_start_time":"2026-07-17 16:04:02 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.203 s, sync=0.030 s, total=0.273 s; sync files=1, longest=0.030 s, average=0.030 s; distance=5916 kB, estimate=29551 kB; lsn=0/7002470, redo lsn=0/7002418","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T16:16:20.38484679Z","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-17T16:44:44.087223083Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:44:44.083 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"9","session_start_time":"2026-07-17 16:04:02 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:44:44.508031225Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:44:44.507 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"10","session_start_time":"2026-07-17 16:04:02 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.288 s, sync=0.002 s, total=0.425 s; sync files=3, longest=0.002 s, average=0.001 s; distance=16391 kB, estimate=28235 kB; lsn=0/9000060, redo lsn=0/8004098","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T16:49:44.608186725Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:49:44.607 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"11","session_start_time":"2026-07-17 16:04:02 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:49:45.136809778Z","logger":"postgres","msg":"record","logging_pod":"keycloak-db-1","record":{"log_time":"2026-07-17 16:49:45.136 UTC","process_id":"39","session_id":"6a5a5272.27","session_line_num":"12","session_start_time":"2026-07-17 16:04:02 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.451 s, sync=0.003 s, total=0.529 s; sync files=4, longest=0.002 s, average=0.001 s; distance=16385 kB, estimate=27050 kB; lsn=0/A000060, redo lsn=0/90045A8","backend_type":"checkpointer","query_id":"0"}} {"level":"info","ts":"2026-07-17T16:52:10.386044377Z","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-17T16:54:00.385720493Z","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"}