{"level":"warn","ts":"2026-04-09T22:23:14.875044Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T22:23:14.875169Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-04-09T22:23:14.875691Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-09T22:23:14.875724Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-09T22:23:14.875793Z","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-04-09T22:23:14.876456Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-04-09T22:23:14.876783Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-04-09T22:23:14.881058Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.032651ms"} {"level":"info","ts":"2026-04-09T22:23:14.889765Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-04-09T22:23:14.890008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-04-09T22:23:14.890143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-04-09T22:23:14.890255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-09T22:23:14.890322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-04-09T22:23:14.890419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-04-09T22:23:14.899144Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-09T22:23:14.900897Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-09T22:23:14.902014Z","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-04-09T22:23:14.90417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-09T22:23:14.904394Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-09T22:23:14.904533Z","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-04-09T22:23:14.904695Z","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-04-09T22:23:14.904792Z","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-04-09T22:23:14.913579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-04-09T22:23:14.91477Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-04-09T22:23:14.914904Z","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-04-09T22:23:14.915078Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-09T22:23:14.915112Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-09T22:23:14.915141Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-04-09T22:23:14.915148Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-09T22:23:15.591294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-04-09T22:23:15.591426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-09T22:23:15.591481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-04-09T22:23:15.591506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-04-09T22:23:15.591553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-09T22:23:15.591601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-04-09T22:23:15.591618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-04-09T22:23:15.592641Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:23:15.593354Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-04-09T22:23:15.593447Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:23:15.593487Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-09T22:23:15.594104Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:23:15.594187Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:23:15.594209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-09T22:23:15.594759Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-09T22:23:15.594842Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-09T22:23:15.59579Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-09T22:23:15.597113Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-04-09T22:23:21.058358Z","caller":"traceutil/trace.go:171","msg":"trace[1100469947] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"124.912335ms","start":"2026-04-09T22:23:20.933427Z","end":"2026-04-09T22:23:21.058339Z","steps":["trace[1100469947] 'process raft request' (duration: 124.727363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:27.104856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.410148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-09T22:23:27.106119Z","caller":"traceutil/trace.go:171","msg":"trace[624922423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:348; }","duration":"407.478767ms","start":"2026-04-09T22:23:26.698396Z","end":"2026-04-09T22:23:27.105875Z","steps":["trace[624922423] 'range keys from in-memory index tree' (duration: 406.319858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:27.106213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:23:26.69838Z","time spent":"407.791261ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-09T22:23:27.269549Z","caller":"traceutil/trace.go:171","msg":"trace[1097364527] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"158.162776ms","start":"2026-04-09T22:23:27.111339Z","end":"2026-04-09T22:23:27.269501Z","steps":["trace[1097364527] 'process raft request' (duration: 157.949324ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:23:27.33007Z","caller":"traceutil/trace.go:171","msg":"trace[1621532524] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:364; }","duration":"211.395456ms","start":"2026-04-09T22:23:27.118649Z","end":"2026-04-09T22:23:27.330045Z","steps":["trace[1621532524] 'read index received' (duration: 150.618688ms)","trace[1621532524] 'applied index is now lower than readState.Index' (duration: 60.775808ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:23:27.330135Z","caller":"traceutil/trace.go:171","msg":"trace[526763057] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"213.93154ms","start":"2026-04-09T22:23:27.116173Z","end":"2026-04-09T22:23:27.330104Z","steps":["trace[526763057] 'process raft request' (duration: 213.724998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:27.330234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.555648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-09T22:23:27.330311Z","caller":"traceutil/trace.go:171","msg":"trace[2127768990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:350; }","duration":"211.664169ms","start":"2026-04-09T22:23:27.118628Z","end":"2026-04-09T22:23:27.330293Z","steps":["trace[2127768990] 'agreement among raft nodes before linearized reading' (duration: 211.513417ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:23:53.074335Z","caller":"traceutil/trace.go:171","msg":"trace[1793089192] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"132.497131ms","start":"2026-04-09T22:23:52.941812Z","end":"2026-04-09T22:23:53.074309Z","steps":["trace[1793089192] 'process raft request' (duration: 132.172828ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:23:53.947387Z","caller":"traceutil/trace.go:171","msg":"trace[1273565568] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"403.798394ms","start":"2026-04-09T22:23:53.543568Z","end":"2026-04-09T22:23:53.947366Z","steps":["trace[1273565568] 'read index received' (duration: 75.350169ms)","trace[1273565568] 'applied index is now lower than readState.Index' (duration: 328.447275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:23:53.9476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.007486ms","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-04-09T22:23:53.947639Z","caller":"traceutil/trace.go:171","msg":"trace[384124301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"404.065946ms","start":"2026-04-09T22:23:53.543562Z","end":"2026-04-09T22:23:53.947628Z","steps":["trace[384124301] 'agreement among raft nodes before linearized reading' (duration: 403.892285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:53.947671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:23:53.543525Z","time spent":"404.138287ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-09T22:23:53.947813Z","caller":"traceutil/trace.go:171","msg":"trace[929022067] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"419.222672ms","start":"2026-04-09T22:23:53.528545Z","end":"2026-04-09T22:23:53.947768Z","steps":["trace[929022067] 'process raft request' (duration: 418.679118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:53.948663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:23:53.528533Z","time spent":"419.457125ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:23:54.096155Z","caller":"traceutil/trace.go:171","msg":"trace[1050768761] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"144.919281ms","start":"2026-04-09T22:23:53.95121Z","end":"2026-04-09T22:23:54.096129Z","steps":["trace[1050768761] 'process raft request' (duration: 134.163689ms)","trace[1050768761] 'compare' (duration: 10.604181ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:23:54.249323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.265747ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-09T22:23:54.249438Z","caller":"traceutil/trace.go:171","msg":"trace[2097617207] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"135.137765ms","start":"2026-04-09T22:23:54.114284Z","end":"2026-04-09T22:23:54.249422Z","steps":["trace[2097617207] 'read index received' (duration: 36.86µs)","trace[2097617207] 'applied index is now lower than readState.Index' (duration: 135.099775ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:23:54.249561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.984664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:23:54.249592Z","caller":"traceutil/trace.go:171","msg":"trace[333808878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"135.050134ms","start":"2026-04-09T22:23:54.114534Z","end":"2026-04-09T22:23:54.249584Z","steps":["trace[333808878] 'agreement among raft nodes before linearized reading' (duration: 134.987983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:54.249775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.146605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xghnw\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-09T22:23:54.24991Z","caller":"traceutil/trace.go:171","msg":"trace[406267360] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xghnw; range_end:; response_count:1; response_revision:636; }","duration":"135.281786ms","start":"2026-04-09T22:23:54.114572Z","end":"2026-04-09T22:23:54.249854Z","steps":["trace[406267360] 'agreement among raft nodes before linearized reading' (duration: 135.026304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:23:54.249999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.654689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-09T22:23:54.250111Z","caller":"traceutil/trace.go:171","msg":"trace[822250087] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:636; }","duration":"135.84512ms","start":"2026-04-09T22:23:54.114246Z","end":"2026-04-09T22:23:54.250091Z","steps":["trace[822250087] 'agreement among raft nodes before linearized reading' (duration: 135.273255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:20.341171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.201572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-09T22:24:20.341281Z","caller":"traceutil/trace.go:171","msg":"trace[2117474689] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:777; }","duration":"122.42894ms","start":"2026-04-09T22:24:20.218833Z","end":"2026-04-09T22:24:20.341262Z","steps":["trace[2117474689] 'range keys from in-memory index tree' (duration: 121.998434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:24:20.341373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.169161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bw4wb\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-09T22:24:20.341468Z","caller":"traceutil/trace.go:171","msg":"trace[598522401] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-bw4wb; range_end:; response_count:1; response_revision:777; }","duration":"113.311476ms","start":"2026-04-09T22:24:20.228128Z","end":"2026-04-09T22:24:20.34144Z","steps":["trace[598522401] 'range keys from in-memory index tree' (duration: 112.910182ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:25:36.984779Z","caller":"traceutil/trace.go:171","msg":"trace[559157958] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"201.020367ms","start":"2026-04-09T22:25:36.783734Z","end":"2026-04-09T22:25:36.984755Z","steps":["trace[559157958] 'read index received' (duration: 200.812663ms)","trace[559157958] 'applied index is now lower than readState.Index' (duration: 206.664µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:25:36.98487Z","caller":"traceutil/trace.go:171","msg":"trace[1646149592] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"306.936101ms","start":"2026-04-09T22:25:36.677899Z","end":"2026-04-09T22:25:36.984835Z","steps":["trace[1646149592] 'process raft request' (duration: 306.712587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:25:36.985084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:25:36.677878Z","time spent":"307.072984ms","remote":"127.0.0.1:36382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10969,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T22:25:36.985122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.737951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-09T22:25:36.98521Z","caller":"traceutil/trace.go:171","msg":"trace[649749281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1844; }","duration":"117.906174ms","start":"2026-04-09T22:25:36.867284Z","end":"2026-04-09T22:25:36.98519Z","steps":["trace[649749281] 'agreement among raft nodes before linearized reading' (duration: 117.638669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:25:36.985576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.841242ms","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-04-09T22:25:36.985643Z","caller":"traceutil/trace.go:171","msg":"trace[305566699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1844; }","duration":"201.937874ms","start":"2026-04-09T22:25:36.783684Z","end":"2026-04-09T22:25:36.985622Z","steps":["trace[305566699] 'agreement among raft nodes before linearized reading' (duration: 201.17719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:25:37.358294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.056852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:25:37.358377Z","caller":"traceutil/trace.go:171","msg":"trace[1480314537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1850; }","duration":"245.187374ms","start":"2026-04-09T22:25:37.113172Z","end":"2026-04-09T22:25:37.358359Z","steps":["trace[1480314537] 'range keys from in-memory index tree' (duration: 244.98681ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:25:37.376158Z","caller":"traceutil/trace.go:171","msg":"trace[272591267] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"184.009312ms","start":"2026-04-09T22:25:37.192123Z","end":"2026-04-09T22:25:37.376132Z","steps":["trace[272591267] 'process raft request' (duration: 183.804989ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:26:06.753286Z","caller":"traceutil/trace.go:171","msg":"trace[1249624017] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"103.199676ms","start":"2026-04-09T22:26:06.650059Z","end":"2026-04-09T22:26:06.753258Z","steps":["trace[1249624017] 'process raft request' (duration: 103.035613ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:26:08.481919Z","caller":"traceutil/trace.go:171","msg":"trace[1115221985] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"207.454319ms","start":"2026-04-09T22:26:08.274435Z","end":"2026-04-09T22:26:08.481889Z","steps":["trace[1115221985] 'process raft request' (duration: 207.227826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:26:08.743012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.150193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-09T22:26:08.743089Z","caller":"traceutil/trace.go:171","msg":"trace[1533815233] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2152; }","duration":"416.691504ms","start":"2026-04-09T22:26:08.326387Z","end":"2026-04-09T22:26:08.743078Z","steps":["trace[1533815233] 'read index received' (duration: 155.279099ms)","trace[1533815233] 'applied index is now lower than readState.Index' (duration: 261.411865ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:26:08.743306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.929068ms","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-04-09T22:26:08.74328Z","caller":"traceutil/trace.go:171","msg":"trace[673301635] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"465.749216ms","start":"2026-04-09T22:26:08.277498Z","end":"2026-04-09T22:26:08.743247Z","steps":["trace[673301635] 'process raft request' (duration: 269.301869ms)","trace[673301635] 'compare' (duration: 196.058551ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:26:08.743331Z","caller":"traceutil/trace.go:171","msg":"trace[1875580733] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2070; }","duration":"416.992599ms","start":"2026-04-09T22:26:08.326331Z","end":"2026-04-09T22:26:08.743324Z","steps":["trace[1875580733] 'agreement among raft nodes before linearized reading' (duration: 416.884457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:26:08.743354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:26:08.326302Z","time spent":"417.04711ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-09T22:26:08.743495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.698375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-09T22:26:08.74358Z","caller":"traceutil/trace.go:171","msg":"trace[126998841] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:2070; }","duration":"204.839478ms","start":"2026-04-09T22:26:08.538722Z","end":"2026-04-09T22:26:08.743561Z","steps":["trace[126998841] 'agreement among raft nodes before linearized reading' (duration: 204.600314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:26:08.743511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:26:08.277486Z","time spent":"465.862017ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:27:22.296493Z","caller":"traceutil/trace.go:171","msg":"trace[1811304895] linearizableReadLoop","detail":"{readStateIndex:2668; appliedIndex:2668; }","duration":"104.857134ms","start":"2026-04-09T22:27:22.191616Z","end":"2026-04-09T22:27:22.296473Z","steps":["trace[1811304895] 'read index received' (duration: 104.850534ms)","trace[1811304895] 'applied index is now lower than readState.Index' (duration: 5.55µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:27:22.296594Z","caller":"traceutil/trace.go:171","msg":"trace[2098895405] transaction","detail":"{read_only:false; response_revision:2567; number_of_response:1; }","duration":"152.057141ms","start":"2026-04-09T22:27:22.144367Z","end":"2026-04-09T22:27:22.296424Z","steps":["trace[2098895405] 'process raft request' (duration: 151.92575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:27:22.296807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.165989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-09T22:27:22.296913Z","caller":"traceutil/trace.go:171","msg":"trace[1365799313] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2567; }","duration":"105.31784ms","start":"2026-04-09T22:27:22.191574Z","end":"2026-04-09T22:27:22.296891Z","steps":["trace[1365799313] 'agreement among raft nodes before linearized reading' (duration: 104.974536ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:22.312762Z","caller":"traceutil/trace.go:171","msg":"trace[1375446291] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"111.470167ms","start":"2026-04-09T22:27:22.201265Z","end":"2026-04-09T22:27:22.312735Z","steps":["trace[1375446291] 'process raft request' (duration: 111.171893ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:55.583299Z","caller":"traceutil/trace.go:171","msg":"trace[1087620207] linearizableReadLoop","detail":"{readStateIndex:2860; appliedIndex:2859; }","duration":"118.975783ms","start":"2026-04-09T22:27:55.464295Z","end":"2026-04-09T22:27:55.583271Z","steps":["trace[1087620207] 'read index received' (duration: 118.71208ms)","trace[1087620207] 'applied index is now lower than readState.Index' (duration: 262.033µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:27:55.583369Z","caller":"traceutil/trace.go:171","msg":"trace[1406455020] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"123.514547ms","start":"2026-04-09T22:27:55.459818Z","end":"2026-04-09T22:27:55.583332Z","steps":["trace[1406455020] 'process raft request' (duration: 123.182113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:27:55.583559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.215266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T22:27:55.583682Z","caller":"traceutil/trace.go:171","msg":"trace[215525806] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2751; }","duration":"119.399768ms","start":"2026-04-09T22:27:55.464243Z","end":"2026-04-09T22:27:55.583643Z","steps":["trace[215525806] 'agreement among raft nodes before linearized reading' (duration: 119.170106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:27:55.584019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.52388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a4d0bb30560ef2\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-09T22:27:55.584114Z","caller":"traceutil/trace.go:171","msg":"trace[1982251508] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a4d0bb30560ef2; range_end:; response_count:1; response_revision:2751; }","duration":"103.61116ms","start":"2026-04-09T22:27:55.48045Z","end":"2026-04-09T22:27:55.584061Z","steps":["trace[1982251508] 'agreement among raft nodes before linearized reading' (duration: 103.438898ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:27:55.706152Z","caller":"traceutil/trace.go:171","msg":"trace[1575980300] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"119.673652ms","start":"2026-04-09T22:27:55.58644Z","end":"2026-04-09T22:27:55.706114Z","steps":["trace[1575980300] 'process raft request' (duration: 99.187098ms)","trace[1575980300] 'compare' (duration: 20.335052ms)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:28:45.61501Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986421743188698234,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T22:28:46.115567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986421743188698234,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T22:28:46.616053Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986421743188698234,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-09T22:28:46.713865Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.65073571s","expected-duration":"1s"} {"level":"info","ts":"2026-04-09T22:28:46.714358Z","caller":"traceutil/trace.go:171","msg":"trace[1235635855] transaction","detail":"{read_only:false; response_revision:3014; number_of_response:1; }","duration":"1.651327593s","start":"2026-04-09T22:28:45.063009Z","end":"2026-04-09T22:28:46.714337Z","steps":["trace[1235635855] 'process raft request' (duration: 1.651145136s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.714526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.06298Z","time spent":"1.651442577s","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:28:46.715075Z","caller":"traceutil/trace.go:171","msg":"trace[1839523722] linearizableReadLoop","detail":"{readStateIndex:3137; appliedIndex:3133; }","duration":"1.600668882s","start":"2026-04-09T22:28:45.114386Z","end":"2026-04-09T22:28:46.715055Z","steps":["trace[1839523722] 'read index received' (duration: 1.599794178s)","trace[1839523722] 'applied index is now lower than readState.Index' (duration: 872.064µs)"],"step_count":2} {"level":"warn","ts":"2026-04-09T22:28:46.715343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.600951514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:28:46.715367Z","caller":"traceutil/trace.go:171","msg":"trace[128589166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3018; }","duration":"1.601025737s","start":"2026-04-09T22:28:45.114334Z","end":"2026-04-09T22:28:46.71536Z","steps":["trace[128589166] 'agreement among raft nodes before linearized reading' (duration: 1.600972154s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.715389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.114316Z","time spent":"1.601068198s","remote":"127.0.0.1:36170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-09T22:28:46.715729Z","caller":"traceutil/trace.go:171","msg":"trace[1649428866] transaction","detail":"{read_only:false; response_revision:3016; number_of_response:1; }","duration":"103.79829ms","start":"2026-04-09T22:28:46.611922Z","end":"2026-04-09T22:28:46.71572Z","steps":["trace[1649428866] 'process raft request' (duration: 103.04973ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:46.715804Z","caller":"traceutil/trace.go:171","msg":"trace[1811790855] transaction","detail":"{read_only:false; response_revision:3015; number_of_response:1; }","duration":"603.06547ms","start":"2026-04-09T22:28:46.112732Z","end":"2026-04-09T22:28:46.715797Z","steps":["trace[1811790855] 'process raft request' (duration: 602.134223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.715878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.112703Z","time spent":"603.131652ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-09T22:28:46.716048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"734.865249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-09T22:28:46.71607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489061092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-09T22:28:46.716416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205636284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"warn","ts":"2026-04-09T22:28:46.716439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.525019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-09T22:28:46.716449Z","caller":"traceutil/trace.go:171","msg":"trace[1330869988] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:3018; }","duration":"1.205692996s","start":"2026-04-09T22:28:45.510743Z","end":"2026-04-09T22:28:46.716436Z","steps":["trace[1330869988] 'agreement among raft nodes before linearized reading' (duration: 1.205620493s)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:46.716114Z","caller":"traceutil/trace.go:171","msg":"trace[145749648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3018; }","duration":"734.972923ms","start":"2026-04-09T22:28:45.981124Z","end":"2026-04-09T22:28:46.716097Z","steps":["trace[145749648] 'agreement among raft nodes before linearized reading' (duration: 734.779505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.71649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.510725Z","time spent":"1.205758648s","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.869523ms","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-04-09T22:28:46.716517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.981101Z","time spent":"735.40061ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-09T22:28:46.716537Z","caller":"traceutil/trace.go:171","msg":"trace[1451389249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3018; }","duration":"883.940066ms","start":"2026-04-09T22:28:45.832588Z","end":"2026-04-09T22:28:46.716528Z","steps":["trace[1451389249] 'agreement among raft nodes before linearized reading' (duration: 883.834962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.716562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.832557Z","time spent":"883.999418ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.484114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-09T22:28:46.716605Z","caller":"traceutil/trace.go:171","msg":"trace[1614683573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3018; }","duration":"447.919631ms","start":"2026-04-09T22:28:46.26867Z","end":"2026-04-09T22:28:46.716589Z","steps":["trace[1614683573] 'agreement among raft nodes before linearized reading' (duration: 447.467503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.716624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.268627Z","time spent":"447.991584ms","remote":"127.0.0.1:36446","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":"warn","ts":"2026-04-09T22:28:46.716219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.412893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-09T22:28:46.716658Z","caller":"traceutil/trace.go:171","msg":"trace[1188596328] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3018; }","duration":"523.868692ms","start":"2026-04-09T22:28:46.192779Z","end":"2026-04-09T22:28:46.716648Z","steps":["trace[1188596328] 'agreement among raft nodes before linearized reading' (duration: 523.420884ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.716695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.192771Z","time spent":"523.916734ms","remote":"127.0.0.1:36170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.545308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-09T22:28:46.716738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.235562421s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a4d0bb30560ef2\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-04-09T22:28:46.716783Z","caller":"traceutil/trace.go:171","msg":"trace[870632782] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:3018; }","duration":"487.070259ms","start":"2026-04-09T22:28:46.229704Z","end":"2026-04-09T22:28:46.716775Z","steps":["trace[870632782] 'agreement among raft nodes before linearized reading' (duration: 486.532397ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:46.716799Z","caller":"traceutil/trace.go:171","msg":"trace[1556014768] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a4d0bb30560ef2; range_end:; response_count:1; response_revision:3018; }","duration":"1.235653715s","start":"2026-04-09T22:28:45.48113Z","end":"2026-04-09T22:28:46.716784Z","steps":["trace[1556014768] 'agreement among raft nodes before linearized reading' (duration: 1.2352686s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.716812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.22967Z","time spent":"487.134741ms","remote":"127.0.0.1:36486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":30,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-09T22:28:46.716331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.560576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-09T22:28:46.716884Z","caller":"traceutil/trace.go:171","msg":"trace[428586809] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3018; }","duration":"590.16487ms","start":"2026-04-09T22:28:46.126712Z","end":"2026-04-09T22:28:46.716877Z","steps":["trace[428586809] 'agreement among raft nodes before linearized reading' (duration: 589.572566ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:28:46.716Z","caller":"traceutil/trace.go:171","msg":"trace[729017512] transaction","detail":"{read_only:false; response_revision:3017; number_of_response:1; }","duration":"102.944236ms","start":"2026-04-09T22:28:46.612989Z","end":"2026-04-09T22:28:46.715933Z","steps":["trace[729017512] 'process raft request' (duration: 102.014779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.71691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.126699Z","time spent":"590.204232ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002183288s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T22:28:46.716976Z","caller":"traceutil/trace.go:171","msg":"trace[53967379] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:3018; }","duration":"1.002843085s","start":"2026-04-09T22:28:45.714115Z","end":"2026-04-09T22:28:46.716958Z","steps":["trace[53967379] 'agreement among raft nodes before linearized reading' (duration: 1.002203389s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.717013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.714075Z","time spent":"1.002926878s","remote":"127.0.0.1:36620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-04-09T22:28:46.716464Z","caller":"traceutil/trace.go:171","msg":"trace[626323158] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3018; }","duration":"816.623343ms","start":"2026-04-09T22:28:45.899833Z","end":"2026-04-09T22:28:46.716457Z","steps":["trace[626323158] 'agreement among raft nodes before linearized reading' (duration: 816.482037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.717061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.899818Z","time spent":"817.236978ms","remote":"127.0.0.1:36382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.481112Z","time spent":"1.235720928s","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18a4d0bb30560ef2\" "} {"level":"warn","ts":"2026-04-09T22:28:46.716268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.866681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-09T22:28:46.717119Z","caller":"traceutil/trace.go:171","msg":"trace[1484914658] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3018; }","duration":"524.717125ms","start":"2026-04-09T22:28:46.192395Z","end":"2026-04-09T22:28:46.717112Z","steps":["trace[1484914658] 'agreement among raft nodes before linearized reading' (duration: 523.820219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.717137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:46.192316Z","time spent":"524.816269ms","remote":"127.0.0.1:36392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-04-09T22:28:46.717302Z","caller":"traceutil/trace.go:171","msg":"trace[1572302162] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3018; }","duration":"1.48949122s","start":"2026-04-09T22:28:45.226941Z","end":"2026-04-09T22:28:46.716433Z","steps":["trace[1572302162] 'agreement among raft nodes before linearized reading' (duration: 1.488785472s)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:28:46.717582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:28:45.226926Z","time spent":"1.490433147s","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-09T22:31:43.5123Z","caller":"traceutil/trace.go:171","msg":"trace[1571888292] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"219.235171ms","start":"2026-04-09T22:31:43.293037Z","end":"2026-04-09T22:31:43.512272Z","steps":["trace[1571888292] 'process raft request' (duration: 121.865484ms)","trace[1571888292] 'compare' (duration: 97.02749ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:43.58785Z","caller":"traceutil/trace.go:171","msg":"trace[2094385165] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"290.339812ms","start":"2026-04-09T22:31:43.297471Z","end":"2026-04-09T22:31:43.587811Z","steps":["trace[2094385165] 'process raft request' (duration: 290.044586ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:43.587856Z","caller":"traceutil/trace.go:171","msg":"trace[489310659] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"254.413833ms","start":"2026-04-09T22:31:43.33341Z","end":"2026-04-09T22:31:43.587824Z","steps":["trace[489310659] 'process raft request' (duration: 254.26211ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:43.589275Z","caller":"traceutil/trace.go:171","msg":"trace[1636824236] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"223.706935ms","start":"2026-04-09T22:31:43.365522Z","end":"2026-04-09T22:31:43.589229Z","steps":["trace[1636824236] 'process raft request' (duration: 222.235384ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:43.590178Z","caller":"traceutil/trace.go:171","msg":"trace[156018994] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"199.834381ms","start":"2026-04-09T22:31:43.39032Z","end":"2026-04-09T22:31:43.590154Z","steps":["trace[156018994] 'process raft request' (duration: 198.36277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:43.590674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.037305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-09T22:31:43.590751Z","caller":"traceutil/trace.go:171","msg":"trace[926095317] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4657; }","duration":"218.123167ms","start":"2026-04-09T22:31:43.372605Z","end":"2026-04-09T22:31:43.590728Z","steps":["trace[926095317] 'agreement among raft nodes before linearized reading' (duration: 217.856751ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:43.593541Z","caller":"traceutil/trace.go:171","msg":"trace[841595757] linearizableReadLoop","detail":"{readStateIndex:4840; appliedIndex:4836; }","duration":"220.903586ms","start":"2026-04-09T22:31:43.372613Z","end":"2026-04-09T22:31:43.593517Z","steps":["trace[841595757] 'read index received' (duration: 42.348205ms)","trace[841595757] 'applied index is now lower than readState.Index' (duration: 178.553001ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:43.634365Z","caller":"traceutil/trace.go:171","msg":"trace[1931950002] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"117.729487ms","start":"2026-04-09T22:31:43.516607Z","end":"2026-04-09T22:31:43.634337Z","steps":["trace[1931950002] 'process raft request' (duration: 117.623885ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:43.63502Z","caller":"traceutil/trace.go:171","msg":"trace[137342621] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"219.533737ms","start":"2026-04-09T22:31:43.415466Z","end":"2026-04-09T22:31:43.635Z","steps":["trace[137342621] 'process raft request' (duration: 218.594467ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:44.0088Z","caller":"traceutil/trace.go:171","msg":"trace[1965297902] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"203.504848ms","start":"2026-04-09T22:31:43.805274Z","end":"2026-04-09T22:31:44.008778Z","steps":["trace[1965297902] 'process raft request' (duration: 186.942379ms)","trace[1965297902] 'compare' (duration: 16.237232ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:56.704977Z","caller":"traceutil/trace.go:171","msg":"trace[158422809] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5087; }","duration":"241.13559ms","start":"2026-04-09T22:31:56.463817Z","end":"2026-04-09T22:31:56.704953Z","steps":["trace[158422809] 'read index received' (duration: 240.931306ms)","trace[158422809] 'applied index is now lower than readState.Index' (duration: 201.524µs)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:56.705041Z","caller":"traceutil/trace.go:171","msg":"trace[907337756] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"282.385267ms","start":"2026-04-09T22:31:56.422619Z","end":"2026-04-09T22:31:56.705004Z","steps":["trace[907337756] 'process raft request' (duration: 282.185223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:56.705227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.493141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-09T22:31:56.705269Z","caller":"traceutil/trace.go:171","msg":"trace[699272155] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4896; }","duration":"116.587984ms","start":"2026-04-09T22:31:56.588671Z","end":"2026-04-09T22:31:56.705259Z","steps":["trace[699272155] 'agreement among raft nodes before linearized reading' (duration: 116.43228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:56.705271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.434716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-09T22:31:56.705352Z","caller":"traceutil/trace.go:171","msg":"trace[1410582264] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4896; }","duration":"241.564949ms","start":"2026-04-09T22:31:56.463759Z","end":"2026-04-09T22:31:56.705324Z","steps":["trace[1410582264] 'agreement among raft nodes before linearized reading' (duration: 241.328804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.952078Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986421743188702810,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-09T22:31:59.963713Z","caller":"traceutil/trace.go:171","msg":"trace[1813101532] transaction","detail":"{read_only:false; response_revision:4925; number_of_response:1; }","duration":"518.185212ms","start":"2026-04-09T22:31:59.445498Z","end":"2026-04-09T22:31:59.963683Z","steps":["trace[1813101532] 'process raft request' (duration: 517.976087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.964325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:31:59.445469Z","time spent":"518.327064ms","remote":"127.0.0.1:36382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10868,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:31:59.966902Z","caller":"traceutil/trace.go:171","msg":"trace[1728036576] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"448.541601ms","start":"2026-04-09T22:31:59.518338Z","end":"2026-04-09T22:31:59.96688Z","steps":["trace[1728036576] 'process raft request' (duration: 448.363177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.967041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:31:59.51832Z","time spent":"448.647893ms","remote":"127.0.0.1:36446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-09T22:31:59.967251Z","caller":"traceutil/trace.go:171","msg":"trace[2101316319] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"293.226822ms","start":"2026-04-09T22:31:59.67401Z","end":"2026-04-09T22:31:59.967237Z","steps":["trace[2101316319] 'process raft request' (duration: 292.818624ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:59.967299Z","caller":"traceutil/trace.go:171","msg":"trace[1523551861] linearizableReadLoop","detail":"{readStateIndex:5122; appliedIndex:5117; }","duration":"515.916465ms","start":"2026-04-09T22:31:59.451365Z","end":"2026-04-09T22:31:59.967281Z","steps":["trace[1523551861] 'read index received' (duration: 512.095987ms)","trace[1523551861] 'applied index is now lower than readState.Index' (duration: 3.819668ms)"],"step_count":2} {"level":"info","ts":"2026-04-09T22:31:59.967406Z","caller":"traceutil/trace.go:171","msg":"trace[92679810] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"234.230838ms","start":"2026-04-09T22:31:59.733167Z","end":"2026-04-09T22:31:59.967397Z","steps":["trace[92679810] 'process raft request' (duration: 234.078565ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:31:59.967493Z","caller":"traceutil/trace.go:171","msg":"trace[250779597] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"287.003085ms","start":"2026-04-09T22:31:59.680307Z","end":"2026-04-09T22:31:59.96731Z","steps":["trace[250779597] 'process raft request' (duration: 286.829021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.967687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.320533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-09T22:31:59.967719Z","caller":"traceutil/trace.go:171","msg":"trace[1823451265] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4929; }","duration":"516.405985ms","start":"2026-04-09T22:31:59.451303Z","end":"2026-04-09T22:31:59.967709Z","steps":["trace[1823451265] 'agreement among raft nodes before linearized reading' (duration: 516.293322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.96775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-09T22:31:59.45128Z","time spent":"516.464077ms","remote":"127.0.0.1:36352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-09T22:31:59.967971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.432814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-09T22:31:59.968016Z","caller":"traceutil/trace.go:171","msg":"trace[1538331063] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4929; }","duration":"138.509196ms","start":"2026-04-09T22:31:59.829496Z","end":"2026-04-09T22:31:59.968005Z","steps":["trace[1538331063] 'agreement among raft nodes before linearized reading' (duration: 138.353703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-09T22:31:59.969791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.222009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-09T22:31:59.969867Z","caller":"traceutil/trace.go:171","msg":"trace[1851049278] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:4929; }","duration":"186.302981ms","start":"2026-04-09T22:31:59.783513Z","end":"2026-04-09T22:31:59.969816Z","steps":["trace[1851049278] 'agreement among raft nodes before linearized reading' (duration: 184.165367ms)"],"step_count":1} {"level":"info","ts":"2026-04-09T22:33:15.619324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2860} {"level":"info","ts":"2026-04-09T22:33:15.699721Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2860,"took":"78.869288ms","hash":1006538585,"current-db-size-bytes":53358592,"current-db-size":"53 MB","current-db-size-in-use-bytes":28782592,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-09T22:33:15.699793Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1006538585,"revision":2860,"compact-revision":-1} {"level":"info","ts":"2026-04-09T22:38:15.625327Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5525} {"level":"info","ts":"2026-04-09T22:38:15.716327Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5525,"took":"89.576562ms","hash":1786769812,"current-db-size-bytes":53358592,"current-db-size":"53 MB","current-db-size-in-use-bytes":18124800,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-09T22:38:15.716398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1786769812,"revision":5525,"compact-revision":2860}