{"level":"warn","ts":"2026-05-16T01:47:28.73947Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-16T01:47:28.739578Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-16T01:47:28.739654Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-16T01:47:28.739695Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-16T01:47:28.73972Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-16T01:47:28.740521Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-05-16T01:47:28.740645Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-16T01:47:28.745059Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.111447ms"} {"level":"info","ts":"2026-05-16T01:47:28.750334Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-05-16T01:47:28.750422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-05-16T01:47:28.750476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-05-16T01:47:28.750489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-16T01:47:28.750508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-05-16T01:47:28.750572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-05-16T01:47:28.757181Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-16T01:47:28.758526Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-16T01:47:28.759429Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-16T01:47:28.761359Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-16T01:47:28.761957Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-16T01:47:28.762493Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-16T01:47:28.762602Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-16T01:47:28.762631Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-16T01:47:28.763195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-05-16T01:47:28.763974Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-16T01:47:28.766122Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-16T01:47:28.766604Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-16T01:47:28.766689Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-16T01:47:28.766365Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-16T01:47:28.767085Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-16T01:47:29.051473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-05-16T01:47:29.051534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-16T01:47:29.051563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-05-16T01:47:29.051662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-05-16T01:47:29.051675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-16T01:47:29.051685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-05-16T01:47:29.051728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-16T01:47:29.052663Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:47:29.054027Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-05-16T01:47:29.054398Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:47:29.054536Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:47:29.054572Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-16T01:47:29.054593Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-16T01:47:29.054851Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-16T01:47:29.054969Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-16T01:47:29.054996Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-16T01:47:29.057948Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-16T01:47:29.058786Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-05-16T01:48:06.178603Z","caller":"traceutil/trace.go:171","msg":"trace[808307036] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"163.907659ms","start":"2026-05-16T01:48:06.014664Z","end":"2026-05-16T01:48:06.178571Z","steps":["trace[808307036] 'process raft request' (duration: 163.167489ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:48:06.453728Z","caller":"traceutil/trace.go:171","msg":"trace[942920989] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"181.955505ms","start":"2026-05-16T01:48:06.271722Z","end":"2026-05-16T01:48:06.453677Z","steps":["trace[942920989] 'process raft request' (duration: 156.967205ms)","trace[942920989] 'compare' (duration: 24.866525ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:48:06.739614Z","caller":"traceutil/trace.go:171","msg":"trace[527312031] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"168.056207ms","start":"2026-05-16T01:48:06.571526Z","end":"2026-05-16T01:48:06.739582Z","steps":["trace[527312031] 'read index received' (duration: 166.103817ms)","trace[527312031] 'applied index is now lower than readState.Index' (duration: 1.95138ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:48:06.739655Z","caller":"traceutil/trace.go:171","msg":"trace[1292067340] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"186.686638ms","start":"2026-05-16T01:48:06.552944Z","end":"2026-05-16T01:48:06.739631Z","steps":["trace[1292067340] 'process raft request' (duration: 184.692197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:48:06.73976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.192023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-16T01:48:06.740046Z","caller":"traceutil/trace.go:171","msg":"trace[118017307] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"168.550387ms","start":"2026-05-16T01:48:06.571476Z","end":"2026-05-16T01:48:06.740026Z","steps":["trace[118017307] 'agreement among raft nodes before linearized reading' (duration: 168.201953ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:48:06.913136Z","caller":"traceutil/trace.go:171","msg":"trace[2126226353] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"173.309433ms","start":"2026-05-16T01:48:06.739803Z","end":"2026-05-16T01:48:06.913112Z","steps":["trace[2126226353] 'read index received' (duration: 171.655375ms)","trace[2126226353] 'applied index is now lower than readState.Index' (duration: 1.652928ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:48:06.91338Z","caller":"traceutil/trace.go:171","msg":"trace[1293746974] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"263.740972ms","start":"2026-05-16T01:48:06.649626Z","end":"2026-05-16T01:48:06.913367Z","steps":["trace[1293746974] 'process raft request' (duration: 262.121666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:48:06.913719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.121323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-16T01:48:06.913735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.278261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-16T01:48:06.913778Z","caller":"traceutil/trace.go:171","msg":"trace[1938566004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:579; }","duration":"172.232718ms","start":"2026-05-16T01:48:06.74153Z","end":"2026-05-16T01:48:06.913762Z","steps":["trace[1938566004] 'agreement among raft nodes before linearized reading' (duration: 172.131384ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:48:06.913784Z","caller":"traceutil/trace.go:171","msg":"trace[389135386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:579; }","duration":"174.331723ms","start":"2026-05-16T01:48:06.739439Z","end":"2026-05-16T01:48:06.91377Z","steps":["trace[389135386] 'agreement among raft nodes before linearized reading' (duration: 174.236619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:48:53.459706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.850847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-16T01:48:53.459777Z","caller":"traceutil/trace.go:171","msg":"trace[757003674] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1148; }","duration":"102.975099ms","start":"2026-05-16T01:48:53.356787Z","end":"2026-05-16T01:48:53.459762Z","steps":["trace[757003674] 'count revisions from in-memory index tree' (duration: 102.662465ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.241403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.758536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-16T01:49:41.241558Z","caller":"traceutil/trace.go:171","msg":"trace[356276256] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"428.583008ms","start":"2026-05-16T01:49:40.812947Z","end":"2026-05-16T01:49:41.24153Z","steps":["trace[356276256] 'process raft request' (duration: 271.903059ms)","trace[356276256] 'compare' (duration: 155.301774ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:49:41.241665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.812925Z","time spent":"428.689751ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-16T01:49:41.590972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.681317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-16T01:49:41.591411Z","caller":"traceutil/trace.go:171","msg":"trace[1779702656] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"777.940844ms","start":"2026-05-16T01:49:40.813432Z","end":"2026-05-16T01:49:41.591373Z","steps":["trace[1779702656] 'process raft request' (duration: 542.727513ms)","trace[1779702656] 'compare' (duration: 234.3993ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:49:41.591684Z","caller":"traceutil/trace.go:171","msg":"trace[77364601] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"778.110879ms","start":"2026-05-16T01:49:40.813555Z","end":"2026-05-16T01:49:41.591666Z","steps":["trace[77364601] 'process raft request' (duration: 777.77944ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:49:41.591716Z","caller":"traceutil/trace.go:171","msg":"trace[475504628] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"776.452686ms","start":"2026-05-16T01:49:40.815244Z","end":"2026-05-16T01:49:41.591697Z","steps":["trace[475504628] 'process raft request' (duration: 776.2129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.591786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.813542Z","time spent":"778.19766ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-16T01:49:41.591953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.815235Z","time spent":"776.533378ms","remote":"127.0.0.1:56432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-16T01:49:41.592014Z","caller":"traceutil/trace.go:171","msg":"trace[330513458] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1904; }","duration":"745.885669ms","start":"2026-05-16T01:49:40.846071Z","end":"2026-05-16T01:49:41.591957Z","steps":["trace[330513458] 'read index received' (duration: 238.794015ms)","trace[330513458] 'applied index is now lower than readState.Index' (duration: 507.088544ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:49:41.592146Z","caller":"traceutil/trace.go:171","msg":"trace[580750624] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"774.679632ms","start":"2026-05-16T01:49:40.817381Z","end":"2026-05-16T01:49:41.592061Z","steps":["trace[580750624] 'process raft request' (duration: 774.183408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.592228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.141265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-16T01:49:41.592365Z","caller":"traceutil/trace.go:171","msg":"trace[1860331261] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1831; }","duration":"746.361871ms","start":"2026-05-16T01:49:40.845983Z","end":"2026-05-16T01:49:41.592345Z","steps":["trace[1860331261] 'agreement among raft nodes before linearized reading' (duration: 746.160126ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.592509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.845955Z","time spent":"746.539026ms","remote":"127.0.0.1:56574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":4,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-05-16T01:49:41.592526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.817365Z","time spent":"774.924077ms","remote":"127.0.0.1:56460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-16T01:49:41.592728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.286031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-16T01:49:41.591907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:40.8134Z","time spent":"778.103638ms","remote":"127.0.0.1:56528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-16T01:49:41.592767Z","caller":"traceutil/trace.go:171","msg":"trace[573741866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1831; }","duration":"208.368133ms","start":"2026-05-16T01:49:41.384388Z","end":"2026-05-16T01:49:41.592756Z","steps":["trace[573741866] 'agreement among raft nodes before linearized reading' (duration: 208.280171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.59257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.706606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-16T01:49:41.593047Z","caller":"traceutil/trace.go:171","msg":"trace[144334719] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1831; }","duration":"208.231899ms","start":"2026-05-16T01:49:41.384794Z","end":"2026-05-16T01:49:41.593026Z","steps":["trace[144334719] 'agreement among raft nodes before linearized reading' (duration: 207.594523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.592635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.102177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-16T01:49:41.593231Z","caller":"traceutil/trace.go:171","msg":"trace[1824583112] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1831; }","duration":"547.114363ms","start":"2026-05-16T01:49:41.046107Z","end":"2026-05-16T01:49:41.593221Z","steps":["trace[1824583112] 'agreement among raft nodes before linearized reading' (duration: 546.315573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.593273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:41.046086Z","time spent":"547.168344ms","remote":"127.0.0.1:56344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":226,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-16T01:49:41.592376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.722835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-16T01:49:41.593422Z","caller":"traceutil/trace.go:171","msg":"trace[606938720] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1831; }","duration":"579.843673ms","start":"2026-05-16T01:49:41.013568Z","end":"2026-05-16T01:49:41.593411Z","steps":["trace[606938720] 'agreement among raft nodes before linearized reading' (duration: 578.608242ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.593465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:41.013542Z","time spent":"579.903245ms","remote":"127.0.0.1:57840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-16T01:49:41.59371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.004771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-16T01:49:41.593764Z","caller":"traceutil/trace.go:171","msg":"trace[1637944898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1831; }","duration":"410.107524ms","start":"2026-05-16T01:49:41.183643Z","end":"2026-05-16T01:49:41.593751Z","steps":["trace[1637944898] 'agreement among raft nodes before linearized reading' (duration: 408.774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:49:41.595332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:49:41.183614Z","time spent":"411.679275ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-16T01:49:41.753593Z","caller":"traceutil/trace.go:171","msg":"trace[648467081] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"154.283708ms","start":"2026-05-16T01:49:41.599275Z","end":"2026-05-16T01:49:41.753559Z","steps":["trace[648467081] 'process raft request' (duration: 154.027942ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:49:41.753708Z","caller":"traceutil/trace.go:171","msg":"trace[1994496436] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"155.410467ms","start":"2026-05-16T01:49:41.598264Z","end":"2026-05-16T01:49:41.753674Z","steps":["trace[1994496436] 'process raft request' (duration: 92.970016ms)","trace[1994496436] 'compare' (duration: 61.912108ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:49:56.838716Z","caller":"traceutil/trace.go:171","msg":"trace[1491144083] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"233.648112ms","start":"2026-05-16T01:49:56.60504Z","end":"2026-05-16T01:49:56.838688Z","steps":["trace[1491144083] 'process raft request' (duration: 233.454507ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:50:20.203153Z","caller":"traceutil/trace.go:171","msg":"trace[759861067] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"112.589067ms","start":"2026-05-16T01:50:20.090519Z","end":"2026-05-16T01:50:20.203108Z","steps":["trace[759861067] 'process raft request' (duration: 35.175293ms)","trace[759861067] 'compare' (duration: 77.207678ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:50:20.553209Z","caller":"traceutil/trace.go:171","msg":"trace[2111547772] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"144.006451ms","start":"2026-05-16T01:50:20.409172Z","end":"2026-05-16T01:50:20.553179Z","steps":["trace[2111547772] 'process raft request' (duration: 142.871596ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:50:21.308602Z","caller":"traceutil/trace.go:171","msg":"trace[1054274174] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"213.895192ms","start":"2026-05-16T01:50:21.094682Z","end":"2026-05-16T01:50:21.308577Z","steps":["trace[1054274174] 'read index received' (duration: 213.657404ms)","trace[1054274174] 'applied index is now lower than readState.Index' (duration: 236.758µs)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:50:21.308772Z","caller":"traceutil/trace.go:171","msg":"trace[1961118489] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"321.827404ms","start":"2026-05-16T01:50:20.9869Z","end":"2026-05-16T01:50:21.308728Z","steps":["trace[1961118489] 'process raft request' (duration: 321.540475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:50:21.308863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.155241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-16T01:50:21.309032Z","caller":"traceutil/trace.go:171","msg":"trace[2001705801] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2099; }","duration":"214.376297ms","start":"2026-05-16T01:50:21.094638Z","end":"2026-05-16T01:50:21.309014Z","steps":["trace[2001705801] 'agreement among raft nodes before linearized reading' (duration: 214.038287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:50:21.309191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-16T01:50:20.986882Z","time spent":"322.116652ms","remote":"127.0.0.1:56520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-16T01:51:53.036347Z","caller":"traceutil/trace.go:171","msg":"trace[516343618] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"151.513639ms","start":"2026-05-16T01:51:52.884791Z","end":"2026-05-16T01:51:53.036305Z","steps":["trace[516343618] 'process raft request' (duration: 151.196908ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:51:53.041527Z","caller":"traceutil/trace.go:171","msg":"trace[1496219525] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"154.178086ms","start":"2026-05-16T01:51:52.88733Z","end":"2026-05-16T01:51:53.041508Z","steps":["trace[1496219525] 'process raft request' (duration: 154.091793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:51:53.22385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.172883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18afe8bfbff3fe24\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-05-16T01:51:53.223928Z","caller":"traceutil/trace.go:171","msg":"trace[39147257] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18afe8bfbff3fe24; range_end:; response_count:1; response_revision:2705; }","duration":"129.294358ms","start":"2026-05-16T01:51:53.094611Z","end":"2026-05-16T01:51:53.223906Z","steps":["trace[39147257] 'range keys from in-memory index tree' (duration: 128.994767ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:51:53.332933Z","caller":"traceutil/trace.go:171","msg":"trace[1801219029] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"106.866146ms","start":"2026-05-16T01:51:53.226038Z","end":"2026-05-16T01:51:53.332904Z","steps":["trace[1801219029] 'process raft request' (duration: 106.672189ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:55:36.989582Z","caller":"traceutil/trace.go:171","msg":"trace[614167476] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"104.106906ms","start":"2026-05-16T01:55:36.88545Z","end":"2026-05-16T01:55:36.989557Z","steps":["trace[614167476] 'process raft request' (duration: 51.455612ms)","trace[614167476] 'compare' (duration: 52.547332ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:55:45.858329Z","caller":"traceutil/trace.go:171","msg":"trace[2141772238] linearizableReadLoop","detail":"{readStateIndex:4916; appliedIndex:4915; }","duration":"145.037442ms","start":"2026-05-16T01:55:45.713245Z","end":"2026-05-16T01:55:45.858282Z","steps":["trace[2141772238] 'read index received' (duration: 61.712371ms)","trace[2141772238] 'applied index is now lower than readState.Index' (duration: 83.323961ms)"],"step_count":2} {"level":"info","ts":"2026-05-16T01:55:45.858373Z","caller":"traceutil/trace.go:171","msg":"trace[1283666913] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"206.362662ms","start":"2026-05-16T01:55:45.651984Z","end":"2026-05-16T01:55:45.858347Z","steps":["trace[1283666913] 'process raft request' (duration: 122.944428ms)","trace[1283666913] 'compare' (duration: 83.23397ms)"],"step_count":2} {"level":"warn","ts":"2026-05-16T01:55:45.85863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.375298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-16T01:55:45.858676Z","caller":"traceutil/trace.go:171","msg":"trace[2012565536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4732; }","duration":"145.486631ms","start":"2026-05-16T01:55:45.713178Z","end":"2026-05-16T01:55:45.858664Z","steps":["trace[2012565536] 'agreement among raft nodes before linearized reading' (duration: 145.252246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-16T01:55:45.870153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.53909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-16T01:55:45.870174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.088289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b945624f-9d93-47af-8d5d-d98e03bcc825\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-05-16T01:55:45.870202Z","caller":"traceutil/trace.go:171","msg":"trace[2094224486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4734; }","duration":"151.657933ms","start":"2026-05-16T01:55:45.718533Z","end":"2026-05-16T01:55:45.870191Z","steps":["trace[2094224486] 'agreement among raft nodes before linearized reading' (duration: 151.51366ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:55:45.87021Z","caller":"traceutil/trace.go:171","msg":"trace[1572216999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b945624f-9d93-47af-8d5d-d98e03bcc825; range_end:; response_count:1; response_revision:4734; }","duration":"121.157331ms","start":"2026-05-16T01:55:45.749042Z","end":"2026-05-16T01:55:45.8702Z","steps":["trace[1572216999] 'agreement among raft nodes before linearized reading' (duration: 121.003227ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:55:46.348456Z","caller":"traceutil/trace.go:171","msg":"trace[980385505] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"152.666496ms","start":"2026-05-16T01:55:46.195741Z","end":"2026-05-16T01:55:46.348382Z","steps":["trace[980385505] 'process raft request' (duration: 152.432101ms)"],"step_count":1} {"level":"info","ts":"2026-05-16T01:57:29.218978Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2897} {"level":"info","ts":"2026-05-16T01:57:29.304334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2897,"took":"83.950295ms","hash":1858811668,"current-db-size-bytes":53665792,"current-db-size":"54 MB","current-db-size-in-use-bytes":29405184,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-16T01:57:29.304396Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1858811668,"revision":2897,"compact-revision":-1} {"level":"info","ts":"2026-05-16T02:02:29.226043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5648} {"level":"info","ts":"2026-05-16T02:02:29.324786Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5648,"took":"97.015103ms","hash":569165990,"current-db-size-bytes":53665792,"current-db-size":"54 MB","current-db-size-in-use-bytes":18370560,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-16T02:02:29.324846Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":569165990,"revision":5648,"compact-revision":2897}