{"level":"warn","ts":"2026-04-20T05:49:09.870173Z","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-20T05:49:09.870266Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-20T05:49:09.870335Z","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-20T05:49:09.870349Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-20T05:49:09.870365Z","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-20T05:49:09.87097Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-04-20T05:49:09.871049Z","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":16,"max-cpu-available":16,"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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-20T05:49:09.877487Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.807752ms"} {"level":"info","ts":"2026-04-20T05:49:09.890159Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-04-20T05:49:09.890239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:49:09.890263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-04-20T05:49:09.890276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:49:09.890291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-04-20T05:49:09.890327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-04-20T05:49:09.899863Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:49:09.901637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:49:09.903085Z","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-20T05:49:09.906357Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:49:09.906544Z","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-20T05:49:09.906669Z","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-20T05:49:09.906683Z","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-20T05:49:09.906678Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:49:09.908451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-04-20T05:49:09.908572Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-04-20T05:49:09.91022Z","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-20T05:49:09.910278Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-20T05:49:09.910321Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-04-20T05:49:09.910478Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:49:09.91051Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:49:10.69127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:49:10.691345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:49:10.6914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-04-20T05:49:10.691419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:49:10.69143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-20T05:49:10.691446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-04-20T05:49:10.691475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-04-20T05:49:10.692714Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:10.693828Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:49:10.693878Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:49:10.693947Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:49:10.694075Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:49:10.694142Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:49:10.694617Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:10.694776Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:10.694821Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:10.696096Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-04-20T05:49:10.697232Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:49:13.386707Z","caller":"traceutil/trace.go:171","msg":"trace[1566382626] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"128.303953ms","start":"2026-04-20T05:49:13.258359Z","end":"2026-04-20T05:49:13.386663Z","steps":["trace[1566382626] 'process raft request' (duration: 68.031198ms)","trace[1566382626] 'compare' (duration: 60.06662ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:13.407055Z","caller":"traceutil/trace.go:171","msg":"trace[1080017830] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"148.10544ms","start":"2026-04-20T05:49:13.258916Z","end":"2026-04-20T05:49:13.407021Z","steps":["trace[1080017830] 'process raft request' (duration: 147.72479ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:13.533335Z","caller":"traceutil/trace.go:171","msg":"trace[1123495815] transaction","detail":"{read_only:false; response_revision:124; number_of_response:1; }","duration":"122.100081ms","start":"2026-04-20T05:49:13.411199Z","end":"2026-04-20T05:49:13.5333Z","steps":["trace[1123495815] 'process raft request' (duration: 78.327537ms)","trace[1123495815] 'compare' (duration: 43.538068ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:14.250233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.718133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:49:14.25036Z","caller":"traceutil/trace.go:171","msg":"trace[1140164503] linearizableReadLoop","detail":"{readStateIndex:150; appliedIndex:149; }","duration":"206.876246ms","start":"2026-04-20T05:49:14.043467Z","end":"2026-04-20T05:49:14.250343Z","steps":["trace[1140164503] 'read index received' (duration: 95.431704ms)","trace[1140164503] 'applied index is now lower than readState.Index' (duration: 111.443382ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:14.250432Z","caller":"traceutil/trace.go:171","msg":"trace[240159926] transaction","detail":"{read_only:false; response_revision:145; number_of_response:1; }","duration":"228.180213ms","start":"2026-04-20T05:49:14.022202Z","end":"2026-04-20T05:49:14.250382Z","steps":["trace[240159926] 'process raft request' (duration: 116.788112ms)","trace[240159926] 'compare' (duration: 110.543229ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:14.250576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.079921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:14.250671Z","caller":"traceutil/trace.go:171","msg":"trace[1483501669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:145; }","duration":"207.245647ms","start":"2026-04-20T05:49:14.043413Z","end":"2026-04-20T05:49:14.250659Z","steps":["trace[1483501669] 'agreement among raft nodes before linearized reading' (duration: 207.035941ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:24.863918Z","caller":"traceutil/trace.go:171","msg":"trace[246195354] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"329.946082ms","start":"2026-04-20T05:49:24.533936Z","end":"2026-04-20T05:49:24.863882Z","steps":["trace[246195354] 'process raft request' (duration: 329.732686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:24.864355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:24.533902Z","time spent":"330.144347ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:49:30.129156Z","caller":"traceutil/trace.go:171","msg":"trace[85653506] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"113.064735ms","start":"2026-04-20T05:49:30.016057Z","end":"2026-04-20T05:49:30.129122Z","steps":["trace[85653506] 'process raft request' (duration: 112.587402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:30.524584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.724241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:49:30.524702Z","caller":"traceutil/trace.go:171","msg":"trace[352121524] linearizableReadLoop","detail":"{readStateIndex:439; appliedIndex:438; }","duration":"222.798801ms","start":"2026-04-20T05:49:30.301886Z","end":"2026-04-20T05:49:30.524685Z","steps":["trace[352121524] 'read index received' (duration: 56.859115ms)","trace[352121524] 'applied index is now lower than readState.Index' (duration: 165.938386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:30.524763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.885644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:30.524795Z","caller":"traceutil/trace.go:171","msg":"trace[1153723438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"222.955886ms","start":"2026-04-20T05:49:30.301828Z","end":"2026-04-20T05:49:30.524784Z","steps":["trace[1153723438] 'agreement among raft nodes before linearized reading' (duration: 222.904445ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:30.52476Z","caller":"traceutil/trace.go:171","msg":"trace[1272797503] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"391.613122ms","start":"2026-04-20T05:49:30.133108Z","end":"2026-04-20T05:49:30.524721Z","steps":["trace[1272797503] 'process raft request' (duration: 225.650116ms)","trace[1272797503] 'compare' (duration: 165.558545ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:30.524946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:30.13308Z","time spent":"391.768866ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:49:45.932717Z","caller":"traceutil/trace.go:171","msg":"trace[776796900] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"130.414042ms","start":"2026-04-20T05:49:45.802282Z","end":"2026-04-20T05:49:45.932696Z","steps":["trace[776796900] 'process raft request' (duration: 129.54146ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:45.937379Z","caller":"traceutil/trace.go:171","msg":"trace[750487899] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"109.904156ms","start":"2026-04-20T05:49:45.827454Z","end":"2026-04-20T05:49:45.937358Z","steps":["trace[750487899] 'process raft request' (duration: 109.28201ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.356364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.519107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.356474Z","caller":"traceutil/trace.go:171","msg":"trace[1021255821] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"158.683213ms","start":"2026-04-20T05:49:51.197769Z","end":"2026-04-20T05:49:51.356452Z","steps":["trace[1021255821] 'range keys from in-memory index tree' (duration: 158.445556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.356535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.382203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T05:49:51.356618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.772005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.356665Z","caller":"traceutil/trace.go:171","msg":"trace[349429762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"255.565517ms","start":"2026-04-20T05:49:51.101072Z","end":"2026-04-20T05:49:51.356638Z","steps":["trace[349429762] 'range keys from in-memory index tree' (duration: 255.236009ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.35672Z","caller":"traceutil/trace.go:171","msg":"trace[624204584] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:623; }","duration":"111.906049ms","start":"2026-04-20T05:49:51.244794Z","end":"2026-04-20T05:49:51.3567Z","steps":["trace[624204584] 'range keys from in-memory index tree' (duration: 111.709234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.356719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.294871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T05:49:51.356768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.260157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.356711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.284668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.357394Z","caller":"traceutil/trace.go:171","msg":"trace[1795653290] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"160.058499ms","start":"2026-04-20T05:49:51.197299Z","end":"2026-04-20T05:49:51.357357Z","steps":["trace[1795653290] 'count revisions from in-memory index tree' (duration: 159.200257ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.356801Z","caller":"traceutil/trace.go:171","msg":"trace[1509211431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"255.414714ms","start":"2026-04-20T05:49:51.101367Z","end":"2026-04-20T05:49:51.356781Z","steps":["trace[1509211431] 'range keys from in-memory index tree' (duration: 255.066045ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.356808Z","caller":"traceutil/trace.go:171","msg":"trace[858737353] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:623; }","duration":"159.303208ms","start":"2026-04-20T05:49:51.197494Z","end":"2026-04-20T05:49:51.356797Z","steps":["trace[858737353] 'range keys from in-memory index tree' (duration: 159.139514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.356814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.517604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.358265Z","caller":"traceutil/trace.go:171","msg":"trace[1021521282] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:623; }","duration":"113.981493ms","start":"2026-04-20T05:49:51.244261Z","end":"2026-04-20T05:49:51.358242Z","steps":["trace[1021521282] 'count revisions from in-memory index tree' (duration: 112.471714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.356539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.153815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.358482Z","caller":"traceutil/trace.go:171","msg":"trace[2010069707] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:623; }","duration":"114.151748ms","start":"2026-04-20T05:49:51.244312Z","end":"2026-04-20T05:49:51.358464Z","steps":["trace[2010069707] 'range keys from in-memory index tree' (duration: 111.96184ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.684722Z","caller":"traceutil/trace.go:171","msg":"trace[2081238572] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"322.395996ms","start":"2026-04-20T05:49:51.362295Z","end":"2026-04-20T05:49:51.684691Z","steps":["trace[2081238572] 'process raft request' (duration: 322.089779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.684936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.362275Z","time spent":"322.54974ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:49:51.816001Z","caller":"traceutil/trace.go:171","msg":"trace[1747489097] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"451.659859ms","start":"2026-04-20T05:49:51.364305Z","end":"2026-04-20T05:49:51.815965Z","steps":["trace[1747489097] 'process raft request' (duration: 435.904897ms)","trace[1747489097] 'compare' (duration: 15.516236ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:51.816174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.364293Z","time spent":"451.794062ms","remote":"127.0.0.1:55422","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-20T05:49:51.816568Z","caller":"traceutil/trace.go:171","msg":"trace[1170998628] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"433.045002ms","start":"2026-04-20T05:49:51.383497Z","end":"2026-04-20T05:49:51.816542Z","steps":["trace[1170998628] 'read index received' (duration: 300.945055ms)","trace[1170998628] 'applied index is now lower than readState.Index' (duration: 132.098767ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:51.816624Z","caller":"traceutil/trace.go:171","msg":"trace[311844649] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"389.517223ms","start":"2026-04-20T05:49:51.427079Z","end":"2026-04-20T05:49:51.816596Z","steps":["trace[311844649] 'process raft request' (duration: 388.987469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.816747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.102234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.81677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.427055Z","time spent":"389.631427ms","remote":"127.0.0.1:55240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:49:51.816891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.937665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.816931Z","caller":"traceutil/trace.go:171","msg":"trace[1887557874] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"214.998136ms","start":"2026-04-20T05:49:51.601922Z","end":"2026-04-20T05:49:51.81692Z","steps":["trace[1887557874] 'agreement among raft nodes before linearized reading' (duration: 214.942414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.816939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.86677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.816909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.33976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.816994Z","caller":"traceutil/trace.go:171","msg":"trace[137145561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"254.944871ms","start":"2026-04-20T05:49:51.562037Z","end":"2026-04-20T05:49:51.816982Z","steps":["trace[137145561] 'agreement among raft nodes before linearized reading' (duration: 254.862099ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.817028Z","caller":"traceutil/trace.go:171","msg":"trace[389374957] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"433.554845ms","start":"2026-04-20T05:49:51.383454Z","end":"2026-04-20T05:49:51.817009Z","steps":["trace[389374957] 'agreement among raft nodes before linearized reading' (duration: 433.200296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.383431Z","time spent":"433.667469ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T05:49:51.817332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.548887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.817345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.403498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.817336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.014657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.817387Z","caller":"traceutil/trace.go:171","msg":"trace[612826579] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"233.48717ms","start":"2026-04-20T05:49:51.583888Z","end":"2026-04-20T05:49:51.817375Z","steps":["trace[612826579] 'agreement among raft nodes before linearized reading' (duration: 233.416318ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.817388Z","caller":"traceutil/trace.go:171","msg":"trace[309587733] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"255.65318ms","start":"2026-04-20T05:49:51.561719Z","end":"2026-04-20T05:49:51.817372Z","steps":["trace[309587733] 'agreement among raft nodes before linearized reading' (duration: 255.547077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.885113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:49:51.817462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.404258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.817541Z","caller":"traceutil/trace.go:171","msg":"trace[98509991] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"194.504841ms","start":"2026-04-20T05:49:51.62301Z","end":"2026-04-20T05:49:51.817515Z","steps":["trace[98509991] 'agreement among raft nodes before linearized reading' (duration: 194.363587ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.817549Z","caller":"traceutil/trace.go:171","msg":"trace[2097480748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"215.411247ms","start":"2026-04-20T05:49:51.602111Z","end":"2026-04-20T05:49:51.817522Z","steps":["trace[2097480748] 'agreement among raft nodes before linearized reading' (duration: 214.76487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.819195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.817692Z","caller":"traceutil/trace.go:171","msg":"trace[874432663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"255.946548ms","start":"2026-04-20T05:49:51.561737Z","end":"2026-04-20T05:49:51.817684Z","steps":["trace[874432663] 'agreement among raft nodes before linearized reading' (duration: 255.819505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.828689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.817435Z","caller":"traceutil/trace.go:171","msg":"trace[1035995297] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"194.148311ms","start":"2026-04-20T05:49:51.623262Z","end":"2026-04-20T05:49:51.81741Z","steps":["trace[1035995297] 'agreement among raft nodes before linearized reading' (duration: 193.898985ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:51.817837Z","caller":"traceutil/trace.go:171","msg":"trace[778661394] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"233.976444ms","start":"2026-04-20T05:49:51.583769Z","end":"2026-04-20T05:49:51.817745Z","steps":["trace[778661394] 'agreement among raft nodes before linearized reading' (duration: 233.818479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.942385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.817957Z","caller":"traceutil/trace.go:171","msg":"trace[820932291] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:626; }","duration":"215.071898ms","start":"2026-04-20T05:49:51.602865Z","end":"2026-04-20T05:49:51.817937Z","steps":["trace[820932291] 'agreement among raft nodes before linearized reading' (duration: 214.903644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.817716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.243893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:51.81682Z","caller":"traceutil/trace.go:171","msg":"trace[97218536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:626; }","duration":"433.283429ms","start":"2026-04-20T05:49:51.383522Z","end":"2026-04-20T05:49:51.816805Z","steps":["trace[97218536] 'agreement among raft nodes before linearized reading' (duration: 433.166156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:51.81813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.383491Z","time spent":"434.620143ms","remote":"127.0.0.1:51836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T05:49:51.818106Z","caller":"traceutil/trace.go:171","msg":"trace[940583342] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:626; }","duration":"194.649534ms","start":"2026-04-20T05:49:51.623448Z","end":"2026-04-20T05:49:51.818097Z","steps":["trace[940583342] 'agreement among raft nodes before linearized reading' (duration: 194.238973ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:52.443111Z","caller":"traceutil/trace.go:171","msg":"trace[2068950471] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:651; }","duration":"142.056878ms","start":"2026-04-20T05:49:52.301036Z","end":"2026-04-20T05:49:52.443093Z","steps":["trace[2068950471] 'read index received' (duration: 123.223875ms)","trace[2068950471] 'applied index is now lower than readState.Index' (duration: 18.832483ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:52.443152Z","caller":"traceutil/trace.go:171","msg":"trace[1056245620] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"561.775431ms","start":"2026-04-20T05:49:51.881357Z","end":"2026-04-20T05:49:52.443133Z","steps":["trace[1056245620] 'process raft request' (duration: 561.688629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:52.443203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.16149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:52.443221Z","caller":"traceutil/trace.go:171","msg":"trace[983586077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"142.244102ms","start":"2026-04-20T05:49:52.300972Z","end":"2026-04-20T05:49:52.443217Z","steps":["trace[983586077] 'agreement among raft nodes before linearized reading' (duration: 142.1813ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:52.443247Z","caller":"traceutil/trace.go:171","msg":"trace[1886566867] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"609.234442ms","start":"2026-04-20T05:49:51.833987Z","end":"2026-04-20T05:49:52.443221Z","steps":["trace[1886566867] 'process raft request' (duration: 590.276536ms)","trace[1886566867] 'compare' (duration: 18.536055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:52.443292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.881318Z","time spent":"561.881304ms","remote":"127.0.0.1:55632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T05:49:52.44339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:51.833664Z","time spent":"609.651863ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:49:52.842906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.971223ms","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-20T05:49:52.842992Z","caller":"traceutil/trace.go:171","msg":"trace[2038213256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:628; }","duration":"192.112427ms","start":"2026-04-20T05:49:52.650861Z","end":"2026-04-20T05:49:52.842974Z","steps":["trace[2038213256] 'range keys from in-memory index tree' (duration: 191.868241ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:58.513876Z","caller":"traceutil/trace.go:171","msg":"trace[62993376] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"120.907484ms","start":"2026-04-20T05:49:58.392925Z","end":"2026-04-20T05:49:58.513832Z","steps":["trace[62993376] 'process raft request' (duration: 56.493668ms)","trace[62993376] 'compare' (duration: 64.218741ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:08.86369Z","caller":"traceutil/trace.go:171","msg":"trace[1707689478] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"302.501607ms","start":"2026-04-20T05:50:08.561162Z","end":"2026-04-20T05:50:08.863664Z","steps":["trace[1707689478] 'process raft request' (duration: 302.318621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:08.863926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:08.561145Z","time spent":"302.65118ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:50:09.22739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.214511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xqd6p\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-20T05:50:09.227455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.739223ms","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-20T05:50:09.227508Z","caller":"traceutil/trace.go:171","msg":"trace[185532503] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xqd6p; range_end:; response_count:1; response_revision:788; }","duration":"312.347874ms","start":"2026-04-20T05:50:08.915129Z","end":"2026-04-20T05:50:09.227477Z","steps":["trace[185532503] 'range keys from in-memory index tree' (duration: 312.025936ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:09.227572Z","caller":"traceutil/trace.go:171","msg":"trace[510423851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"153.921619ms","start":"2026-04-20T05:50:09.073626Z","end":"2026-04-20T05:50:09.227548Z","steps":["trace[510423851] 'range keys from in-memory index tree' (duration: 153.541208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:09.227607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:08.915067Z","time spent":"312.527038ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xqd6p\" "} {"level":"warn","ts":"2026-04-20T05:50:09.228309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.421069ms","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-20T05:50:09.228449Z","caller":"traceutil/trace.go:171","msg":"trace[29955416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:788; }","duration":"294.19686ms","start":"2026-04-20T05:50:08.934222Z","end":"2026-04-20T05:50:09.228419Z","steps":["trace[29955416] 'range keys from in-memory index tree' (duration: 293.159833ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:37.294464Z","caller":"traceutil/trace.go:171","msg":"trace[931981180] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"278.298042ms","start":"2026-04-20T05:50:37.016138Z","end":"2026-04-20T05:50:37.294436Z","steps":["trace[931981180] 'process raft request' (duration: 278.087777ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:54.2135Z","caller":"traceutil/trace.go:171","msg":"trace[128770598] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"114.191191ms","start":"2026-04-20T05:50:54.099285Z","end":"2026-04-20T05:50:54.213476Z","steps":["trace[128770598] 'read index received' (duration: 114.126439ms)","trace[128770598] 'applied index is now lower than readState.Index' (duration: 63.292µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:54.213572Z","caller":"traceutil/trace.go:171","msg":"trace[1043280343] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"149.208498ms","start":"2026-04-20T05:50:54.064322Z","end":"2026-04-20T05:50:54.213531Z","steps":["trace[1043280343] 'process raft request' (duration: 148.977302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:54.213724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.412227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:50:54.213819Z","caller":"traceutil/trace.go:171","msg":"trace[698019418] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1326; }","duration":"114.572191ms","start":"2026-04-20T05:50:54.099227Z","end":"2026-04-20T05:50:54.213799Z","steps":["trace[698019418] 'agreement among raft nodes before linearized reading' (duration: 114.409367ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:04.118412Z","caller":"traceutil/trace.go:171","msg":"trace[1448021069] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"147.981065ms","start":"2026-04-20T05:51:03.970393Z","end":"2026-04-20T05:51:04.118374Z","steps":["trace[1448021069] 'process raft request' (duration: 147.706968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:25.663504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.245723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:51:25.664062Z","caller":"traceutil/trace.go:171","msg":"trace[490962976] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"566.244509ms","start":"2026-04-20T05:51:25.097758Z","end":"2026-04-20T05:51:25.664003Z","steps":["trace[490962976] 'process raft request' (duration: 160.356399ms)","trace[490962976] 'compare' (duration: 404.699949ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:25.664228Z","caller":"traceutil/trace.go:171","msg":"trace[1900587905] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1936; }","duration":"491.45228ms","start":"2026-04-20T05:51:25.172718Z","end":"2026-04-20T05:51:25.66417Z","steps":["trace[1900587905] 'read index received' (duration: 85.282123ms)","trace[1900587905] 'applied index is now lower than readState.Index' (duration: 406.137947ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:25.664117Z","caller":"traceutil/trace.go:171","msg":"trace[635996436] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"289.176623ms","start":"2026-04-20T05:51:25.374915Z","end":"2026-04-20T05:51:25.664092Z","steps":["trace[635996436] 'process raft request' (duration: 289.089971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:25.664465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.522514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:51:25.66451Z","caller":"traceutil/trace.go:171","msg":"trace[1030602072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1863; }","duration":"362.624677ms","start":"2026-04-20T05:51:25.301874Z","end":"2026-04-20T05:51:25.664499Z","steps":["trace[1030602072] 'agreement among raft nodes before linearized reading' (duration: 362.506094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:25.664472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.721227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-20T05:51:25.664551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.301853Z","time spent":"362.690129ms","remote":"127.0.0.1:55138","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-20T05:51:25.664573Z","caller":"traceutil/trace.go:171","msg":"trace[707190693] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0; range_end:; response_count:1; response_revision:1863; }","duration":"491.918882ms","start":"2026-04-20T05:51:25.172631Z","end":"2026-04-20T05:51:25.66455Z","steps":["trace[707190693] 'agreement among raft nodes before linearized reading' (duration: 491.631455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:25.664654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.172607Z","time spent":"492.030425ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0\" "} {"level":"warn","ts":"2026-04-20T05:51:25.664359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.097732Z","time spent":"566.454775ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:51:25.665044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.390498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-20T05:51:25.665113Z","caller":"traceutil/trace.go:171","msg":"trace[1281661800] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0; range_end:; response_count:1; response_revision:1863; }","duration":"300.495449ms","start":"2026-04-20T05:51:25.364599Z","end":"2026-04-20T05:51:25.665095Z","steps":["trace[1281661800] 'agreement among raft nodes before linearized reading' (duration: 299.919584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:25.665297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.364579Z","time spent":"300.702155ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2dfcbd2e-38de-430f-b5d4-284f1e1c73d0\" "} {"level":"info","ts":"2026-04-20T05:51:25.871342Z","caller":"traceutil/trace.go:171","msg":"trace[84933816] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"128.309951ms","start":"2026-04-20T05:51:25.743005Z","end":"2026-04-20T05:51:25.871315Z","steps":["trace[84933816] 'process raft request' (duration: 41.145248ms)","trace[84933816] 'compare' (duration: 86.953767ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:25.871572Z","caller":"traceutil/trace.go:171","msg":"trace[1790960395] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"118.954936ms","start":"2026-04-20T05:51:25.752589Z","end":"2026-04-20T05:51:25.871544Z","steps":["trace[1790960395] 'process raft request' (duration: 118.656538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:26.278753Z","caller":"traceutil/trace.go:171","msg":"trace[98547931] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"397.234885ms","start":"2026-04-20T05:51:25.881482Z","end":"2026-04-20T05:51:26.278717Z","steps":["trace[98547931] 'process raft request' (duration: 395.780947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:26.278968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.881445Z","time spent":"397.419338ms","remote":"127.0.0.1:55426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:26.279466Z","caller":"traceutil/trace.go:171","msg":"trace[1711340942] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1943; }","duration":"388.332361ms","start":"2026-04-20T05:51:25.891118Z","end":"2026-04-20T05:51:26.27945Z","steps":["trace[1711340942] 'read index received' (duration: 36.293701ms)","trace[1711340942] 'applied index is now lower than readState.Index' (duration: 352.03764ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:51:26.279671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.547636ms","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-20T05:51:26.27972Z","caller":"traceutil/trace.go:171","msg":"trace[1554378090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1872; }","duration":"388.642058ms","start":"2026-04-20T05:51:25.891063Z","end":"2026-04-20T05:51:26.279705Z","steps":["trace[1554378090] 'agreement among raft nodes before linearized reading' (duration: 388.452493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:26.279759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.891037Z","time spent":"388.71411ms","remote":"127.0.0.1:47308","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":"info","ts":"2026-04-20T05:51:26.279653Z","caller":"traceutil/trace.go:171","msg":"trace[1022747696] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"398.068426ms","start":"2026-04-20T05:51:25.881519Z","end":"2026-04-20T05:51:26.279587Z","steps":["trace[1022747696] 'process raft request' (duration: 397.08676ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:26.279947Z","caller":"traceutil/trace.go:171","msg":"trace[1585315243] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"398.286341ms","start":"2026-04-20T05:51:25.88165Z","end":"2026-04-20T05:51:26.279936Z","steps":["trace[1585315243] 'process raft request' (duration: 397.752428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:26.28005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.881507Z","time spent":"398.375543ms","remote":"127.0.0.1:55322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:51:26.280173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:25.881611Z","time spent":"398.369773ms","remote":"127.0.0.1:55322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:38.613045Z","caller":"traceutil/trace.go:171","msg":"trace[1386214661] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"185.359424ms","start":"2026-04-20T05:51:38.427646Z","end":"2026-04-20T05:51:38.613006Z","steps":["trace[1386214661] 'process raft request' (duration: 185.143268ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:38.626866Z","caller":"traceutil/trace.go:171","msg":"trace[626768140] linearizableReadLoop","detail":"{readStateIndex:2051; appliedIndex:2049; }","duration":"170.476454ms","start":"2026-04-20T05:51:38.456368Z","end":"2026-04-20T05:51:38.626845Z","steps":["trace[626768140] 'read index received' (duration: 156.405956ms)","trace[626768140] 'applied index is now lower than readState.Index' (duration: 14.068448ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:38.626913Z","caller":"traceutil/trace.go:171","msg":"trace[2092686709] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"173.875423ms","start":"2026-04-20T05:51:38.453007Z","end":"2026-04-20T05:51:38.626883Z","steps":["trace[2092686709] 'process raft request' (duration: 173.727689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:38.627146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.761863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-04-20T05:51:38.627202Z","caller":"traceutil/trace.go:171","msg":"trace[1878902898] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1973; }","duration":"170.901426ms","start":"2026-04-20T05:51:38.456289Z","end":"2026-04-20T05:51:38.627191Z","steps":["trace[1878902898] 'agreement among raft nodes before linearized reading' (duration: 170.66369ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:09.31448Z","caller":"traceutil/trace.go:171","msg":"trace[2020936916] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"221.660479ms","start":"2026-04-20T05:52:09.092792Z","end":"2026-04-20T05:52:09.314452Z","steps":["trace[2020936916] 'process raft request' (duration: 221.495014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:16.63358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.165567ms","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-04-20T05:52:16.633675Z","caller":"traceutil/trace.go:171","msg":"trace[1617547342] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2192; }","duration":"493.332152ms","start":"2026-04-20T05:52:16.140324Z","end":"2026-04-20T05:52:16.633656Z","steps":["trace[1617547342] 'range keys from in-memory index tree' (duration: 492.90702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:16.633937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:16.140112Z","time spent":"493.812284ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T05:52:16.634104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.120965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:52:16.634236Z","caller":"traceutil/trace.go:171","msg":"trace[60598265] linearizableReadLoop","detail":"{readStateIndex:2279; appliedIndex:2278; }","duration":"332.203344ms","start":"2026-04-20T05:52:16.302008Z","end":"2026-04-20T05:52:16.634211Z","steps":["trace[60598265] 'read index received' (duration: 100.874014ms)","trace[60598265] 'applied index is now lower than readState.Index' (duration: 231.32745ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:16.634323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.313657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:52:16.63436Z","caller":"traceutil/trace.go:171","msg":"trace[492402243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2193; }","duration":"332.379739ms","start":"2026-04-20T05:52:16.301964Z","end":"2026-04-20T05:52:16.634344Z","steps":["trace[492402243] 'agreement among raft nodes before linearized reading' (duration: 332.306507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:16.634402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:16.301942Z","time spent":"332.449171ms","remote":"127.0.0.1:55136","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-20T05:52:16.634635Z","caller":"traceutil/trace.go:171","msg":"trace[668249771] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"447.228119ms","start":"2026-04-20T05:52:16.187361Z","end":"2026-04-20T05:52:16.634589Z","steps":["trace[668249771] 'process raft request' (duration: 215.482188ms)","trace[668249771] 'compare' (duration: 230.649512ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:16.634814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:16.187323Z","time spent":"447.384353ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:52:17.04486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.972807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:52:17.045005Z","caller":"traceutil/trace.go:171","msg":"trace[721457610] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"406.294118ms","start":"2026-04-20T05:52:16.638679Z","end":"2026-04-20T05:52:17.044973Z","steps":["trace[721457610] 'process raft request' (duration: 246.075365ms)","trace[721457610] 'compare' (duration: 159.194867ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:17.045123Z","caller":"traceutil/trace.go:171","msg":"trace[1944302267] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"388.373211ms","start":"2026-04-20T05:52:16.656685Z","end":"2026-04-20T05:52:17.045058Z","steps":["trace[1944302267] 'read index received' (duration: 228.071566ms)","trace[1944302267] 'applied index is now lower than readState.Index' (duration: 160.299115ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:17.04515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:16.638667Z","time spent":"406.407022ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:52:17.045211Z","caller":"traceutil/trace.go:171","msg":"trace[1311509897] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"274.693282ms","start":"2026-04-20T05:52:16.770506Z","end":"2026-04-20T05:52:17.045199Z","steps":["trace[1311509897] 'process raft request' (duration: 274.477636ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:17.045161Z","caller":"traceutil/trace.go:171","msg":"trace[289246595] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"271.699184ms","start":"2026-04-20T05:52:16.773439Z","end":"2026-04-20T05:52:17.045139Z","steps":["trace[289246595] 'process raft request' (duration: 271.635373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:17.045401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.70444ms","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":"warn","ts":"2026-04-20T05:52:17.045422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.026547ms","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-20T05:52:17.04545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.205245ms","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-20T05:52:17.04547Z","caller":"traceutil/trace.go:171","msg":"trace[910614936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"212.126239ms","start":"2026-04-20T05:52:16.833332Z","end":"2026-04-20T05:52:17.045458Z","steps":["trace[910614936] 'agreement among raft nodes before linearized reading' (duration: 211.939794ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:17.045482Z","caller":"traceutil/trace.go:171","msg":"trace[483242157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2196; }","duration":"206.273037ms","start":"2026-04-20T05:52:16.839199Z","end":"2026-04-20T05:52:17.045472Z","steps":["trace[483242157] 'agreement among raft nodes before linearized reading' (duration: 206.164504ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:17.04548Z","caller":"traceutil/trace.go:171","msg":"trace[349155525] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2196; }","duration":"388.814703ms","start":"2026-04-20T05:52:16.656642Z","end":"2026-04-20T05:52:17.045457Z","steps":["trace[349155525] 'agreement among raft nodes before linearized reading' (duration: 388.523975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:17.045529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:16.656631Z","time spent":"388.884395ms","remote":"127.0.0.1:47308","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":"info","ts":"2026-04-20T05:52:17.326038Z","caller":"traceutil/trace.go:171","msg":"trace[1884020288] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"275.72545ms","start":"2026-04-20T05:52:17.050291Z","end":"2026-04-20T05:52:17.326016Z","steps":["trace[1884020288] 'process raft request' (duration: 275.582746ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:17.329957Z","caller":"traceutil/trace.go:171","msg":"trace[1261621285] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"279.56458ms","start":"2026-04-20T05:52:17.050357Z","end":"2026-04-20T05:52:17.329922Z","steps":["trace[1261621285] 'process raft request' (duration: 279.202501ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:45.634105Z","caller":"traceutil/trace.go:171","msg":"trace[1486096198] transaction","detail":"{read_only:false; response_revision:2866; number_of_response:1; }","duration":"193.177176ms","start":"2026-04-20T05:53:45.440901Z","end":"2026-04-20T05:53:45.634078Z","steps":["trace[1486096198] 'process raft request' (duration: 193.028662ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:45.649546Z","caller":"traceutil/trace.go:171","msg":"trace[919176310] linearizableReadLoop","detail":"{readStateIndex:2981; appliedIndex:2979; }","duration":"193.473424ms","start":"2026-04-20T05:53:45.45605Z","end":"2026-04-20T05:53:45.649523Z","steps":["trace[919176310] 'read index received' (duration: 177.899009ms)","trace[919176310] 'applied index is now lower than readState.Index' (duration: 15.573035ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:53:45.649662Z","caller":"traceutil/trace.go:171","msg":"trace[2069205121] transaction","detail":"{read_only:false; response_revision:2867; number_of_response:1; }","duration":"207.828718ms","start":"2026-04-20T05:53:45.441815Z","end":"2026-04-20T05:53:45.649644Z","steps":["trace[2069205121] 'process raft request' (duration: 207.582672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:45.649733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.664528ms","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-20T05:53:45.64978Z","caller":"traceutil/trace.go:171","msg":"trace[95222618] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2867; }","duration":"193.760522ms","start":"2026-04-20T05:53:45.456008Z","end":"2026-04-20T05:53:45.649769Z","steps":["trace[95222618] 'agreement among raft nodes before linearized reading' (duration: 193.613868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:46.37197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.335861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:53:46.372242Z","caller":"traceutil/trace.go:171","msg":"trace[964267703] transaction","detail":"{read_only:false; response_revision:2871; number_of_response:1; }","duration":"424.362041ms","start":"2026-04-20T05:53:45.947833Z","end":"2026-04-20T05:53:46.372195Z","steps":["trace[964267703] 'process raft request' (duration: 313.685351ms)","trace[964267703] 'compare' (duration: 110.119025ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:53:46.372457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:53:45.947814Z","time spent":"424.524934ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:54:15.948365Z","caller":"traceutil/trace.go:171","msg":"trace[79292236] transaction","detail":"{read_only:false; response_revision:3032; number_of_response:1; }","duration":"168.489442ms","start":"2026-04-20T05:54:15.779851Z","end":"2026-04-20T05:54:15.94834Z","steps":["trace[79292236] 'process raft request' (duration: 168.332019ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:15.94938Z","caller":"traceutil/trace.go:171","msg":"trace[442701229] linearizableReadLoop","detail":"{readStateIndex:3153; appliedIndex:3151; }","duration":"105.60394ms","start":"2026-04-20T05:54:15.843747Z","end":"2026-04-20T05:54:15.949351Z","steps":["trace[442701229] 'read index received' (duration: 104.559443ms)","trace[442701229] 'applied index is now lower than readState.Index' (duration: 1.043037ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:54:15.949478Z","caller":"traceutil/trace.go:171","msg":"trace[798203894] transaction","detail":"{read_only:false; response_revision:3033; number_of_response:1; }","duration":"169.494058ms","start":"2026-04-20T05:54:15.779951Z","end":"2026-04-20T05:54:15.949445Z","steps":["trace[798203894] 'process raft request' (duration: 169.21219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:15.949635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.879188ms","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-20T05:54:15.949687Z","caller":"traceutil/trace.go:171","msg":"trace[671400800] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3033; }","duration":"105.982129ms","start":"2026-04-20T05:54:15.843693Z","end":"2026-04-20T05:54:15.949675Z","steps":["trace[671400800] 'agreement among raft nodes before linearized reading' (duration: 105.768704ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:52.974103Z","caller":"traceutil/trace.go:171","msg":"trace[572430230] transaction","detail":"{read_only:false; response_revision:3233; number_of_response:1; }","duration":"122.692034ms","start":"2026-04-20T05:54:52.851383Z","end":"2026-04-20T05:54:52.974075Z","steps":["trace[572430230] 'process raft request' (duration: 122.512319ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:52.985872Z","caller":"traceutil/trace.go:171","msg":"trace[1863177590] transaction","detail":"{read_only:false; response_revision:3234; number_of_response:1; }","duration":"133.968636ms","start":"2026-04-20T05:54:52.851882Z","end":"2026-04-20T05:54:52.98585Z","steps":["trace[1863177590] 'process raft request' (duration: 133.865914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:56:21.792981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.602899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:56:21.793108Z","caller":"traceutil/trace.go:171","msg":"trace[473434001] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:3892; }","duration":"178.804264ms","start":"2026-04-20T05:56:21.614278Z","end":"2026-04-20T05:56:21.793083Z","steps":["trace[473434001] 'count revisions from in-memory index tree' (duration: 178.538168ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:39.470011Z","caller":"traceutil/trace.go:171","msg":"trace[1182347439] linearizableReadLoop","detail":"{readStateIndex:5092; appliedIndex:5091; }","duration":"248.279682ms","start":"2026-04-20T05:57:39.221695Z","end":"2026-04-20T05:57:39.469975Z","steps":["trace[1182347439] 'read index received' (duration: 248.073147ms)","trace[1182347439] 'applied index is now lower than readState.Index' (duration: 205.175µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:57:39.470035Z","caller":"traceutil/trace.go:171","msg":"trace[1701256880] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"248.719332ms","start":"2026-04-20T05:57:39.221281Z","end":"2026-04-20T05:57:39.470001Z","steps":["trace[1701256880] 'process raft request' (duration: 248.510087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:39.470247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.536588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-plbns\" ","response":"range_response_count:1 size:9716"} {"level":"info","ts":"2026-04-20T05:57:39.470289Z","caller":"traceutil/trace.go:171","msg":"trace[1544761237] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-plbns; range_end:; response_count:1; response_revision:4900; }","duration":"248.629291ms","start":"2026-04-20T05:57:39.221648Z","end":"2026-04-20T05:57:39.470277Z","steps":["trace[1544761237] 'agreement among raft nodes before linearized reading' (duration: 248.449366ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:39.489731Z","caller":"traceutil/trace.go:171","msg":"trace[1799457515] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"200.991559ms","start":"2026-04-20T05:57:39.288707Z","end":"2026-04-20T05:57:39.489699Z","steps":["trace[1799457515] 'process raft request' (duration: 200.837155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:39.489952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.990429ms","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-04-20T05:57:39.490001Z","caller":"traceutil/trace.go:171","msg":"trace[1405041117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4901; }","duration":"230.091162ms","start":"2026-04-20T05:57:39.259901Z","end":"2026-04-20T05:57:39.489992Z","steps":["trace[1405041117] 'agreement among raft nodes before linearized reading' (duration: 229.888666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:39.490115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.396417ms","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-20T05:57:39.490129Z","caller":"traceutil/trace.go:171","msg":"trace[1831403046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4901; }","duration":"204.440418ms","start":"2026-04-20T05:57:39.285683Z","end":"2026-04-20T05:57:39.490123Z","steps":["trace[1831403046] 'agreement among raft nodes before linearized reading' (duration: 204.391587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:39.490132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.122003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:57:39.490178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.885663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9dc202e6-e621-4711-bf6c-6142b24515b6\" ","response":"range_response_count:1 size:4080"} {"level":"info","ts":"2026-04-20T05:57:39.490239Z","caller":"traceutil/trace.go:171","msg":"trace[2075531922] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4901; }","duration":"191.259266ms","start":"2026-04-20T05:57:39.298953Z","end":"2026-04-20T05:57:39.490212Z","steps":["trace[2075531922] 'agreement among raft nodes before linearized reading' (duration: 191.053631ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:39.490248Z","caller":"traceutil/trace.go:171","msg":"trace[21419850] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9dc202e6-e621-4711-bf6c-6142b24515b6; range_end:; response_count:1; response_revision:4901; }","duration":"198.976416ms","start":"2026-04-20T05:57:39.291254Z","end":"2026-04-20T05:57:39.490231Z","steps":["trace[21419850] 'agreement among raft nodes before linearized reading' (duration: 198.73364ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:42.435119Z","caller":"traceutil/trace.go:171","msg":"trace[1882535463] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5242; }","duration":"183.118276ms","start":"2026-04-20T05:57:42.251974Z","end":"2026-04-20T05:57:42.435092Z","steps":["trace[1882535463] 'read index received' (duration: 182.999813ms)","trace[1882535463] 'applied index is now lower than readState.Index' (duration: 116.973µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:57:42.43521Z","caller":"traceutil/trace.go:171","msg":"trace[1353017491] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"266.571045ms","start":"2026-04-20T05:57:42.168615Z","end":"2026-04-20T05:57:42.435186Z","steps":["trace[1353017491] 'process raft request' (duration: 266.326678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:42.43564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.642179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2101f386-08db-4ff5-8021-5394b00ce686\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-20T05:57:42.435737Z","caller":"traceutil/trace.go:171","msg":"trace[330303530] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2101f386-08db-4ff5-8021-5394b00ce686; range_end:; response_count:1; response_revision:5047; }","duration":"183.809193ms","start":"2026-04-20T05:57:42.251908Z","end":"2026-04-20T05:57:42.435717Z","steps":["trace[330303530] 'agreement among raft nodes before linearized reading' (duration: 183.334131ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:42.594427Z","caller":"traceutil/trace.go:171","msg":"trace[1784842277] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5243; }","duration":"159.204507ms","start":"2026-04-20T05:57:42.435195Z","end":"2026-04-20T05:57:42.594399Z","steps":["trace[1784842277] 'read index received' (duration: 159.085394ms)","trace[1784842277] 'applied index is now lower than readState.Index' (duration: 117.783µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:57:42.594469Z","caller":"traceutil/trace.go:171","msg":"trace[1744583507] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"234.043463ms","start":"2026-04-20T05:57:42.360393Z","end":"2026-04-20T05:57:42.594437Z","steps":["trace[1744583507] 'process raft request' (duration: 233.829898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:42.594735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.230856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-plbns.18a7fb1829c1b387\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-20T05:57:42.594797Z","caller":"traceutil/trace.go:171","msg":"trace[45893565] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-plbns.18a7fb1829c1b387; range_end:; response_count:1; response_revision:5048; }","duration":"336.35008ms","start":"2026-04-20T05:57:42.258429Z","end":"2026-04-20T05:57:42.594779Z","steps":["trace[45893565] 'agreement among raft nodes before linearized reading' (duration: 336.071402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:42.594852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:57:42.258408Z","time spent":"336.432521ms","remote":"127.0.0.1:55214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":985,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-plbns.18a7fb1829c1b387\" "} {"level":"warn","ts":"2026-04-20T05:57:42.59498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.944231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:719488"} {"level":"info","ts":"2026-04-20T05:57:42.595037Z","caller":"traceutil/trace.go:171","msg":"trace[1131518489] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5048; }","duration":"193.062534ms","start":"2026-04-20T05:57:42.401961Z","end":"2026-04-20T05:57:42.595024Z","steps":["trace[1131518489] 'agreement among raft nodes before linearized reading' (duration: 192.576721ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:42.628421Z","caller":"traceutil/trace.go:171","msg":"trace[318242041] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"185.702263ms","start":"2026-04-20T05:57:42.442701Z","end":"2026-04-20T05:57:42.628403Z","steps":["trace[318242041] 'process raft request' (duration: 185.534038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:51.584921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.231481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:57:51.585208Z","caller":"traceutil/trace.go:171","msg":"trace[2029040977] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"162.371129ms","start":"2026-04-20T05:57:51.422804Z","end":"2026-04-20T05:57:51.585175Z","steps":["trace[2029040977] 'process raft request' (duration: 39.750768ms)","trace[2029040977] 'compare' (duration: 122.046856ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:57:51.585306Z","caller":"traceutil/trace.go:171","msg":"trace[102809909] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"162.41356ms","start":"2026-04-20T05:57:51.422854Z","end":"2026-04-20T05:57:51.585268Z","steps":["trace[102809909] 'process raft request' (duration: 162.222576ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:51.585419Z","caller":"traceutil/trace.go:171","msg":"trace[932398255] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"162.369409ms","start":"2026-04-20T05:57:51.423019Z","end":"2026-04-20T05:57:51.585388Z","steps":["trace[932398255] 'process raft request' (duration: 162.132062ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:54.303496Z","caller":"traceutil/trace.go:171","msg":"trace[418357660] linearizableReadLoop","detail":"{readStateIndex:5484; appliedIndex:5483; }","duration":"297.427123ms","start":"2026-04-20T05:57:54.00605Z","end":"2026-04-20T05:57:54.303477Z","steps":["trace[418357660] 'read index received' (duration: 297.238839ms)","trace[418357660] 'applied index is now lower than readState.Index' (duration: 187.354µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:57:54.303525Z","caller":"traceutil/trace.go:171","msg":"trace[1487175738] transaction","detail":"{read_only:false; response_revision:5280; number_of_response:1; }","duration":"520.332958ms","start":"2026-04-20T05:57:53.783165Z","end":"2026-04-20T05:57:54.303498Z","steps":["trace[1487175738] 'process raft request' (duration: 520.138413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:54.303787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.874332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T05:57:54.303795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.395425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:57:54.303846Z","caller":"traceutil/trace.go:171","msg":"trace[1414456046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5280; }","duration":"290.981145ms","start":"2026-04-20T05:57:54.012854Z","end":"2026-04-20T05:57:54.303836Z","steps":["trace[1414456046] 'agreement among raft nodes before linearized reading' (duration: 290.819821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:54.303869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:57:53.78312Z","time spent":"520.604614ms","remote":"127.0.0.1:55192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:57:54.303873Z","caller":"traceutil/trace.go:171","msg":"trace[1669669714] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:5280; }","duration":"127.52107ms","start":"2026-04-20T05:57:54.176336Z","end":"2026-04-20T05:57:54.303857Z","steps":["trace[1669669714] 'agreement among raft nodes before linearized reading' (duration: 127.400426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:57:54.303774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.70872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T05:57:54.304008Z","caller":"traceutil/trace.go:171","msg":"trace[25335415] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5280; }","duration":"297.992878ms","start":"2026-04-20T05:57:54.005998Z","end":"2026-04-20T05:57:54.303991Z","steps":["trace[25335415] 'agreement among raft nodes before linearized reading' (duration: 297.591857ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:02.831036Z","caller":"traceutil/trace.go:171","msg":"trace[2074543460] linearizableReadLoop","detail":"{readStateIndex:5671; appliedIndex:5670; }","duration":"479.179774ms","start":"2026-04-20T05:58:02.351822Z","end":"2026-04-20T05:58:02.831002Z","steps":["trace[2074543460] 'read index received' (duration: 449.900777ms)","trace[2074543460] 'applied index is now lower than readState.Index' (duration: 29.277677ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:02.831252Z","caller":"traceutil/trace.go:171","msg":"trace[1158101621] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"479.662866ms","start":"2026-04-20T05:58:02.351554Z","end":"2026-04-20T05:58:02.831217Z","steps":["trace[1158101621] 'process raft request' (duration: 450.169663ms)","trace[1158101621] 'compare' (duration: 29.156723ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:02.831398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:02.351525Z","time spent":"479.777179ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:58:02.831443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.913093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T05:58:02.83153Z","caller":"traceutil/trace.go:171","msg":"trace[632740085] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162; range_end:; response_count:1; response_revision:5465; }","duration":"354.054747ms","start":"2026-04-20T05:58:02.477456Z","end":"2026-04-20T05:58:02.831511Z","steps":["trace[632740085] 'agreement among raft nodes before linearized reading' (duration: 353.837281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:02.83158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:02.47735Z","time spent":"354.220102ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162\" "} {"level":"warn","ts":"2026-04-20T05:58:02.831561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.710057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T05:58:02.831656Z","caller":"traceutil/trace.go:171","msg":"trace[181303171] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5465; }","duration":"479.82215ms","start":"2026-04-20T05:58:02.351814Z","end":"2026-04-20T05:58:02.831636Z","steps":["trace[181303171] 'agreement among raft nodes before linearized reading' (duration: 479.538673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:02.831709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:02.351775Z","time spent":"479.924072ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T05:58:02.832222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.740398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T05:58:02.832304Z","caller":"traceutil/trace.go:171","msg":"trace[1190143196] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162; range_end:; response_count:1; response_revision:5465; }","duration":"295.873642ms","start":"2026-04-20T05:58:02.536411Z","end":"2026-04-20T05:58:02.832285Z","steps":["trace[1190143196] 'agreement among raft nodes before linearized reading' (duration: 295.049681ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:03.309018Z","caller":"traceutil/trace.go:171","msg":"trace[860194594] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"113.659149ms","start":"2026-04-20T05:58:03.195338Z","end":"2026-04-20T05:58:03.308997Z","steps":["trace[860194594] 'process raft request' (duration: 113.518936ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:03.499674Z","caller":"traceutil/trace.go:171","msg":"trace[601064849] linearizableReadLoop","detail":"{readStateIndex:5678; appliedIndex:5675; }","duration":"198.694839ms","start":"2026-04-20T05:58:03.300951Z","end":"2026-04-20T05:58:03.499646Z","steps":["trace[601064849] 'read index received' (duration: 7.932784ms)","trace[601064849] 'applied index is now lower than readState.Index' (duration: 190.760395ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:03.49972Z","caller":"traceutil/trace.go:171","msg":"trace[39637007] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"260.479637ms","start":"2026-04-20T05:58:03.239208Z","end":"2026-04-20T05:58:03.499687Z","steps":["trace[39637007] 'process raft request' (duration: 256.234217ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:03.499834Z","caller":"traceutil/trace.go:171","msg":"trace[593566081] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"203.403831ms","start":"2026-04-20T05:58:03.296408Z","end":"2026-04-20T05:58:03.499812Z","steps":["trace[593566081] 'process raft request' (duration: 203.107743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:03.500087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.12221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:58:03.50017Z","caller":"traceutil/trace.go:171","msg":"trace[890964232] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5472; }","duration":"199.255963ms","start":"2026-04-20T05:58:03.300891Z","end":"2026-04-20T05:58:03.500147Z","steps":["trace[890964232] 'agreement among raft nodes before linearized reading' (duration: 199.109049ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:06.023781Z","caller":"traceutil/trace.go:171","msg":"trace[1118884944] linearizableReadLoop","detail":"{readStateIndex:5700; appliedIndex:5699; }","duration":"358.728657ms","start":"2026-04-20T05:58:05.665017Z","end":"2026-04-20T05:58:06.023746Z","steps":["trace[1118884944] 'read index received' (duration: 344.51503ms)","trace[1118884944] 'applied index is now lower than readState.Index' (duration: 14.211807ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:06.023828Z","caller":"traceutil/trace.go:171","msg":"trace[673273491] transaction","detail":"{read_only:false; response_revision:5493; number_of_response:1; }","duration":"371.798545ms","start":"2026-04-20T05:58:05.652Z","end":"2026-04-20T05:58:06.023799Z","steps":["trace[673273491] 'process raft request' (duration: 357.447305ms)","trace[673273491] 'compare' (duration: 14.007642ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:06.023977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:05.65198Z","time spent":"371.904619ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:58:06.024113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.067845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T05:58:06.024209Z","caller":"traceutil/trace.go:171","msg":"trace[1296906134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5493; }","duration":"359.20164ms","start":"2026-04-20T05:58:05.664983Z","end":"2026-04-20T05:58:06.024185Z","steps":["trace[1296906134] 'agreement among raft nodes before linearized reading' (duration: 358.883101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:06.024268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:05.664971Z","time spent":"359.282353ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T05:58:06.02588Z","caller":"traceutil/trace.go:171","msg":"trace[2103562355] transaction","detail":"{read_only:false; response_revision:5494; number_of_response:1; }","duration":"115.857796ms","start":"2026-04-20T05:58:05.909986Z","end":"2026-04-20T05:58:06.025844Z","steps":["trace[2103562355] 'process raft request' (duration: 115.694882ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:06.026384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.128998ms","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-04-20T05:58:06.02645Z","caller":"traceutil/trace.go:171","msg":"trace[18064469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5494; }","duration":"359.21218ms","start":"2026-04-20T05:58:05.667222Z","end":"2026-04-20T05:58:06.026435Z","steps":["trace[18064469] 'agreement among raft nodes before linearized reading' (duration: 358.555643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:06.026486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:05.667218Z","time spent":"359.261951ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T05:58:06.026703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.731805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T05:58:06.026737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.166172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T05:58:06.026744Z","caller":"traceutil/trace.go:171","msg":"trace[616113608] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:5494; }","duration":"129.778716ms","start":"2026-04-20T05:58:05.896955Z","end":"2026-04-20T05:58:06.026734Z","steps":["trace[616113608] 'agreement among raft nodes before linearized reading' (duration: 128.849602ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:06.026759Z","caller":"traceutil/trace.go:171","msg":"trace[1477006387] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:5494; }","duration":"356.198573ms","start":"2026-04-20T05:58:05.670554Z","end":"2026-04-20T05:58:06.026753Z","steps":["trace[1477006387] 'agreement among raft nodes before linearized reading' (duration: 355.378272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:06.026736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.276743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162\" ","response":"range_response_count:1 size:3952"} {"level":"warn","ts":"2026-04-20T05:58:06.026777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:05.670548Z","time spent":"356.224873ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fd2bj\" "} {"level":"info","ts":"2026-04-20T05:58:06.026815Z","caller":"traceutil/trace.go:171","msg":"trace[1449600758] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f2944826-a5e0-4526-bb26-f61f7fe2f162; range_end:; response_count:1; response_revision:5494; }","duration":"182.405367ms","start":"2026-04-20T05:58:05.844391Z","end":"2026-04-20T05:58:06.026797Z","steps":["trace[1449600758] 'agreement among raft nodes before linearized reading' (duration: 181.508954ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:10.201672Z","caller":"traceutil/trace.go:171","msg":"trace[1330851406] linearizableReadLoop","detail":"{readStateIndex:5799; appliedIndex:5797; }","duration":"158.008937ms","start":"2026-04-20T05:58:10.043632Z","end":"2026-04-20T05:58:10.201641Z","steps":["trace[1330851406] 'read index received' (duration: 91.403073ms)","trace[1330851406] 'applied index is now lower than readState.Index' (duration: 66.604274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:10.20195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.306774ms","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-20T05:58:10.201991Z","caller":"traceutil/trace.go:171","msg":"trace[595962497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5587; }","duration":"158.401396ms","start":"2026-04-20T05:58:10.043579Z","end":"2026-04-20T05:58:10.20198Z","steps":["trace[595962497] 'agreement among raft nodes before linearized reading' (duration: 158.237802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:10.202052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.274316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T05:58:10.202135Z","caller":"traceutil/trace.go:171","msg":"trace[468338391] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:5587; }","duration":"155.323617ms","start":"2026-04-20T05:58:10.046754Z","end":"2026-04-20T05:58:10.202078Z","steps":["trace[468338391] 'agreement among raft nodes before linearized reading' (duration: 155.258265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:10.20197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.96113ms","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-04-20T05:58:10.202202Z","caller":"traceutil/trace.go:171","msg":"trace[1972011949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5587; }","duration":"157.212075ms","start":"2026-04-20T05:58:10.044961Z","end":"2026-04-20T05:58:10.202173Z","steps":["trace[1972011949] 'agreement among raft nodes before linearized reading' (duration: 156.876057ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:44.554198Z","caller":"traceutil/trace.go:171","msg":"trace[324702499] linearizableReadLoop","detail":"{readStateIndex:6121; appliedIndex:6120; }","duration":"283.450532ms","start":"2026-04-20T05:58:44.270699Z","end":"2026-04-20T05:58:44.554149Z","steps":["trace[324702499] 'read index received' (duration: 229.894596ms)","trace[324702499] 'applied index is now lower than readState.Index' (duration: 53.554756ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:58:44.554208Z","caller":"traceutil/trace.go:171","msg":"trace[1569512012] transaction","detail":"{read_only:false; response_revision:5902; number_of_response:1; }","duration":"310.723047ms","start":"2026-04-20T05:58:44.24345Z","end":"2026-04-20T05:58:44.554173Z","steps":["trace[1569512012] 'process raft request' (duration: 257.12933ms)","trace[1569512012] 'compare' (duration: 53.211937ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:58:44.554423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:58:44.243422Z","time spent":"310.909331ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:58:44.554427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.105451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:58:44.554486Z","caller":"traceutil/trace.go:171","msg":"trace[208289023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5902; }","duration":"252.213733ms","start":"2026-04-20T05:58:44.302261Z","end":"2026-04-20T05:58:44.554474Z","steps":["trace[208289023] 'agreement among raft nodes before linearized reading' (duration: 252.09567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:44.554631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.318686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T05:58:44.554648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.541441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T05:58:44.554718Z","caller":"traceutil/trace.go:171","msg":"trace[472054656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5902; }","duration":"187.453448ms","start":"2026-04-20T05:58:44.367244Z","end":"2026-04-20T05:58:44.554698Z","steps":["trace[472054656] 'agreement among raft nodes before linearized reading' (duration: 187.192771ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:58:44.554733Z","caller":"traceutil/trace.go:171","msg":"trace[1730457226] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:5902; }","duration":"182.669204ms","start":"2026-04-20T05:58:44.372041Z","end":"2026-04-20T05:58:44.55471Z","steps":["trace[1730457226] 'agreement among raft nodes before linearized reading' (duration: 182.421977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:44.555279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.827892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T05:58:44.555345Z","caller":"traceutil/trace.go:171","msg":"trace[1811168103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5902; }","duration":"186.930854ms","start":"2026-04-20T05:58:44.368398Z","end":"2026-04-20T05:58:44.555329Z","steps":["trace[1811168103] 'agreement among raft nodes before linearized reading' (duration: 185.986909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:58:44.555316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.487968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T05:58:44.555518Z","caller":"traceutil/trace.go:171","msg":"trace[137601292] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5902; }","duration":"284.836857ms","start":"2026-04-20T05:58:44.270654Z","end":"2026-04-20T05:58:44.555491Z","steps":["trace[137601292] 'agreement among raft nodes before linearized reading' (duration: 283.610665ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:59:10.730068Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3008} {"level":"info","ts":"2026-04-20T05:59:10.82446Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3008,"took":"91.6705ms","hash":1861255271,"current-db-size-bytes":58449920,"current-db-size":"58 MB","current-db-size-in-use-bytes":31334400,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-20T05:59:10.824543Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1861255271,"revision":3008,"compact-revision":-1} {"level":"info","ts":"2026-04-20T06:03:08.822108Z","caller":"traceutil/trace.go:171","msg":"trace[1289372723] linearizableReadLoop","detail":"{readStateIndex:8025; appliedIndex:8024; }","duration":"119.59536ms","start":"2026-04-20T06:03:08.702487Z","end":"2026-04-20T06:03:08.822082Z","steps":["trace[1289372723] 'read index received' (duration: 119.481058ms)","trace[1289372723] 'applied index is now lower than readState.Index' (duration: 113.302µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:03:08.822232Z","caller":"traceutil/trace.go:171","msg":"trace[2068771259] transaction","detail":"{read_only:false; response_revision:7744; number_of_response:1; }","duration":"199.937947ms","start":"2026-04-20T06:03:08.62225Z","end":"2026-04-20T06:03:08.822188Z","steps":["trace[2068771259] 'process raft request' (duration: 199.679991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:03:08.822348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.836027ms","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-20T06:03:08.822412Z","caller":"traceutil/trace.go:171","msg":"trace[975152967] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:7744; }","duration":"119.955499ms","start":"2026-04-20T06:03:08.702444Z","end":"2026-04-20T06:03:08.822399Z","steps":["trace[975152967] 'agreement among raft nodes before linearized reading' (duration: 119.757194ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:03:09.149973Z","caller":"traceutil/trace.go:171","msg":"trace[1138977216] transaction","detail":"{read_only:false; response_revision:7746; number_of_response:1; }","duration":"161.051762ms","start":"2026-04-20T06:03:08.988879Z","end":"2026-04-20T06:03:09.149931Z","steps":["trace[1138977216] 'process raft request' (duration: 116.961412ms)","trace[1138977216] 'compare' (duration: 43.960797ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:03:20.543175Z","caller":"traceutil/trace.go:171","msg":"trace[1062442388] transaction","detail":"{read_only:false; response_revision:7837; number_of_response:1; }","duration":"104.443379ms","start":"2026-04-20T06:03:20.438664Z","end":"2026-04-20T06:03:20.543108Z","steps":["trace[1062442388] 'process raft request' (duration: 104.273825ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:03:20.544243Z","caller":"traceutil/trace.go:171","msg":"trace[1747250736] transaction","detail":"{read_only:false; response_revision:7838; number_of_response:1; }","duration":"104.857449ms","start":"2026-04-20T06:03:20.43935Z","end":"2026-04-20T06:03:20.544208Z","steps":["trace[1747250736] 'process raft request' (duration: 104.697175ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:10.736876Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6085} {"level":"info","ts":"2026-04-20T06:04:10.834842Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6085,"took":"95.973519ms","hash":4107990609,"current-db-size-bytes":58449920,"current-db-size":"58 MB","current-db-size-in-use-bytes":23375872,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-20T06:04:10.834922Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4107990609,"revision":6085,"compact-revision":3008} {"level":"info","ts":"2026-04-20T06:04:12.6627Z","caller":"traceutil/trace.go:171","msg":"trace[1752712457] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"370.908809ms","start":"2026-04-20T06:04:12.291756Z","end":"2026-04-20T06:04:12.662665Z","steps":["trace[1752712457] 'process raft request' (duration: 370.676313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:12.662905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.29174Z","time spent":"371.058894ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:04:12.975198Z","caller":"traceutil/trace.go:171","msg":"trace[840852482] transaction","detail":"{read_only:false; response_revision:8313; number_of_response:1; }","duration":"581.53215ms","start":"2026-04-20T06:04:12.393634Z","end":"2026-04-20T06:04:12.975167Z","steps":["trace[840852482] 'process raft request' (duration: 563.520704ms)","trace[840852482] 'compare' (duration: 17.770049ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:04:12.97537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.393607Z","time spent":"581.675534ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:04:12.975674Z","caller":"traceutil/trace.go:171","msg":"trace[231121789] transaction","detail":"{read_only:false; response_revision:8314; number_of_response:1; }","duration":"508.534774ms","start":"2026-04-20T06:04:12.467091Z","end":"2026-04-20T06:04:12.975626Z","steps":["trace[231121789] 'process raft request' (duration: 508.035692ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:12.975628Z","caller":"traceutil/trace.go:171","msg":"trace[862327010] linearizableReadLoop","detail":"{readStateIndex:8613; appliedIndex:8611; }","duration":"562.645981ms","start":"2026-04-20T06:04:12.412899Z","end":"2026-04-20T06:04:12.975545Z","steps":["trace[862327010] 'read index received' (duration: 249.520224ms)","trace[862327010] 'applied index is now lower than readState.Index' (duration: 313.124157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:04:12.976435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.467062Z","time spent":"509.270533ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:04:12.975918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.94863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:04:12.976669Z","caller":"traceutil/trace.go:171","msg":"trace[624847796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8314; }","duration":"563.792693ms","start":"2026-04-20T06:04:12.412845Z","end":"2026-04-20T06:04:12.976637Z","steps":["trace[624847796] 'agreement among raft nodes before linearized reading' (duration: 562.814847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:12.976762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.412824Z","time spent":"563.908445ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T06:04:12.976939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.556991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:04:12.97706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.460196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:04:12.977178Z","caller":"traceutil/trace.go:171","msg":"trace[1598642839] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8314; }","duration":"392.693302ms","start":"2026-04-20T06:04:12.584464Z","end":"2026-04-20T06:04:12.977157Z","steps":["trace[1598642839] 'agreement among raft nodes before linearized reading' (duration: 392.459326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:12.977294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.584445Z","time spent":"392.829446ms","remote":"127.0.0.1:51580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":30,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:04:12.977077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.122998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:04:12.97756Z","caller":"traceutil/trace.go:171","msg":"trace[850021587] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:8314; }","duration":"502.783906ms","start":"2026-04-20T06:04:12.474194Z","end":"2026-04-20T06:04:12.976978Z","steps":["trace[850021587] 'agreement among raft nodes before linearized reading' (duration: 502.656903ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:12.977719Z","caller":"traceutil/trace.go:171","msg":"trace[228739044] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:8314; }","duration":"502.787226ms","start":"2026-04-20T06:04:12.474917Z","end":"2026-04-20T06:04:12.977705Z","steps":["trace[228739044] 'agreement among raft nodes before linearized reading' (duration: 502.033286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:12.978493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.474902Z","time spent":"503.567055ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fd2bj\" "} {"level":"warn","ts":"2026-04-20T06:04:12.97809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:12.474176Z","time spent":"503.567776ms","remote":"127.0.0.1:47226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:04:25.536014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:24.897963Z","time spent":"638.044919ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-20T06:04:25.684075Z","caller":"traceutil/trace.go:171","msg":"trace[434219469] transaction","detail":"{read_only:false; response_revision:8377; number_of_response:1; }","duration":"667.043329ms","start":"2026-04-20T06:04:25.017007Z","end":"2026-04-20T06:04:25.684051Z","steps":["trace[434219469] 'process raft request' (duration: 666.825553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.684227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.016982Z","time spent":"667.164761ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:04:25.684368Z","caller":"traceutil/trace.go:171","msg":"trace[144394172] linearizableReadLoop","detail":"{readStateIndex:8681; appliedIndex:8678; }","duration":"638.425639ms","start":"2026-04-20T06:04:25.045919Z","end":"2026-04-20T06:04:25.684344Z","steps":["trace[144394172] 'read index received' (duration: 489.973905ms)","trace[144394172] 'applied index is now lower than readState.Index' (duration: 148.450554ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:04:25.684473Z","caller":"traceutil/trace.go:171","msg":"trace[343296521] transaction","detail":"{read_only:false; response_revision:8379; number_of_response:1; }","duration":"571.4886ms","start":"2026-04-20T06:04:25.112974Z","end":"2026-04-20T06:04:25.684463Z","steps":["trace[343296521] 'process raft request' (duration: 571.268795ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:25.684451Z","caller":"traceutil/trace.go:171","msg":"trace[1398948437] transaction","detail":"{read_only:false; response_revision:8378; number_of_response:1; }","duration":"646.274801ms","start":"2026-04-20T06:04:25.038155Z","end":"2026-04-20T06:04:25.68443Z","steps":["trace[1398948437] 'process raft request' (duration: 645.846421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.684585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.668247ms","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-20T06:04:25.684611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.112948Z","time spent":"571.562162ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:04:25.68464Z","caller":"traceutil/trace.go:171","msg":"trace[1796761057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8379; }","duration":"638.765599ms","start":"2026-04-20T06:04:25.045859Z","end":"2026-04-20T06:04:25.684624Z","steps":["trace[1796761057] 'agreement among raft nodes before linearized reading' (duration: 638.606944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.684679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.04583Z","time spent":"638.84094ms","remote":"127.0.0.1:55422","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-20T06:04:25.684828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.038129Z","time spent":"646.483628ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:04:25.731347Z","caller":"traceutil/trace.go:171","msg":"trace[811247348] transaction","detail":"{read_only:false; response_revision:8380; number_of_response:1; }","duration":"193.958119ms","start":"2026-04-20T06:04:25.537351Z","end":"2026-04-20T06:04:25.731309Z","steps":["trace[811247348] 'process raft request' (duration: 193.759834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.731463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.751664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-20T06:04:25.731475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.190674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:04:25.731519Z","caller":"traceutil/trace.go:171","msg":"trace[115463168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8380; }","duration":"265.845727ms","start":"2026-04-20T06:04:25.465657Z","end":"2026-04-20T06:04:25.731503Z","steps":["trace[115463168] 'agreement among raft nodes before linearized reading' (duration: 265.676902ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:25.731528Z","caller":"traceutil/trace.go:171","msg":"trace[1699727607] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:8380; }","duration":"676.293447ms","start":"2026-04-20T06:04:25.055222Z","end":"2026-04-20T06:04:25.731515Z","steps":["trace[1699727607] 'agreement among raft nodes before linearized reading' (duration: 676.135952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.731374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.206741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:04:25.731568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.411014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T06:04:25.731648Z","caller":"traceutil/trace.go:171","msg":"trace[1089835753] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8380; }","duration":"680.523777ms","start":"2026-04-20T06:04:25.051107Z","end":"2026-04-20T06:04:25.731631Z","steps":["trace[1089835753] 'agreement among raft nodes before linearized reading' (duration: 680.29208ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:25.731627Z","caller":"traceutil/trace.go:171","msg":"trace[373012269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8380; }","duration":"430.501299ms","start":"2026-04-20T06:04:25.301092Z","end":"2026-04-20T06:04:25.731593Z","steps":["trace[373012269] 'agreement among raft nodes before linearized reading' (duration: 430.17564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.731696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.051093Z","time spent":"680.594548ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T06:04:25.731571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.055202Z","time spent":"676.358749ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fd2bj\" "} {"level":"warn","ts":"2026-04-20T06:04:25.731739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.301063Z","time spent":"430.635923ms","remote":"127.0.0.1:55138","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-20T06:04:25.731709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.170322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:04:25.731854Z","caller":"traceutil/trace.go:171","msg":"trace[1935098610] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:8380; }","duration":"655.413588ms","start":"2026-04-20T06:04:25.076426Z","end":"2026-04-20T06:04:25.731839Z","steps":["trace[1935098610] 'agreement among raft nodes before linearized reading' (duration: 655.005187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.732007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.076413Z","time spent":"655.562251ms","remote":"127.0.0.1:47138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:04:25.732185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.577894ms","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-20T06:04:25.732967Z","caller":"traceutil/trace.go:171","msg":"trace[1003120332] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8380; }","duration":"682.345925ms","start":"2026-04-20T06:04:25.050575Z","end":"2026-04-20T06:04:25.732921Z","steps":["trace[1003120332] 'agreement among raft nodes before linearized reading' (duration: 680.672461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:25.733047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:25.050564Z","time spent":"682.461857ms","remote":"127.0.0.1:55422","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":"warn","ts":"2026-04-20T06:04:54.801975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532005874,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:04:55.61855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.855451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T06:04:55.618652Z","caller":"traceutil/trace.go:171","msg":"trace[1496877508] linearizableReadLoop","detail":"{readStateIndex:8899; appliedIndex:8898; }","duration":"1.317171563s","start":"2026-04-20T06:04:54.301464Z","end":"2026-04-20T06:04:55.618636Z","steps":["trace[1496877508] 'read index received' (duration: 795.080454ms)","trace[1496877508] 'applied index is now lower than readState.Index' (duration: 522.089968ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:04:55.618849Z","caller":"traceutil/trace.go:171","msg":"trace[1827567918] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"1.460299367s","start":"2026-04-20T06:04:54.158537Z","end":"2026-04-20T06:04:55.618836Z","steps":["trace[1827567918] 'process raft request' (duration: 938.070046ms)","trace[1827567918] 'compare' (duration: 521.702818ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:04:55.618918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:54.158505Z","time spent":"1.46038026s","remote":"127.0.0.1:55422","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-20T06:04:55.619199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.317704726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:04:55.619306Z","caller":"traceutil/trace.go:171","msg":"trace[1919356377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8589; }","duration":"1.317865721s","start":"2026-04-20T06:04:54.301411Z","end":"2026-04-20T06:04:55.619276Z","steps":["trace[1919356377] 'agreement among raft nodes before linearized reading' (duration: 1.317613704s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:55.619361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:54.301391Z","time spent":"1.317961353s","remote":"127.0.0.1:55136","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-20T06:04:55.732418Z","caller":"traceutil/trace.go:171","msg":"trace[1671182526] linearizableReadLoop","detail":"{readStateIndex:8900; appliedIndex:8899; }","duration":"113.712944ms","start":"2026-04-20T06:04:55.618679Z","end":"2026-04-20T06:04:55.732392Z","steps":["trace[1671182526] 'read index received' (duration: 113.411417ms)","trace[1671182526] 'applied index is now lower than readState.Index' (duration: 300.497µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:04:55.732578Z","caller":"traceutil/trace.go:171","msg":"trace[119562552] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"362.632541ms","start":"2026-04-20T06:04:55.369901Z","end":"2026-04-20T06:04:55.732533Z","steps":["trace[119562552] 'process raft request' (duration: 362.311983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:55.732673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.500827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T06:04:55.732709Z","caller":"traceutil/trace.go:171","msg":"trace[1816435018] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:8590; }","duration":"833.599929ms","start":"2026-04-20T06:04:54.899099Z","end":"2026-04-20T06:04:55.732699Z","steps":["trace[1816435018] 'agreement among raft nodes before linearized reading' (duration: 833.433464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:55.732751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:54.899076Z","time spent":"833.666971ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"warn","ts":"2026-04-20T06:04:55.732761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.265439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:04:55.732769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:55.369842Z","time spent":"362.832087ms","remote":"127.0.0.1:55326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19368,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:04:55.73283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.505448ms","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-04-20T06:04:55.732795Z","caller":"traceutil/trace.go:171","msg":"trace[1244765858] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8590; }","duration":"112.3318ms","start":"2026-04-20T06:04:55.620454Z","end":"2026-04-20T06:04:55.732786Z","steps":["trace[1244765858] 'agreement among raft nodes before linearized reading' (duration: 112.272219ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:55.732913Z","caller":"traceutil/trace.go:171","msg":"trace[142809450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8590; }","duration":"828.639462ms","start":"2026-04-20T06:04:54.904254Z","end":"2026-04-20T06:04:55.732893Z","steps":["trace[142809450] 'agreement among raft nodes before linearized reading' (duration: 828.284012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:55.732949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:54.904229Z","time spent":"828.713583ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T06:04:55.73319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.949602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:04:55.733887Z","caller":"traceutil/trace.go:171","msg":"trace[90147488] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:8590; }","duration":"728.162188ms","start":"2026-04-20T06:04:55.005161Z","end":"2026-04-20T06:04:55.733323Z","steps":["trace[90147488] 'agreement among raft nodes before linearized reading' (duration: 727.631644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:04:55.733937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:04:55.005144Z","time spent":"728.782723ms","remote":"127.0.0.1:55518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:04:58.03304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.436954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:04:58.03314Z","caller":"traceutil/trace.go:171","msg":"trace[971209224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8604; }","duration":"114.612758ms","start":"2026-04-20T06:04:57.918491Z","end":"2026-04-20T06:04:58.033104Z","steps":["trace[971209224] 'range keys from in-memory index tree' (duration: 114.244959ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:58.173446Z","caller":"traceutil/trace.go:171","msg":"trace[1223263824] transaction","detail":"{read_only:false; response_revision:8605; number_of_response:1; }","duration":"135.55626ms","start":"2026-04-20T06:04:58.037863Z","end":"2026-04-20T06:04:58.173419Z","steps":["trace[1223263824] 'process raft request' (duration: 135.291063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:58.215124Z","caller":"traceutil/trace.go:171","msg":"trace[1666213022] transaction","detail":"{read_only:false; response_revision:8606; number_of_response:1; }","duration":"177.199834ms","start":"2026-04-20T06:04:58.037898Z","end":"2026-04-20T06:04:58.215097Z","steps":["trace[1666213022] 'process raft request' (duration: 176.831815ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:58.215164Z","caller":"traceutil/trace.go:171","msg":"trace[358304244] transaction","detail":"{read_only:false; response_revision:8607; number_of_response:1; }","duration":"177.223676ms","start":"2026-04-20T06:04:58.037915Z","end":"2026-04-20T06:04:58.215139Z","steps":["trace[358304244] 'process raft request' (duration: 177.069111ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:58.215149Z","caller":"traceutil/trace.go:171","msg":"trace[476707578] transaction","detail":"{read_only:false; response_revision:8608; number_of_response:1; }","duration":"177.133402ms","start":"2026-04-20T06:04:58.037984Z","end":"2026-04-20T06:04:58.215117Z","steps":["trace[476707578] 'process raft request' (duration: 177.087161ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:04:58.344197Z","caller":"traceutil/trace.go:171","msg":"trace[1134811371] transaction","detail":"{read_only:false; response_revision:8609; number_of_response:1; }","duration":"145.69448ms","start":"2026-04-20T06:04:58.19848Z","end":"2026-04-20T06:04:58.344174Z","steps":["trace[1134811371] 'process raft request' (duration: 101.627383ms)","trace[1134811371] 'compare' (duration: 43.958585ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:08.227562Z","caller":"traceutil/trace.go:171","msg":"trace[2054860226] linearizableReadLoop","detail":"{readStateIndex:9020; appliedIndex:9019; }","duration":"216.719495ms","start":"2026-04-20T06:05:08.010815Z","end":"2026-04-20T06:05:08.227535Z","steps":["trace[2054860226] 'read index received' (duration: 216.537931ms)","trace[2054860226] 'applied index is now lower than readState.Index' (duration: 180.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:08.227701Z","caller":"traceutil/trace.go:171","msg":"trace[1214076044] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"217.025623ms","start":"2026-04-20T06:05:08.010665Z","end":"2026-04-20T06:05:08.227691Z","steps":["trace[1214076044] 'process raft request' (duration: 216.705915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.228308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.666393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:05:08.228414Z","caller":"traceutil/trace.go:171","msg":"trace[314437190] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:8703; }","duration":"135.831397ms","start":"2026-04-20T06:05:08.092551Z","end":"2026-04-20T06:05:08.228382Z","steps":["trace[314437190] 'agreement among raft nodes before linearized reading' (duration: 135.270482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.228517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.685279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wh88d\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-20T06:05:08.228692Z","caller":"traceutil/trace.go:171","msg":"trace[751745249] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wh88d; range_end:; response_count:1; response_revision:8703; }","duration":"217.869075ms","start":"2026-04-20T06:05:08.010797Z","end":"2026-04-20T06:05:08.228666Z","steps":["trace[751745249] 'agreement among raft nodes before linearized reading' (duration: 217.430113ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.562476Z","caller":"traceutil/trace.go:171","msg":"trace[851894367] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"329.961367ms","start":"2026-04-20T06:05:08.23248Z","end":"2026-04-20T06:05:08.562441Z","steps":["trace[851894367] 'process raft request' (duration: 291.652299ms)","trace[851894367] 'compare' (duration: 37.699113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:05:08.562662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.232451Z","time spent":"330.113662ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:05:08.562898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.347748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228759"} {"level":"info","ts":"2026-04-20T06:05:08.562964Z","caller":"traceutil/trace.go:171","msg":"trace[1539143469] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8704; }","duration":"330.45314ms","start":"2026-04-20T06:05:08.232498Z","end":"2026-04-20T06:05:08.562951Z","steps":["trace[1539143469] 'agreement among raft nodes before linearized reading' (duration: 330.081431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.563004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.232483Z","time spent":"330.511772ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228782,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"info","ts":"2026-04-20T06:05:08.562544Z","caller":"traceutil/trace.go:171","msg":"trace[1848314239] linearizableReadLoop","detail":"{readStateIndex:9021; appliedIndex:9020; }","duration":"329.741742ms","start":"2026-04-20T06:05:08.232535Z","end":"2026-04-20T06:05:08.562277Z","steps":["trace[1848314239] 'read index received' (duration: 291.574037ms)","trace[1848314239] 'applied index is now lower than readState.Index' (duration: 38.166175ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:08.639293Z","caller":"traceutil/trace.go:171","msg":"trace[1170314670] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"403.405413ms","start":"2026-04-20T06:05:08.235857Z","end":"2026-04-20T06:05:08.639262Z","steps":["trace[1170314670] 'process raft request' (duration: 403.168318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.639455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.235838Z","time spent":"403.534396ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4638,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:05:08.639644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.57807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T06:05:08.639718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.704229ms","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-04-20T06:05:08.639778Z","caller":"traceutil/trace.go:171","msg":"trace[750317488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8707; }","duration":"375.796441ms","start":"2026-04-20T06:05:08.263966Z","end":"2026-04-20T06:05:08.639763Z","steps":["trace[750317488] 'agreement among raft nodes before linearized reading' (duration: 375.657167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.639821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.263948Z","time spent":"375.864783ms","remote":"127.0.0.1:55422","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-20T06:05:08.639841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.859278ms","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-20T06:05:08.639881Z","caller":"traceutil/trace.go:171","msg":"trace[230338213] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8707; }","duration":"376.919349ms","start":"2026-04-20T06:05:08.262952Z","end":"2026-04-20T06:05:08.639872Z","steps":["trace[230338213] 'agreement among raft nodes before linearized reading' (duration: 376.782326ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.639726Z","caller":"traceutil/trace.go:171","msg":"trace[847471115] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8707; }","duration":"381.705623ms","start":"2026-04-20T06:05:08.258003Z","end":"2026-04-20T06:05:08.639709Z","steps":["trace[847471115] 'agreement among raft nodes before linearized reading' (duration: 381.480137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.639918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.262943Z","time spent":"376.96662ms","remote":"127.0.0.1:55422","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-20T06:05:08.639899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.02298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:08.640106Z","caller":"traceutil/trace.go:171","msg":"trace[1374836321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8707; }","duration":"306.293967ms","start":"2026-04-20T06:05:08.333794Z","end":"2026-04-20T06:05:08.640088Z","steps":["trace[1374836321] 'agreement among raft nodes before linearized reading' (duration: 305.901947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.639955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.257976Z","time spent":"381.95121ms","remote":"127.0.0.1:55422","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":"warn","ts":"2026-04-20T06:05:08.639903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.116791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5732"} {"level":"info","ts":"2026-04-20T06:05:08.640236Z","caller":"traceutil/trace.go:171","msg":"trace[1306025310] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8707; }","duration":"151.531891ms","start":"2026-04-20T06:05:08.488681Z","end":"2026-04-20T06:05:08.640213Z","steps":["trace[1306025310] 'agreement among raft nodes before linearized reading' (duration: 150.913736ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.640037Z","caller":"traceutil/trace.go:171","msg":"trace[1106133719] transaction","detail":"{read_only:false; response_revision:8707; number_of_response:1; }","duration":"151.954442ms","start":"2026-04-20T06:05:08.487904Z","end":"2026-04-20T06:05:08.639858Z","steps":["trace[1106133719] 'process raft request' (duration: 151.48441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.640172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:08.333769Z","time spent":"306.386678ms","remote":"127.0.0.1:55136","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-20T06:05:08.640096Z","caller":"traceutil/trace.go:171","msg":"trace[8252942] transaction","detail":"{read_only:false; response_revision:8706; number_of_response:1; }","duration":"267.596928ms","start":"2026-04-20T06:05:08.372464Z","end":"2026-04-20T06:05:08.64006Z","steps":["trace[8252942] 'process raft request' (duration: 266.724236ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.776205Z","caller":"traceutil/trace.go:171","msg":"trace[718790073] transaction","detail":"{read_only:false; response_revision:8709; number_of_response:1; }","duration":"130.14535ms","start":"2026-04-20T06:05:08.646026Z","end":"2026-04-20T06:05:08.776171Z","steps":["trace[718790073] 'process raft request' (duration: 129.814931ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.776257Z","caller":"traceutil/trace.go:171","msg":"trace[801339053] linearizableReadLoop","detail":"{readStateIndex:9028; appliedIndex:9025; }","duration":"114.794143ms","start":"2026-04-20T06:05:08.661419Z","end":"2026-04-20T06:05:08.776213Z","steps":["trace[801339053] 'read index received' (duration: 114.245209ms)","trace[801339053] 'applied index is now lower than readState.Index' (duration: 547.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:05:08.776573Z","caller":"traceutil/trace.go:171","msg":"trace[184550491] transaction","detail":"{read_only:false; response_revision:8711; number_of_response:1; }","duration":"122.84275ms","start":"2026-04-20T06:05:08.653702Z","end":"2026-04-20T06:05:08.776545Z","steps":["trace[184550491] 'process raft request' (duration: 122.40323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:08.776667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.210194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:08.776779Z","caller":"traceutil/trace.go:171","msg":"trace[1515962228] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8711; }","duration":"115.383529ms","start":"2026-04-20T06:05:08.661376Z","end":"2026-04-20T06:05:08.776759Z","steps":["trace[1515962228] 'agreement among raft nodes before linearized reading' (duration: 115.197063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:08.77678Z","caller":"traceutil/trace.go:171","msg":"trace[1218991764] transaction","detail":"{read_only:false; response_revision:8710; number_of_response:1; }","duration":"128.815845ms","start":"2026-04-20T06:05:08.647931Z","end":"2026-04-20T06:05:08.776747Z","steps":["trace[1218991764] 'process raft request' (duration: 128.117367ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:09.817628Z","caller":"traceutil/trace.go:171","msg":"trace[731542167] linearizableReadLoop","detail":"{readStateIndex:9031; appliedIndex:9030; }","duration":"371.423658ms","start":"2026-04-20T06:05:09.446184Z","end":"2026-04-20T06:05:09.817608Z","steps":["trace[731542167] 'read index received' (duration: 371.151471ms)","trace[731542167] 'applied index is now lower than readState.Index' (duration: 271.287µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:05:09.817787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.585671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:09.817773Z","caller":"traceutil/trace.go:171","msg":"trace[1653379873] transaction","detail":"{read_only:false; response_revision:8714; number_of_response:1; }","duration":"557.948073ms","start":"2026-04-20T06:05:09.259787Z","end":"2026-04-20T06:05:09.817735Z","steps":["trace[1653379873] 'process raft request' (duration: 557.683416ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:09.81785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.690465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:05:09.817871Z","caller":"traceutil/trace.go:171","msg":"trace[1161991745] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8714; }","duration":"359.711136ms","start":"2026-04-20T06:05:09.458155Z","end":"2026-04-20T06:05:09.817866Z","steps":["trace[1161991745] 'agreement among raft nodes before linearized reading' (duration: 359.679645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:09.817895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.458128Z","time spent":"359.761787ms","remote":"127.0.0.1:55136","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-20T06:05:09.817944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.259768Z","time spent":"558.086478ms","remote":"127.0.0.1:58788","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7439,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:05:09.817818Z","caller":"traceutil/trace.go:171","msg":"trace[654593865] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8714; }","duration":"371.675865ms","start":"2026-04-20T06:05:09.446131Z","end":"2026-04-20T06:05:09.817807Z","steps":["trace[654593865] 'agreement among raft nodes before linearized reading' (duration: 371.599092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:09.8182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.44611Z","time spent":"371.986073ms","remote":"127.0.0.1:55374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:05:10.16614Z","caller":"traceutil/trace.go:171","msg":"trace[1160640094] transaction","detail":"{read_only:false; response_revision:8717; number_of_response:1; }","duration":"301.806281ms","start":"2026-04-20T06:05:09.864294Z","end":"2026-04-20T06:05:10.1661Z","steps":["trace[1160640094] 'process raft request' (duration: 301.73946ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:05:10.166227Z","caller":"traceutil/trace.go:171","msg":"trace[1441585104] transaction","detail":"{read_only:false; response_revision:8716; number_of_response:1; }","duration":"309.425798ms","start":"2026-04-20T06:05:09.856747Z","end":"2026-04-20T06:05:10.166172Z","steps":["trace[1441585104] 'process raft request' (duration: 309.044939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:10.166375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.864279Z","time spent":"301.972965ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:05:10.166467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.856716Z","time spent":"309.617512ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:05:10.188627Z","caller":"traceutil/trace.go:171","msg":"trace[1978199344] transaction","detail":"{read_only:false; response_revision:8718; number_of_response:1; }","duration":"312.277512ms","start":"2026-04-20T06:05:09.87632Z","end":"2026-04-20T06:05:10.188597Z","steps":["trace[1978199344] 'process raft request' (duration: 312.089897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:05:10.189651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:05:09.876289Z","time spent":"313.213365ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:05:36.746519Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002472.wal"} {"level":"warn","ts":"2026-04-20T06:06:18.614397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532008110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:19.11461Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532008110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:19.615535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532008110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:20.116422Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532008110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:20.301361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687186753s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T06:06:20.301536Z","caller":"traceutil/trace.go:171","msg":"trace[466548266] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.687409667s","start":"2026-04-20T06:06:18.614104Z","end":"2026-04-20T06:06:20.301514Z","steps":["trace[466548266] 'agreement among raft nodes before linearized reading' (duration: 1.687215883s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.301596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.614091Z","time spent":"1.68749255s","remote":"127.0.0.1:55136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 06:06:20 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T06:06:20.616859Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532008110,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:20.92334Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.00334089s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T06:06:20.924159Z","caller":"traceutil/trace.go:171","msg":"trace[305740090] transaction","detail":"{read_only:false; response_revision:9400; number_of_response:1; }","duration":"3.004211472s","start":"2026-04-20T06:06:17.91992Z","end":"2026-04-20T06:06:20.924132Z","steps":["trace[305740090] 'process raft request' (duration: 3.003929215s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.92438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.919911Z","time spent":"3.004358836s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:20.927403Z","caller":"traceutil/trace.go:171","msg":"trace[936614636] transaction","detail":"{read_only:false; response_revision:9401; number_of_response:1; }","duration":"3.007282202s","start":"2026-04-20T06:06:17.920092Z","end":"2026-04-20T06:06:20.927375Z","steps":["trace[936614636] 'process raft request' (duration: 3.007025486s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.927421Z","caller":"traceutil/trace.go:171","msg":"trace[510201391] transaction","detail":"{read_only:false; response_revision:9403; number_of_response:1; }","duration":"3.007152947s","start":"2026-04-20T06:06:17.920238Z","end":"2026-04-20T06:06:20.927391Z","steps":["trace[510201391] 'process raft request' (duration: 3.007070865s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.927576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920074Z","time spent":"3.007393914s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:20.927566Z","caller":"traceutil/trace.go:171","msg":"trace[812459094] transaction","detail":"{read_only:false; response_revision:9402; number_of_response:1; }","duration":"3.007199939s","start":"2026-04-20T06:06:17.92022Z","end":"2026-04-20T06:06:20.92742Z","steps":["trace[812459094] 'process raft request' (duration: 3.007044445s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.92765Z","caller":"traceutil/trace.go:171","msg":"trace[1321576470] transaction","detail":"{read_only:false; response_revision:9404; number_of_response:1; }","duration":"3.007327522s","start":"2026-04-20T06:06:17.920302Z","end":"2026-04-20T06:06:20.92763Z","steps":["trace[1321576470] 'process raft request' (duration: 3.007046025s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.927665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920233Z","time spent":"3.00724506s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:20.927736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920203Z","time spent":"3.007447805s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:20.92775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920294Z","time spent":"3.007405334s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:20.930453Z","caller":"traceutil/trace.go:171","msg":"trace[1315028395] linearizableReadLoop","detail":"{readStateIndex:9741; appliedIndex:9735; }","duration":"3.01034199s","start":"2026-04-20T06:06:17.920092Z","end":"2026-04-20T06:06:20.930434Z","steps":["trace[1315028395] 'read index received' (duration: 3.003580857s)","trace[1315028395] 'applied index is now lower than readState.Index' (duration: 6.759713ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:06:20.930627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.473318044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:20.930649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.720097232s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:20.93069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.59837038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:20.930695Z","caller":"traceutil/trace.go:171","msg":"trace[948185233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9404; }","duration":"1.473419625s","start":"2026-04-20T06:06:19.457264Z","end":"2026-04-20T06:06:20.930684Z","steps":["trace[948185233] 'agreement among raft nodes before linearized reading' (duration: 1.473325553s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.863311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:20.930715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.010518895s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T06:06:20.930747Z","caller":"traceutil/trace.go:171","msg":"trace[863820159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9404; }","duration":"628.941653ms","start":"2026-04-20T06:06:20.301792Z","end":"2026-04-20T06:06:20.930733Z","steps":["trace[863820159] 'agreement among raft nodes before linearized reading' (duration: 628.881131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:20.301774Z","time spent":"629.012424ms","remote":"127.0.0.1:55138","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-20T06:06:20.930785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.163963567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-7dff694fcc-fs44k.18a7fb72dc6e0708\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-20T06:06:20.930854Z","caller":"traceutil/trace.go:171","msg":"trace[1761931515] range","detail":"{range_begin:/registry/events/openstack/barbican-api-7dff694fcc-fs44k.18a7fb72dc6e0708; range_end:; response_count:1; response_revision:9404; }","duration":"2.164073749s","start":"2026-04-20T06:06:18.766765Z","end":"2026-04-20T06:06:20.930838Z","steps":["trace[1761931515] 'agreement among raft nodes before linearized reading' (duration: 2.163816573s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.087063813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:06:20.93089Z","caller":"traceutil/trace.go:171","msg":"trace[326284317] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:9404; }","duration":"2.087130654s","start":"2026-04-20T06:06:18.843751Z","end":"2026-04-20T06:06:20.930882Z","steps":["trace[326284317] 'agreement among raft nodes before linearized reading' (duration: 2.087069183s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.766752Z","time spent":"2.164132831s","remote":"127.0.0.1:55214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-7dff694fcc-fs44k.18a7fb72dc6e0708\" "} {"level":"warn","ts":"2026-04-20T06:06:20.930892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.3167608s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T06:06:20.930931Z","caller":"traceutil/trace.go:171","msg":"trace[544762723] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9404; }","duration":"2.316849452s","start":"2026-04-20T06:06:18.614072Z","end":"2026-04-20T06:06:20.930921Z","steps":["trace[544762723] 'agreement among raft nodes before linearized reading' (duration: 2.316692118s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.843733Z","time spent":"2.087177055s","remote":"127.0.0.1:55398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":2,"response size":30,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:20.930971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.614053Z","time spent":"2.316910034s","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T06:06:20.931062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.004811317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T06:06:20.931096Z","caller":"traceutil/trace.go:171","msg":"trace[210702196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9404; }","duration":"3.004858208s","start":"2026-04-20T06:06:17.92623Z","end":"2026-04-20T06:06:20.931088Z","steps":["trace[210702196] 'agreement among raft nodes before linearized reading' (duration: 3.00453199s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.930737Z","caller":"traceutil/trace.go:171","msg":"trace[1144163751] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:9404; }","duration":"1.598455202s","start":"2026-04-20T06:06:19.332271Z","end":"2026-04-20T06:06:20.930726Z","steps":["trace[1144163751] 'agreement among raft nodes before linearized reading' (duration: 1.59837347s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.930792Z","caller":"traceutil/trace.go:171","msg":"trace[1056781714] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9404; }","duration":"3.010617388s","start":"2026-04-20T06:06:17.920159Z","end":"2026-04-20T06:06:20.930776Z","steps":["trace[1056781714] 'agreement among raft nodes before linearized reading' (duration: 3.010404731s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.930741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:19.457251Z","time spent":"1.473483888s","remote":"127.0.0.1:55136","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-20T06:06:20.931201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920116Z","time spent":"3.011055938s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T06:06:20.931244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011056828s","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-20T06:06:20.931241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011022777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-04-20T06:06:20.931241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.005393932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:291536"} {"level":"info","ts":"2026-04-20T06:06:20.931277Z","caller":"traceutil/trace.go:171","msg":"trace[1633877373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9404; }","duration":"3.01109947s","start":"2026-04-20T06:06:17.920171Z","end":"2026-04-20T06:06:20.93127Z","steps":["trace[1633877373] 'agreement among raft nodes before linearized reading' (duration: 3.011013287s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.931292Z","caller":"traceutil/trace.go:171","msg":"trace[1508418294] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:9404; }","duration":"3.01108797s","start":"2026-04-20T06:06:17.920191Z","end":"2026-04-20T06:06:20.931279Z","steps":["trace[1508418294] 'agreement among raft nodes before linearized reading' (duration: 3.010971926s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:20.931306Z","caller":"traceutil/trace.go:171","msg":"trace[1252627401] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9404; }","duration":"3.005461924s","start":"2026-04-20T06:06:17.925829Z","end":"2026-04-20T06:06:20.931291Z","steps":["trace[1252627401] 'agreement among raft nodes before linearized reading' (duration: 3.004986392s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.931299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920165Z","time spent":"3.01112898s","remote":"127.0.0.1:55422","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-20T06:06:20.931327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920185Z","time spent":"3.011133771s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-20T06:06:20.93114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:19.332254Z","time spent":"1.598875872s","remote":"127.0.0.1:48544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:20.931356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.925805Z","time spent":"3.005536246s","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":31,"response size":291559,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-04-20T06:06:20.930797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126540534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:20.931428Z","caller":"traceutil/trace.go:171","msg":"trace[1116305778] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:9404; }","duration":"1.127239731s","start":"2026-04-20T06:06:19.804175Z","end":"2026-04-20T06:06:20.931415Z","steps":["trace[1116305778] 'agreement among raft nodes before linearized reading' (duration: 1.126583684s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.931414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.314319038s","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-20T06:06:20.931531Z","caller":"traceutil/trace.go:171","msg":"trace[590825576] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9404; }","duration":"2.314501251s","start":"2026-04-20T06:06:18.617004Z","end":"2026-04-20T06:06:20.931505Z","steps":["trace[590825576] 'agreement among raft nodes before linearized reading' (duration: 2.31408129s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.931587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.616989Z","time spent":"2.314588514s","remote":"127.0.0.1:55422","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-20T06:06:20.930733Z","caller":"traceutil/trace.go:171","msg":"trace[1035706804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:9404; }","duration":"1.720225205s","start":"2026-04-20T06:06:19.210493Z","end":"2026-04-20T06:06:20.930718Z","steps":["trace[1035706804] 'agreement among raft nodes before linearized reading' (duration: 1.720112443s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.931464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:19.804152Z","time spent":"1.127300663s","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:20.931163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.926225Z","time spent":"3.00492923s","remote":"127.0.0.1:55422","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":"warn","ts":"2026-04-20T06:06:20.931798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.010550796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-20T06:06:20.931757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:19.210472Z","time spent":"1.721256941s","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:20.931636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.919971297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:20.931988Z","caller":"traceutil/trace.go:171","msg":"trace[454002578] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:9404; }","duration":"2.920750898s","start":"2026-04-20T06:06:18.011227Z","end":"2026-04-20T06:06:20.931978Z","steps":["trace[454002578] 'agreement among raft nodes before linearized reading' (duration: 2.919993798s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.932099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:18.011207Z","time spent":"2.920880652s","remote":"127.0.0.1:53296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:06:20.932398Z","caller":"traceutil/trace.go:171","msg":"trace[904675828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9404; }","duration":"3.011813639s","start":"2026-04-20T06:06:17.920064Z","end":"2026-04-20T06:06:20.931878Z","steps":["trace[904675828] 'agreement among raft nodes before linearized reading' (duration: 3.010471104s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:20.932502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:17.920054Z","time spent":"3.012429774s","remote":"127.0.0.1:55422","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-04-20T06:06:57.135061Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4594e5f716bad646","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T06:06:57.142025Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T06:06:57.142112Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T06:08:31.520858Z","caller":"traceutil/trace.go:171","msg":"trace[1087465608] transaction","detail":"{read_only:false; response_revision:10300; number_of_response:1; }","duration":"124.63333ms","start":"2026-04-20T06:08:31.396189Z","end":"2026-04-20T06:08:31.520822Z","steps":["trace[1087465608] 'process raft request' (duration: 124.405744ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:10.745013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8305} {"level":"info","ts":"2026-04-20T06:09:10.825293Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8305,"took":"78.065267ms","hash":879030482,"current-db-size-bytes":58449920,"current-db-size":"58 MB","current-db-size-in-use-bytes":24821760,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T06:09:10.825383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":879030482,"revision":8305,"compact-revision":6085} {"level":"info","ts":"2026-04-20T06:10:38.425912Z","caller":"traceutil/trace.go:171","msg":"trace[1649390495] transaction","detail":"{read_only:false; response_revision:11066; number_of_response:1; }","duration":"101.357696ms","start":"2026-04-20T06:10:38.324506Z","end":"2026-04-20T06:10:38.425863Z","steps":["trace[1649390495] 'process raft request' (duration: 100.998418ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:14:10.752326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10505} {"level":"info","ts":"2026-04-20T06:14:10.831234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10505,"took":"76.489726ms","hash":2322940783,"current-db-size-bytes":58449920,"current-db-size":"58 MB","current-db-size-in-use-bytes":20869120,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T06:14:10.831311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2322940783,"revision":10505,"compact-revision":8305} {"level":"info","ts":"2026-04-20T06:14:51.813863Z","caller":"traceutil/trace.go:171","msg":"trace[621814473] transaction","detail":"{read_only:false; response_revision:12431; number_of_response:1; }","duration":"146.61542ms","start":"2026-04-20T06:14:51.667218Z","end":"2026-04-20T06:14:51.813833Z","steps":["trace[621814473] 'process raft request' (duration: 144.876955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:00.382395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.065099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:15:00.382487Z","caller":"traceutil/trace.go:171","msg":"trace[707061673] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:12474; }","duration":"232.228344ms","start":"2026-04-20T06:15:00.15024Z","end":"2026-04-20T06:15:00.382469Z","steps":["trace[707061673] 'count revisions from in-memory index tree' (duration: 231.944567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.552475Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440201723532016498,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:15:01.736092Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.234978615s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T06:15:01.738427Z","caller":"traceutil/trace.go:171","msg":"trace[375455673] transaction","detail":"{read_only:false; response_revision:12481; number_of_response:1; }","duration":"180.559656ms","start":"2026-04-20T06:15:01.557851Z","end":"2026-04-20T06:15:01.738411Z","steps":["trace[375455673] 'process raft request' (duration: 180.531566ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.738584Z","caller":"traceutil/trace.go:171","msg":"trace[791593881] transaction","detail":"{read_only:false; response_revision:12478; number_of_response:1; }","duration":"180.777672ms","start":"2026-04-20T06:15:01.557799Z","end":"2026-04-20T06:15:01.738577Z","steps":["trace[791593881] 'process raft request' (duration: 180.457293ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.738533Z","caller":"traceutil/trace.go:171","msg":"trace[1259367547] linearizableReadLoop","detail":"{readStateIndex:12929; appliedIndex:12928; }","duration":"1.043920126s","start":"2026-04-20T06:15:00.694555Z","end":"2026-04-20T06:15:01.738475Z","steps":["trace[1259367547] 'read index received' (duration: 1.041836112s)","trace[1259367547] 'applied index is now lower than readState.Index' (duration: 2.081484ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:15:01.738834Z","caller":"traceutil/trace.go:171","msg":"trace[1874662537] transaction","detail":"{read_only:false; response_revision:12479; number_of_response:1; }","duration":"181.011088ms","start":"2026-04-20T06:15:01.557816Z","end":"2026-04-20T06:15:01.738827Z","steps":["trace[1874662537] 'process raft request' (duration: 180.518255ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.738904Z","caller":"traceutil/trace.go:171","msg":"trace[2074587887] transaction","detail":"{read_only:false; response_revision:12480; number_of_response:1; }","duration":"181.048438ms","start":"2026-04-20T06:15:01.557849Z","end":"2026-04-20T06:15:01.738897Z","steps":["trace[2074587887] 'process raft request' (duration: 180.513524ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.738978Z","caller":"traceutil/trace.go:171","msg":"trace[337627018] transaction","detail":"{read_only:false; response_revision:12477; number_of_response:1; }","duration":"1.237920221s","start":"2026-04-20T06:15:00.501042Z","end":"2026-04-20T06:15:01.738962Z","steps":["trace[337627018] 'process raft request' (duration: 1.235246253s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.739134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:00.501032Z","time spent":"1.237992352s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:15:01.739236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044655925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"warn","ts":"2026-04-20T06:15:01.739271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.434198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:15:01.739292Z","caller":"traceutil/trace.go:171","msg":"trace[548323737] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:12481; }","duration":"989.470299ms","start":"2026-04-20T06:15:00.749816Z","end":"2026-04-20T06:15:01.739286Z","steps":["trace[548323737] 'agreement among raft nodes before linearized reading' (duration: 989.365916ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.739301Z","caller":"traceutil/trace.go:171","msg":"trace[1714179657] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:12481; }","duration":"1.044766748s","start":"2026-04-20T06:15:00.694517Z","end":"2026-04-20T06:15:01.739283Z","steps":["trace[1714179657] 'agreement among raft nodes before linearized reading' (duration: 1.044575963s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.739314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:00.749809Z","time spent":"989.500169ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fd2bj\" "} {"level":"warn","ts":"2026-04-20T06:15:01.739337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:00.694498Z","time spent":"1.04483092s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-20T06:15:01.739412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.646149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:15:01.739431Z","caller":"traceutil/trace.go:171","msg":"trace[221582728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12481; }","duration":"180.69274ms","start":"2026-04-20T06:15:01.558733Z","end":"2026-04-20T06:15:01.739426Z","steps":["trace[221582728] 'agreement among raft nodes before linearized reading' (duration: 180.66221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.739502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.389443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T06:15:01.739535Z","caller":"traceutil/trace.go:171","msg":"trace[1321730511] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12481; }","duration":"898.443995ms","start":"2026-04-20T06:15:00.841082Z","end":"2026-04-20T06:15:01.739526Z","steps":["trace[1321730511] 'agreement among raft nodes before linearized reading' (duration: 898.350692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.739561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:00.841068Z","time spent":"898.486865ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-20T06:15:01.985593Z","caller":"traceutil/trace.go:171","msg":"trace[936975598] linearizableReadLoop","detail":"{readStateIndex:12934; appliedIndex:12933; }","duration":"238.839985ms","start":"2026-04-20T06:15:01.746721Z","end":"2026-04-20T06:15:01.985561Z","steps":["trace[936975598] 'read index received' (duration: 237.435659ms)","trace[936975598] 'applied index is now lower than readState.Index' (duration: 1.402996ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:15:01.986028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.291236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T06:15:01.986099Z","caller":"traceutil/trace.go:171","msg":"trace[1925476644] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:12482; }","duration":"239.427729ms","start":"2026-04-20T06:15:01.746657Z","end":"2026-04-20T06:15:01.986085Z","steps":["trace[1925476644] 'agreement among raft nodes before linearized reading' (duration: 239.03537ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.985642Z","caller":"traceutil/trace.go:171","msg":"trace[969429310] transaction","detail":"{read_only:false; response_revision:12482; number_of_response:1; }","duration":"240.031705ms","start":"2026-04-20T06:15:01.745554Z","end":"2026-04-20T06:15:01.985585Z","steps":["trace[969429310] 'process raft request' (duration: 238.68024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:01.986202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.661453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T06:15:01.986139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.051964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T06:15:01.986394Z","caller":"traceutil/trace.go:171","msg":"trace[1731555327] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12482; }","duration":"110.349843ms","start":"2026-04-20T06:15:01.876029Z","end":"2026-04-20T06:15:01.986379Z","steps":["trace[1731555327] 'agreement among raft nodes before linearized reading' (duration: 109.933762ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:01.986317Z","caller":"traceutil/trace.go:171","msg":"trace[367197494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12482; }","duration":"112.823867ms","start":"2026-04-20T06:15:01.873468Z","end":"2026-04-20T06:15:01.986292Z","steps":["trace[367197494] 'agreement among raft nodes before linearized reading' (duration: 112.499918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.496945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.805598855s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5127"} {"level":"info","ts":"2026-04-20T06:15:04.497068Z","caller":"traceutil/trace.go:171","msg":"trace[1638779126] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:12484; }","duration":"1.805760949s","start":"2026-04-20T06:15:02.69128Z","end":"2026-04-20T06:15:04.497041Z","steps":["trace[1638779126] 'range keys from in-memory index tree' (duration: 1.805373928s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.497125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.691275Z","time spent":"1.80583944s","remote":"127.0.0.1:55396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":5150,"request content":"key:\"/registry/jobs/openstack/staffeln-db-sync\" "} {"level":"warn","ts":"2026-04-20T06:15:04.498486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.808480489s","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-20T06:15:04.498557Z","caller":"traceutil/trace.go:171","msg":"trace[1200003586] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12484; }","duration":"1.808597022s","start":"2026-04-20T06:15:02.689942Z","end":"2026-04-20T06:15:04.498539Z","steps":["trace[1200003586] 'range keys from in-memory index tree' (duration: 1.808340276s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.498632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.68993Z","time spent":"1.808681414s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T06:15:04.498777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809233379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T06:15:04.498825Z","caller":"traceutil/trace.go:171","msg":"trace[1283842195] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12484; }","duration":"1.809309911s","start":"2026-04-20T06:15:02.689502Z","end":"2026-04-20T06:15:04.498812Z","steps":["trace[1283842195] 'range keys from in-memory index tree' (duration: 1.809100206s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.498858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.689486Z","time spent":"1.809363092s","remote":"127.0.0.1:55422","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":"warn","ts":"2026-04-20T06:15:04.499667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.065029741s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T06:15:04.499879Z","caller":"traceutil/trace.go:171","msg":"trace[1819594077] transaction","detail":"{read_only:false; response_revision:12486; number_of_response:1; }","duration":"470.084491ms","start":"2026-04-20T06:15:04.029776Z","end":"2026-04-20T06:15:04.49986Z","steps":["trace[1819594077] 'process raft request' (duration: 469.999649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.499951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.029747Z","time spent":"470.167994ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:15:04.499984Z","caller":"traceutil/trace.go:171","msg":"trace[2117883550] linearizableReadLoop","detail":"{readStateIndex:12937; appliedIndex:12936; }","duration":"1.793060271s","start":"2026-04-20T06:15:02.706894Z","end":"2026-04-20T06:15:04.499954Z","steps":["trace[2117883550] 'read index received' (duration: 726.817158ms)","trace[2117883550] 'applied index is now lower than readState.Index' (duration: 1.066240013s)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:15:04.500075Z","caller":"traceutil/trace.go:171","msg":"trace[1277337336] transaction","detail":"{read_only:false; response_revision:12485; number_of_response:1; }","duration":"1.793653866s","start":"2026-04-20T06:15:02.706375Z","end":"2026-04-20T06:15:04.500029Z","steps":["trace[1277337336] 'process raft request' (duration: 727.424814ms)","trace[1277337336] 'compare' (duration: 1.063865711s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:15:04.500152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.793237415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:15:04.50019Z","caller":"traceutil/trace.go:171","msg":"trace[2084201855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12486; }","duration":"1.793320127s","start":"2026-04-20T06:15:02.706859Z","end":"2026-04-20T06:15:04.500179Z","steps":["trace[2084201855] 'agreement among raft nodes before linearized reading' (duration: 1.793212915s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.500226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.706335Z","time spent":"1.793799139s","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:15:04.50022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.706843Z","time spent":"1.793369838s","remote":"127.0.0.1:55136","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-20T06:15:04.501404Z","caller":"traceutil/trace.go:171","msg":"trace[1105218283] transaction","detail":"{read_only:false; response_revision:12488; number_of_response:1; }","duration":"471.127049ms","start":"2026-04-20T06:15:04.030251Z","end":"2026-04-20T06:15:04.501378Z","steps":["trace[1105218283] 'process raft request' (duration: 471.026176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.501563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.030242Z","time spent":"471.236031ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:15:04.50162Z","caller":"traceutil/trace.go:171","msg":"trace[2042736161] transaction","detail":"{read_only:false; response_revision:12489; number_of_response:1; }","duration":"471.310113ms","start":"2026-04-20T06:15:04.030296Z","end":"2026-04-20T06:15:04.501606Z","steps":["trace[2042736161] 'process raft request' (duration: 471.030196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.501699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.03029Z","time spent":"471.358514ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:15:04.501884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691487325s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:15:04.501907Z","caller":"traceutil/trace.go:171","msg":"trace[892655278] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:12490; }","duration":"1.691557176s","start":"2026-04-20T06:15:02.810343Z","end":"2026-04-20T06:15:04.5019Z","steps":["trace[892655278] 'agreement among raft nodes before linearized reading' (duration: 1.691516885s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.501924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:02.810323Z","time spent":"1.691596688s","remote":"127.0.0.1:55572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-04-20T06:15:04.501867Z","caller":"traceutil/trace.go:171","msg":"trace[627507341] transaction","detail":"{read_only:false; response_revision:12487; number_of_response:1; }","duration":"471.631432ms","start":"2026-04-20T06:15:04.030162Z","end":"2026-04-20T06:15:04.501793Z","steps":["trace[627507341] 'process raft request' (duration: 470.940984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.502017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.030145Z","time spent":"471.818966ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:15:04.502138Z","caller":"traceutil/trace.go:171","msg":"trace[158242992] transaction","detail":"{read_only:false; response_revision:12490; number_of_response:1; }","duration":"471.775476ms","start":"2026-04-20T06:15:04.030347Z","end":"2026-04-20T06:15:04.502123Z","steps":["trace[158242992] 'process raft request' (duration: 471.198551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.502217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.030335Z","time spent":"471.847027ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:15:04.502247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.442962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T06:15:04.50228Z","caller":"traceutil/trace.go:171","msg":"trace[950806244] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12490; }","duration":"472.543115ms","start":"2026-04-20T06:15:04.029725Z","end":"2026-04-20T06:15:04.502268Z","steps":["trace[950806244] 'agreement among raft nodes before linearized reading' (duration: 472.412472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.50231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.029689Z","time spent":"472.614417ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T06:15:04.502401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.0696Z","time spent":"432.799999ms","remote":"127.0.0.1:55214","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T06:15:04.502635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.269298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T06:15:04.502649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.381707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:15:04.502675Z","caller":"traceutil/trace.go:171","msg":"trace[582125407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12490; }","duration":"472.33226ms","start":"2026-04-20T06:15:04.030333Z","end":"2026-04-20T06:15:04.502665Z","steps":["trace[582125407] 'agreement among raft nodes before linearized reading' (duration: 472.213917ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:04.50268Z","caller":"traceutil/trace.go:171","msg":"trace[1078784350] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:12490; }","duration":"979.414588ms","start":"2026-04-20T06:15:03.523255Z","end":"2026-04-20T06:15:04.50267Z","steps":["trace[1078784350] 'agreement among raft nodes before linearized reading' (duration: 979.356007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.502714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:03.523215Z","time spent":"979.48971ms","remote":"127.0.0.1:48576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:15:04.502703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.030326Z","time spent":"472.370121ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T06:15:04.502893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005469671s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T06:15:04.502893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.810371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:15:04.502917Z","caller":"traceutil/trace.go:171","msg":"trace[1894863724] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:12490; }","duration":"1.005539443s","start":"2026-04-20T06:15:03.497368Z","end":"2026-04-20T06:15:04.502907Z","steps":["trace[1894863724] 'agreement among raft nodes before linearized reading' (duration: 1.005494132s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:15:04.502922Z","caller":"traceutil/trace.go:171","msg":"trace[1454968036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:12490; }","duration":"472.854963ms","start":"2026-04-20T06:15:04.030058Z","end":"2026-04-20T06:15:04.502913Z","steps":["trace[1454968036] 'agreement among raft nodes before linearized reading' (duration: 472.773831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.502938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:03.497341Z","time spent":"1.005591805s","remote":"127.0.0.1:51572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":15,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:15:04.502948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.030049Z","time spent":"472.892854ms","remote":"127.0.0.1:55422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T06:15:04.502347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.182885277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:15:04.503087Z","caller":"traceutil/trace.go:171","msg":"trace[480128263] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:12490; }","duration":"1.183681668s","start":"2026-04-20T06:15:03.319389Z","end":"2026-04-20T06:15:04.50307Z","steps":["trace[480128263] 'agreement among raft nodes before linearized reading' (duration: 1.182911207s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.503113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.210173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fd2bj\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-04-20T06:15:04.503133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:03.319357Z","time spent":"1.18376095s","remote":"127.0.0.1:53296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:15:04.503141Z","caller":"traceutil/trace.go:171","msg":"trace[1087950527] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fd2bj; range_end:; response_count:1; response_revision:12490; }","duration":"473.293444ms","start":"2026-04-20T06:15:04.029838Z","end":"2026-04-20T06:15:04.503132Z","steps":["trace[1087950527] 'agreement among raft nodes before linearized reading' (duration: 473.208211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:15:04.503257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:15:04.029809Z","time spent":"473.438538ms","remote":"127.0.0.1:55340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-fd2bj\" "}