{"level":"warn","ts":"2026-04-08T01:22:05.864782Z","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-08T01:22:05.864872Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.57: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.57:2380","--initial-cluster=instance=https://199.204.45.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.57: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-08T01:22:05.86494Z","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-08T01:22:05.864953Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-08T01:22:05.864975Z","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-08T01:22:05.865566Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"]} {"level":"info","ts":"2026-04-08T01:22:05.865638Z","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.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.57: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-08T01:22:05.869985Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.15399ms"} {"level":"info","ts":"2026-04-08T01:22:05.875887Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b6478f0ac5aeb8e1","cluster-id":"6c58cff80d4a5b62"} {"level":"info","ts":"2026-04-08T01:22:05.876011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T01:22:05.876043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 0"} {"level":"info","ts":"2026-04-08T01:22:05.876057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b6478f0ac5aeb8e1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T01:22:05.876073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became follower at term 1"} {"level":"info","ts":"2026-04-08T01:22:05.876119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"warn","ts":"2026-04-08T01:22:05.88161Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T01:22:05.883963Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T01:22:05.885349Z","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-08T01:22:05.887867Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b6478f0ac5aeb8e1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T01:22:05.88808Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b6478f0ac5aeb8e1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T01:22:05.888313Z","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-08T01:22:05.888447Z","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-08T01:22:05.888473Z","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-08T01:22:05.890629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 switched to configuration voters=(13134624114678348001)"} {"level":"info","ts":"2026-04-08T01:22:05.891717Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","added-peer-id":"b6478f0ac5aeb8e1","added-peer-peer-urls":["https://199.204.45.57:2380"]} {"level":"info","ts":"2026-04-08T01:22:05.893914Z","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-08T01:22:05.894047Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-08T01:22:05.894138Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.57:2380"} {"level":"info","ts":"2026-04-08T01:22:05.894406Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b6478f0ac5aeb8e1","initial-advertise-peer-urls":["https://199.204.45.57:2380"],"listen-peer-urls":["https://199.204.45.57:2380"],"advertise-client-urls":["https://199.204.45.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T01:22:05.894479Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T01:22:05.976997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T01:22:05.977172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T01:22:05.977267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgPreVoteResp from b6478f0ac5aeb8e1 at term 1"} {"level":"info","ts":"2026-04-08T01:22:05.977351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became candidate at term 2"} {"level":"info","ts":"2026-04-08T01:22:05.977394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 received MsgVoteResp from b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-08T01:22:05.977476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b6478f0ac5aeb8e1 became leader at term 2"} {"level":"info","ts":"2026-04-08T01:22:05.977566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b6478f0ac5aeb8e1 elected leader b6478f0ac5aeb8e1 at term 2"} {"level":"info","ts":"2026-04-08T01:22:05.978444Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:22:05.978506Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T01:22:05.978481Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:05.978448Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b6478f0ac5aeb8e1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.57:2379]}","request-path":"/0/members/b6478f0ac5aeb8e1/attributes","cluster-id":"6c58cff80d4a5b62","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T01:22:05.978906Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T01:22:05.978988Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T01:22:05.979473Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c58cff80d4a5b62","local-member-id":"b6478f0ac5aeb8e1","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:05.979716Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:05.97979Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T01:22:05.981701Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T01:22:05.982238Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.57:2379"} {"level":"info","ts":"2026-04-08T01:22:10.964662Z","caller":"traceutil/trace.go:171","msg":"trace[1750059902] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"140.016233ms","start":"2026-04-08T01:22:10.824619Z","end":"2026-04-08T01:22:10.964635Z","steps":["trace[1750059902] 'process raft request' (duration: 139.807468ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:11.780477Z","caller":"traceutil/trace.go:171","msg":"trace[984310190] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"112.669839ms","start":"2026-04-08T01:22:11.667774Z","end":"2026-04-08T01:22:11.780444Z","steps":["trace[984310190] 'process raft request' (duration: 112.497314ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:11.780556Z","caller":"traceutil/trace.go:171","msg":"trace[920077793] transaction","detail":"{read_only:false; number_of_response:0; response_revision:273; }","duration":"112.428622ms","start":"2026-04-08T01:22:11.66809Z","end":"2026-04-08T01:22:11.780519Z","steps":["trace[920077793] 'process raft request' (duration: 112.223026ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:11.78055Z","caller":"traceutil/trace.go:171","msg":"trace[1210074785] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"141.575904ms","start":"2026-04-08T01:22:11.638942Z","end":"2026-04-08T01:22:11.780518Z","steps":["trace[1210074785] 'process raft request' (duration: 95.00417ms)","trace[1210074785] 'compare' (duration: 46.156744ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:22.120664Z","caller":"traceutil/trace.go:171","msg":"trace[1491702967] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"324.923178ms","start":"2026-04-08T01:22:21.795711Z","end":"2026-04-08T01:22:22.120634Z","steps":["trace[1491702967] 'read index received' (duration: 324.885617ms)","trace[1491702967] 'applied index is now lower than readState.Index' (duration: 36.411µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:22.120752Z","caller":"traceutil/trace.go:171","msg":"trace[1711282335] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"457.614257ms","start":"2026-04-08T01:22:21.663106Z","end":"2026-04-08T01:22:22.120721Z","steps":["trace[1711282335] 'process raft request' (duration: 457.386301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:22.120908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.165904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:22.121035Z","caller":"traceutil/trace.go:171","msg":"trace[2064176314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:407; }","duration":"325.346289ms","start":"2026-04-08T01:22:21.795664Z","end":"2026-04-08T01:22:22.12101Z","steps":["trace[2064176314] 'agreement among raft nodes before linearized reading' (duration: 325.100732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:22.121088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:21.795648Z","time spent":"325.430741ms","remote":"127.0.0.1:37360","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-08T01:22:22.121405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:21.663074Z","time spent":"457.74521ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:22:22.324049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.705778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:22:22.324156Z","caller":"traceutil/trace.go:171","msg":"trace[1793804143] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"203.388415ms","start":"2026-04-08T01:22:22.120751Z","end":"2026-04-08T01:22:22.324139Z","steps":["trace[1793804143] 'read index received' (duration: 84.289796ms)","trace[1793804143] 'applied index is now lower than readState.Index' (duration: 119.097409ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:22.324232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.104871ms","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-08T01:22:22.32422Z","caller":"traceutil/trace.go:171","msg":"trace[2047886653] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"405.333161ms","start":"2026-04-08T01:22:21.918855Z","end":"2026-04-08T01:22:22.324188Z","steps":["trace[2047886653] 'process raft request' (duration: 286.255053ms)","trace[2047886653] 'compare' (duration: 118.569284ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:22.32423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.775709ms","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-08T01:22:22.324265Z","caller":"traceutil/trace.go:171","msg":"trace[1247178831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:408; }","duration":"340.163842ms","start":"2026-04-08T01:22:21.984092Z","end":"2026-04-08T01:22:22.324256Z","steps":["trace[1247178831] 'agreement among raft nodes before linearized reading' (duration: 340.097911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:22.324312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:21.984077Z","time spent":"340.227114ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T01:22:22.324317Z","caller":"traceutil/trace.go:171","msg":"trace[2053534733] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:408; }","duration":"242.871291ms","start":"2026-04-08T01:22:22.081422Z","end":"2026-04-08T01:22:22.324293Z","steps":["trace[2053534733] 'agreement among raft nodes before linearized reading' (duration: 242.719808ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:22.324349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:21.918831Z","time spent":"405.447474ms","remote":"127.0.0.1:37646","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-08T01:22:22.324355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.583347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T01:22:22.324479Z","caller":"traceutil/trace.go:171","msg":"trace[1142177561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"267.805882ms","start":"2026-04-08T01:22:22.056648Z","end":"2026-04-08T01:22:22.324454Z","steps":["trace[1142177561] 'agreement among raft nodes before linearized reading' (duration: 267.506395ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:32.991282Z","caller":"traceutil/trace.go:171","msg":"trace[2093300933] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"195.490755ms","start":"2026-04-08T01:22:32.795767Z","end":"2026-04-08T01:22:32.991258Z","steps":["trace[2093300933] 'read index received' (duration: 195.227488ms)","trace[2093300933] 'applied index is now lower than readState.Index' (duration: 261.987µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:32.991335Z","caller":"traceutil/trace.go:171","msg":"trace[1799012686] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"310.905296ms","start":"2026-04-08T01:22:32.680395Z","end":"2026-04-08T01:22:32.9913Z","steps":["trace[1799012686] 'process raft request' (duration: 310.724962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:32.991439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.636429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:22:32.99148Z","caller":"traceutil/trace.go:171","msg":"trace[1141146247] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:467; }","duration":"195.751502ms","start":"2026-04-08T01:22:32.795717Z","end":"2026-04-08T01:22:32.991468Z","steps":["trace[1141146247] 'agreement among raft nodes before linearized reading' (duration: 195.64164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:32.991519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:32.680374Z","time spent":"311.064672ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:22:36.659182Z","caller":"traceutil/trace.go:171","msg":"trace[509689089] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"259.970636ms","start":"2026-04-08T01:22:36.399185Z","end":"2026-04-08T01:22:36.659155Z","steps":["trace[509689089] 'read index received' (duration: 259.722539ms)","trace[509689089] 'applied index is now lower than readState.Index' (duration: 247.197µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:36.659231Z","caller":"traceutil/trace.go:171","msg":"trace[2068523788] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"260.814648ms","start":"2026-04-08T01:22:36.39838Z","end":"2026-04-08T01:22:36.659194Z","steps":["trace[2068523788] 'process raft request' (duration: 260.576911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:36.659357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.277377ms","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-08T01:22:36.6594Z","caller":"traceutil/trace.go:171","msg":"trace[1151466303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"259.355699ms","start":"2026-04-08T01:22:36.400034Z","end":"2026-04-08T01:22:36.65939Z","steps":["trace[1151466303] 'agreement among raft nodes before linearized reading' (duration: 259.259547ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:36.659391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.173611ms","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-08T01:22:36.659452Z","caller":"traceutil/trace.go:171","msg":"trace[2079974420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"260.256123ms","start":"2026-04-08T01:22:36.399182Z","end":"2026-04-08T01:22:36.659439Z","steps":["trace[2079974420] 'agreement among raft nodes before linearized reading' (duration: 260.100529ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.957546Z","caller":"traceutil/trace.go:171","msg":"trace[1907224721] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"278.414073ms","start":"2026-04-08T01:22:38.678953Z","end":"2026-04-08T01:22:38.957367Z","steps":["trace[1907224721] 'process raft request' (duration: 191.348867ms)","trace[1907224721] 'compare' (duration: 86.157932ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:38.959127Z","caller":"traceutil/trace.go:171","msg":"trace[1384505235] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"267.685401ms","start":"2026-04-08T01:22:38.691412Z","end":"2026-04-08T01:22:38.959097Z","steps":["trace[1384505235] 'process raft request' (duration: 267.180037ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.95917Z","caller":"traceutil/trace.go:171","msg":"trace[1521087220] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"251.709479ms","start":"2026-04-08T01:22:38.707388Z","end":"2026-04-08T01:22:38.959098Z","steps":["trace[1521087220] 'process raft request' (duration: 251.354149ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959384Z","caller":"traceutil/trace.go:171","msg":"trace[774658534] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"259.848833ms","start":"2026-04-08T01:22:38.6993Z","end":"2026-04-08T01:22:38.959149Z","steps":["trace[774658534] 'process raft request' (duration: 259.400041ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959504Z","caller":"traceutil/trace.go:171","msg":"trace[473913228] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"250.203369ms","start":"2026-04-08T01:22:38.709294Z","end":"2026-04-08T01:22:38.959497Z","steps":["trace[473913228] 'process raft request' (duration: 249.532721ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959457Z","caller":"traceutil/trace.go:171","msg":"trace[1388365722] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:529; }","duration":"202.922892ms","start":"2026-04-08T01:22:38.75651Z","end":"2026-04-08T01:22:38.959433Z","steps":["trace[1388365722] 'read index received' (duration: 113.72144ms)","trace[1388365722] 'applied index is now lower than readState.Index' (duration: 89.200412ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:38.959606Z","caller":"traceutil/trace.go:171","msg":"trace[12014078] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"223.755232ms","start":"2026-04-08T01:22:38.735844Z","end":"2026-04-08T01:22:38.959599Z","steps":["trace[12014078] 'process raft request' (duration: 223.248679ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959437Z","caller":"traceutil/trace.go:171","msg":"trace[1750565939] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"249.966433ms","start":"2026-04-08T01:22:38.70946Z","end":"2026-04-08T01:22:38.959427Z","steps":["trace[1750565939] 'process raft request' (duration: 249.406898ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.95977Z","caller":"traceutil/trace.go:171","msg":"trace[589349587] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"246.259826ms","start":"2026-04-08T01:22:38.7135Z","end":"2026-04-08T01:22:38.959759Z","steps":["trace[589349587] 'process raft request' (duration: 245.421083ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959731Z","caller":"traceutil/trace.go:171","msg":"trace[1477657903] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"111.478571ms","start":"2026-04-08T01:22:38.848243Z","end":"2026-04-08T01:22:38.959721Z","steps":["trace[1477657903] 'process raft request' (duration: 111.08061ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959473Z","caller":"traceutil/trace.go:171","msg":"trace[185114097] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"251.741109ms","start":"2026-04-08T01:22:38.707724Z","end":"2026-04-08T01:22:38.959465Z","steps":["trace[185114097] 'process raft request' (duration: 251.062091ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.95967Z","caller":"traceutil/trace.go:171","msg":"trace[178829603] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"206.368783ms","start":"2026-04-08T01:22:38.753288Z","end":"2026-04-08T01:22:38.959657Z","steps":["trace[178829603] 'process raft request' (duration: 205.87401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:38.960019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.752909ms","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-08T01:22:38.96006Z","caller":"traceutil/trace.go:171","msg":"trace[501502758] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"202.853621ms","start":"2026-04-08T01:22:38.757197Z","end":"2026-04-08T01:22:38.960051Z","steps":["trace[501502758] 'agreement among raft nodes before linearized reading' (duration: 202.688447ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:38.959848Z","caller":"traceutil/trace.go:171","msg":"trace[332966324] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"234.119186ms","start":"2026-04-08T01:22:38.725722Z","end":"2026-04-08T01:22:38.959841Z","steps":["trace[332966324] 'process raft request' (duration: 233.244133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:38.960179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.644651ms","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-08T01:22:38.960291Z","caller":"traceutil/trace.go:171","msg":"trace[2039635529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:525; }","duration":"203.797805ms","start":"2026-04-08T01:22:38.756468Z","end":"2026-04-08T01:22:38.960266Z","steps":["trace[2039635529] 'agreement among raft nodes before linearized reading' (duration: 203.57845ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:22:45.4364Z","caller":"traceutil/trace.go:171","msg":"trace[988022120] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"436.73764ms","start":"2026-04-08T01:22:44.99959Z","end":"2026-04-08T01:22:45.436328Z","steps":["trace[988022120] 'read index received' (duration: 433.255968ms)","trace[988022120] 'applied index is now lower than readState.Index' (duration: 3.480112ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:45.436765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.154181ms","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-08T01:22:45.437179Z","caller":"traceutil/trace.go:171","msg":"trace[262137120] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"437.608713ms","start":"2026-04-08T01:22:44.999545Z","end":"2026-04-08T01:22:45.437154Z","steps":["trace[262137120] 'agreement among raft nodes before linearized reading' (duration: 436.886154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:45.437248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:44.999529Z","time spent":"437.703496ms","remote":"127.0.0.1:37646","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-08T01:22:45.437331Z","caller":"traceutil/trace.go:171","msg":"trace[1200888879] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"564.1016ms","start":"2026-04-08T01:22:44.873186Z","end":"2026-04-08T01:22:45.437287Z","steps":["trace[1200888879] 'process raft request' (duration: 559.829468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:45.437504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:44.873152Z","time spent":"564.270395ms","remote":"127.0.0.1:37442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:22:45.437675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.029529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T01:22:45.437788Z","caller":"traceutil/trace.go:171","msg":"trace[1299379223] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"423.200334ms","start":"2026-04-08T01:22:45.014566Z","end":"2026-04-08T01:22:45.437767Z","steps":["trace[1299379223] 'agreement among raft nodes before linearized reading' (duration: 422.918226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:45.437859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:45.014545Z","time spent":"423.301886ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T01:22:46.18676Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261352730,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:22:46.338454Z","caller":"traceutil/trace.go:171","msg":"trace[27533859] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"652.418559ms","start":"2026-04-08T01:22:45.68601Z","end":"2026-04-08T01:22:46.338429Z","steps":["trace[27533859] 'read index received' (duration: 652.185663ms)","trace[27533859] 'applied index is now lower than readState.Index' (duration: 231.676µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:46.338529Z","caller":"traceutil/trace.go:171","msg":"trace[342889044] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"842.952625ms","start":"2026-04-08T01:22:45.495546Z","end":"2026-04-08T01:22:46.338499Z","steps":["trace[342889044] 'process raft request' (duration: 842.74499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:46.338639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.024397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:22:46.338671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:45.495519Z","time spent":"843.086149ms","remote":"127.0.0.1:37936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T01:22:46.338681Z","caller":"traceutil/trace.go:171","msg":"trace[433463933] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"542.12251ms","start":"2026-04-08T01:22:45.796548Z","end":"2026-04-08T01:22:46.33867Z","steps":["trace[433463933] 'agreement among raft nodes before linearized reading' (duration: 542.007276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:46.338723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:45.796528Z","time spent":"542.187982ms","remote":"127.0.0.1:37356","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-08T01:22:46.338742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.715987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c5plk\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-08T01:22:46.338805Z","caller":"traceutil/trace.go:171","msg":"trace[60974141] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c5plk; range_end:; response_count:1; response_revision:623; }","duration":"652.82667ms","start":"2026-04-08T01:22:45.685963Z","end":"2026-04-08T01:22:46.33879Z","steps":["trace[60974141] 'agreement among raft nodes before linearized reading' (duration: 652.585793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:22:46.338844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:22:45.685944Z","time spent":"652.893382ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-c5plk\" "} {"level":"info","ts":"2026-04-08T01:22:47.072892Z","caller":"traceutil/trace.go:171","msg":"trace[1487177655] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"157.953916ms","start":"2026-04-08T01:22:46.914894Z","end":"2026-04-08T01:22:47.072848Z","steps":["trace[1487177655] 'process raft request' (duration: 106.100788ms)","trace[1487177655] 'compare' (duration: 51.624122ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:22:47.823855Z","caller":"traceutil/trace.go:171","msg":"trace[524581762] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"120.568261ms","start":"2026-04-08T01:22:47.703256Z","end":"2026-04-08T01:22:47.823824Z","steps":["trace[524581762] 'process raft request' (duration: 87.914129ms)","trace[524581762] 'compare' (duration: 32.436576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:22:59.676752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.453499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:22:59.676874Z","caller":"traceutil/trace.go:171","msg":"trace[680698573] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"145.073548ms","start":"2026-04-08T01:22:59.531782Z","end":"2026-04-08T01:22:59.676856Z","steps":["trace[680698573] 'process raft request' (duration: 44.434343ms)","trace[680698573] 'compare' (duration: 100.342976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:02.297214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261353114,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:23:02.396611Z","caller":"traceutil/trace.go:171","msg":"trace[440572612] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"600.072069ms","start":"2026-04-08T01:23:01.796515Z","end":"2026-04-08T01:23:02.396587Z","steps":["trace[440572612] 'read index received' (duration: 599.848093ms)","trace[440572612] 'applied index is now lower than readState.Index' (duration: 222.786µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:23:02.396677Z","caller":"traceutil/trace.go:171","msg":"trace[1231732937] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"612.335561ms","start":"2026-04-08T01:23:01.784312Z","end":"2026-04-08T01:23:02.396647Z","steps":["trace[1231732937] 'process raft request' (duration: 612.137866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:02.396764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.225464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:23:02.396825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:01.784294Z","time spent":"612.456556ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:23:02.396848Z","caller":"traceutil/trace.go:171","msg":"trace[1920292214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:789; }","duration":"600.344687ms","start":"2026-04-08T01:23:01.796486Z","end":"2026-04-08T01:23:02.396831Z","steps":["trace[1920292214] 'agreement among raft nodes before linearized reading' (duration: 600.207042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:02.396891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:01.796474Z","time spent":"600.409028ms","remote":"127.0.0.1:37356","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-08T01:23:28.898671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.166355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:28.898775Z","caller":"traceutil/trace.go:171","msg":"trace[1832795501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1174; }","duration":"102.325889ms","start":"2026-04-08T01:23:28.796429Z","end":"2026-04-08T01:23:28.898755Z","steps":["trace[1832795501] 'range keys from in-memory index tree' (duration: 102.059012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:29.573803Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261353809,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:23:29.738471Z","caller":"traceutil/trace.go:171","msg":"trace[1633652292] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"751.915573ms","start":"2026-04-08T01:23:28.986528Z","end":"2026-04-08T01:23:29.738444Z","steps":["trace[1633652292] 'process raft request' (duration: 751.76244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:29.738622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:28.986512Z","time spent":"752.033777ms","remote":"127.0.0.1:37646","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-08T01:23:30.060425Z","caller":"traceutil/trace.go:171","msg":"trace[433977362] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1207; }","duration":"986.655927ms","start":"2026-04-08T01:23:29.073745Z","end":"2026-04-08T01:23:30.060401Z","steps":["trace[433977362] 'read index received' (duration: 664.522879ms)","trace[433977362] 'applied index is now lower than readState.Index' (duration: 322.132188ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:23:30.060451Z","caller":"traceutil/trace.go:171","msg":"trace[588865245] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"462.572402ms","start":"2026-04-08T01:23:29.597851Z","end":"2026-04-08T01:23:30.060423Z","steps":["trace[588865245] 'process raft request' (duration: 462.457929ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:30.060483Z","caller":"traceutil/trace.go:171","msg":"trace[1217668040] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"647.705275ms","start":"2026-04-08T01:23:29.412757Z","end":"2026-04-08T01:23:30.060462Z","steps":["trace[1217668040] 'process raft request' (duration: 611.958772ms)","trace[1217668040] 'compare' (duration: 35.439574ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:30.060588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.412731Z","time spent":"647.802538ms","remote":"127.0.0.1:37646","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-08T01:23:30.060593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"986.841632ms","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-08T01:23:30.060635Z","caller":"traceutil/trace.go:171","msg":"trace[1899830909] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1177; }","duration":"986.904873ms","start":"2026-04-08T01:23:29.07372Z","end":"2026-04-08T01:23:30.060625Z","steps":["trace[1899830909] 'agreement among raft nodes before linearized reading' (duration: 986.811721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.060669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.07363Z","time spent":"987.028376ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":8,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:23:30.06071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.080716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-08T01:23:30.060748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.769321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:30.060785Z","caller":"traceutil/trace.go:171","msg":"trace[379987049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1177; }","duration":"910.21507ms","start":"2026-04-08T01:23:29.150552Z","end":"2026-04-08T01:23:30.060768Z","steps":["trace[379987049] 'agreement among raft nodes before linearized reading' (duration: 910.006585ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:30.060803Z","caller":"traceutil/trace.go:171","msg":"trace[281336804] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1177; }","duration":"265.937115ms","start":"2026-04-08T01:23:29.794852Z","end":"2026-04-08T01:23:30.060789Z","steps":["trace[281336804] 'agreement among raft nodes before linearized reading' (duration: 265.779611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.060844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.150477Z","time spent":"910.351433ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-08T01:23:30.060921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.369462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:30.060966Z","caller":"traceutil/trace.go:171","msg":"trace[1266764131] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1177; }","duration":"165.448964ms","start":"2026-04-08T01:23:29.895507Z","end":"2026-04-08T01:23:30.060956Z","steps":["trace[1266764131] 'agreement among raft nodes before linearized reading' (duration: 165.375233ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.06103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.082955ms","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-08T01:23:30.06106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.581072ms","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-08T01:23:30.06115Z","caller":"traceutil/trace.go:171","msg":"trace[494080502] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1177; }","duration":"407.701376ms","start":"2026-04-08T01:23:29.653422Z","end":"2026-04-08T01:23:30.061124Z","steps":["trace[494080502] 'agreement among raft nodes before linearized reading' (duration: 407.446748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.061192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.653401Z","time spent":"407.783347ms","remote":"127.0.0.1:37646","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-08T01:23:30.061187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.597824Z","time spent":"462.687725ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:23:30.061136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.860366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:23:30.061302Z","caller":"traceutil/trace.go:171","msg":"trace[1302340414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"143.207298ms","start":"2026-04-08T01:23:29.917901Z","end":"2026-04-08T01:23:30.061109Z","steps":["trace[1302340414] 'agreement among raft nodes before linearized reading' (duration: 142.791087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.061198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.686293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-08T01:23:30.061612Z","caller":"traceutil/trace.go:171","msg":"trace[993060403] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:1177; }","duration":"687.162165ms","start":"2026-04-08T01:23:29.374429Z","end":"2026-04-08T01:23:30.061591Z","steps":["trace[993060403] 'agreement among raft nodes before linearized reading' (duration: 686.417186ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:30.061312Z","caller":"traceutil/trace.go:171","msg":"trace[578262404] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1177; }","duration":"456.118612ms","start":"2026-04-08T01:23:29.605159Z","end":"2026-04-08T01:23:30.061277Z","steps":["trace[578262404] 'agreement among raft nodes before linearized reading' (duration: 455.627479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:23:30.061665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.374405Z","time spent":"687.247488ms","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"warn","ts":"2026-04-08T01:23:30.061704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:23:29.605144Z","time spent":"456.541484ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":5,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:23:30.282739Z","caller":"traceutil/trace.go:171","msg":"trace[35361295] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"158.667194ms","start":"2026-04-08T01:23:30.124044Z","end":"2026-04-08T01:23:30.282712Z","steps":["trace[35361295] 'process raft request' (duration: 89.11834ms)","trace[35361295] 'compare' (duration: 69.419791ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:23:45.054866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.572709ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:23:45.055Z","caller":"traceutil/trace.go:171","msg":"trace[589324491] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1314; }","duration":"169.715793ms","start":"2026-04-08T01:23:44.885261Z","end":"2026-04-08T01:23:45.054977Z","steps":["trace[589324491] 'range keys from in-memory index tree' (duration: 169.556779ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:51.584627Z","caller":"traceutil/trace.go:171","msg":"trace[431478911] transaction","detail":"{read_only:false; response_revision:1431; number_of_response:1; }","duration":"115.303591ms","start":"2026-04-08T01:23:51.469297Z","end":"2026-04-08T01:23:51.5846Z","steps":["trace[431478911] 'process raft request' (duration: 115.130247ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:23:52.72382Z","caller":"traceutil/trace.go:171","msg":"trace[227337075] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"111.080143ms","start":"2026-04-08T01:23:52.612704Z","end":"2026-04-08T01:23:52.723784Z","steps":["trace[227337075] 'process raft request' (duration: 110.841166ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.253322Z","caller":"traceutil/trace.go:171","msg":"trace[1559241647] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"101.973563ms","start":"2026-04-08T01:24:02.151308Z","end":"2026-04-08T01:24:02.253282Z","steps":["trace[1559241647] 'process raft request' (duration: 101.757088ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.253368Z","caller":"traceutil/trace.go:171","msg":"trace[1107725308] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"100.152446ms","start":"2026-04-08T01:24:02.153176Z","end":"2026-04-08T01:24:02.253328Z","steps":["trace[1107725308] 'process raft request' (duration: 99.989042ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.253413Z","caller":"traceutil/trace.go:171","msg":"trace[2021470304] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"109.946592ms","start":"2026-04-08T01:24:02.143425Z","end":"2026-04-08T01:24:02.253371Z","steps":["trace[2021470304] 'process raft request' (duration: 97.59054ms)","trace[2021470304] 'compare' (duration: 11.928622ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:02.584514Z","caller":"traceutil/trace.go:171","msg":"trace[1701192159] linearizableReadLoop","detail":"{readStateIndex:1638; appliedIndex:1632; }","duration":"257.99858ms","start":"2026-04-08T01:24:02.326491Z","end":"2026-04-08T01:24:02.584489Z","steps":["trace[1701192159] 'read index received' (duration: 30.917128ms)","trace[1701192159] 'applied index is now lower than readState.Index' (duration: 227.080472ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:02.58454Z","caller":"traceutil/trace.go:171","msg":"trace[387238263] transaction","detail":"{read_only:false; response_revision:1576; number_of_response:1; }","duration":"264.951221ms","start":"2026-04-08T01:24:02.319552Z","end":"2026-04-08T01:24:02.584504Z","steps":["trace[387238263] 'process raft request' (duration: 196.957195ms)","trace[387238263] 'compare' (duration: 67.572296ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:02.58458Z","caller":"traceutil/trace.go:171","msg":"trace[1388819037] transaction","detail":"{read_only:false; response_revision:1579; number_of_response:1; }","duration":"262.427136ms","start":"2026-04-08T01:24:02.32213Z","end":"2026-04-08T01:24:02.584557Z","steps":["trace[1388819037] 'process raft request' (duration: 262.275981ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.584649Z","caller":"traceutil/trace.go:171","msg":"trace[826624718] transaction","detail":"{read_only:false; response_revision:1580; number_of_response:1; }","duration":"260.079355ms","start":"2026-04-08T01:24:02.324559Z","end":"2026-04-08T01:24:02.584639Z","steps":["trace[826624718] 'process raft request' (duration: 259.888789ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.584649Z","caller":"traceutil/trace.go:171","msg":"trace[405696451] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"264.980462ms","start":"2026-04-08T01:24:02.319652Z","end":"2026-04-08T01:24:02.584632Z","steps":["trace[405696451] 'process raft request' (duration: 264.604292ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.584655Z","caller":"traceutil/trace.go:171","msg":"trace[419690718] transaction","detail":"{read_only:false; response_revision:1578; number_of_response:1; }","duration":"262.681644ms","start":"2026-04-08T01:24:02.321953Z","end":"2026-04-08T01:24:02.584635Z","steps":["trace[419690718] 'process raft request' (duration: 262.402776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:02.584919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.568862ms","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-08T01:24:02.584927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.427161ms","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-08T01:24:02.584944Z","caller":"traceutil/trace.go:171","msg":"trace[83629560] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1580; }","duration":"251.637824ms","start":"2026-04-08T01:24:02.3333Z","end":"2026-04-08T01:24:02.584937Z","steps":["trace[83629560] 'agreement among raft nodes before linearized reading' (duration: 251.547182ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:02.584941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.969809ms","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-08T01:24:02.584967Z","caller":"traceutil/trace.go:171","msg":"trace[2046745574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1580; }","duration":"258.500153ms","start":"2026-04-08T01:24:02.326456Z","end":"2026-04-08T01:24:02.584956Z","steps":["trace[2046745574] 'agreement among raft nodes before linearized reading' (duration: 258.36208ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:02.585017Z","caller":"traceutil/trace.go:171","msg":"trace[1665200868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1580; }","duration":"253.089952ms","start":"2026-04-08T01:24:02.331909Z","end":"2026-04-08T01:24:02.584999Z","steps":["trace[1665200868] 'agreement among raft nodes before linearized reading' (duration: 252.898477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:03.412717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.480331ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:03.412892Z","caller":"traceutil/trace.go:171","msg":"trace[2126305124] transaction","detail":"{read_only:false; response_revision:1639; number_of_response:1; }","duration":"161.260003ms","start":"2026-04-08T01:24:03.251601Z","end":"2026-04-08T01:24:03.412861Z","steps":["trace[2126305124] 'process raft request' (duration: 36.571006ms)","trace[2126305124] 'compare' (duration: 124.352108ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:19.348827Z","caller":"traceutil/trace.go:171","msg":"trace[2131470482] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"167.740481ms","start":"2026-04-08T01:24:19.181067Z","end":"2026-04-08T01:24:19.348808Z","steps":["trace[2131470482] 'process raft request' (duration: 167.607578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:20.081068Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261355198,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T01:24:20.582014Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261355198,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-08T01:24:20.686344Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.257841349s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-08T01:24:20.854491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.799225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:24:20.854663Z","caller":"traceutil/trace.go:171","msg":"trace[1082685321] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"1.426181307s","start":"2026-04-08T01:24:19.42841Z","end":"2026-04-08T01:24:20.854592Z","steps":["trace[1082685321] 'process raft request' (duration: 1.258192708s)","trace[1082685321] 'compare' (duration: 167.680691ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:20.854768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:19.428394Z","time spent":"1.426310109s","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:21.195595Z","caller":"traceutil/trace.go:171","msg":"trace[1100305276] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1935; }","duration":"1.615319207s","start":"2026-04-08T01:24:19.580253Z","end":"2026-04-08T01:24:21.195572Z","steps":["trace[1100305276] 'read index received' (duration: 1.10633554s)","trace[1100305276] 'applied index is now lower than readState.Index' (duration: 508.982767ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:21.195697Z","caller":"traceutil/trace.go:171","msg":"trace[1242571816] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"956.557307ms","start":"2026-04-08T01:24:20.239084Z","end":"2026-04-08T01:24:21.195641Z","steps":["trace[1242571816] 'process raft request' (duration: 956.411544ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.195748Z","caller":"traceutil/trace.go:171","msg":"trace[362651540] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"1.13079973s","start":"2026-04-08T01:24:20.064889Z","end":"2026-04-08T01:24:21.195689Z","steps":["trace[362651540] 'process raft request' (duration: 1.130460391s)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.195775Z","caller":"traceutil/trace.go:171","msg":"trace[1041874399] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"826.252464ms","start":"2026-04-08T01:24:20.369475Z","end":"2026-04-08T01:24:21.195728Z","steps":["trace[1041874399] 'process raft request' (duration: 826.061009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.195885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.239031Z","time spent":"956.756743ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:21.195953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.615657656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T01:24:21.195975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.369451Z","time spent":"826.435249ms","remote":"127.0.0.1:37646","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-08T01:24:21.196009Z","caller":"traceutil/trace.go:171","msg":"trace[631302304] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1870; }","duration":"1.615784929s","start":"2026-04-08T01:24:19.580208Z","end":"2026-04-08T01:24:21.195993Z","steps":["trace[631302304] 'agreement among raft nodes before linearized reading' (duration: 1.615505501s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.196026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.064869Z","time spent":"1.131016316s","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:21.196059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:19.580187Z","time spent":"1.615860991s","remote":"127.0.0.1:40834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":16,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:24:21.257478Z","caller":"traceutil/trace.go:171","msg":"trace[63935631] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"412.533097ms","start":"2026-04-08T01:24:20.844914Z","end":"2026-04-08T01:24:21.257448Z","steps":["trace[63935631] 'process raft request' (duration: 412.363172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.257649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.8449Z","time spent":"412.6552ms","remote":"127.0.0.1:37646","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-08T01:24:21.257792Z","caller":"traceutil/trace.go:171","msg":"trace[2141493560] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"332.315751ms","start":"2026-04-08T01:24:20.925455Z","end":"2026-04-08T01:24:21.257771Z","steps":["trace[2141493560] 'process raft request' (duration: 331.953272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.257891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.925435Z","time spent":"332.402643ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:21.257926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.733264ms","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-08T01:24:21.257964Z","caller":"traceutil/trace.go:171","msg":"trace[763169991] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1873; }","duration":"561.792775ms","start":"2026-04-08T01:24:20.69616Z","end":"2026-04-08T01:24:21.257953Z","steps":["trace[763169991] 'agreement among raft nodes before linearized reading' (duration: 561.661172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.25794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.368667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:21.257993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.696146Z","time spent":"561.840677ms","remote":"127.0.0.1:37646","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-08T01:24:21.258015Z","caller":"traceutil/trace.go:171","msg":"trace[58715533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1873; }","duration":"777.49605ms","start":"2026-04-08T01:24:20.480499Z","end":"2026-04-08T01:24:21.257995Z","steps":["trace[58715533] 'agreement among raft nodes before linearized reading' (duration: 777.372087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.257991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.635563705s","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-08T01:24:21.258064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.480475Z","time spent":"777.579382ms","remote":"127.0.0.1:43368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:24:21.258103Z","caller":"traceutil/trace.go:171","msg":"trace[487899386] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"1.635719639s","start":"2026-04-08T01:24:19.622355Z","end":"2026-04-08T01:24:21.258074Z","steps":["trace[487899386] 'agreement among raft nodes before linearized reading' (duration: 1.635459893s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155376602s","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-08T01:24:21.258199Z","caller":"traceutil/trace.go:171","msg":"trace[899772264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1873; }","duration":"1.155432464s","start":"2026-04-08T01:24:20.102756Z","end":"2026-04-08T01:24:21.258189Z","steps":["trace[899772264] 'agreement among raft nodes before linearized reading' (duration: 1.1553052s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.102745Z","time spent":"1.155476315s","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-08T01:24:21.25826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.025849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:21.258281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.226747547s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-190b7c29-8059-4213-bd38-b87a835de5db\" ","response":"range_response_count:1 size:3743"} {"level":"warn","ts":"2026-04-08T01:24:21.258292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.124958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:21.25833Z","caller":"traceutil/trace.go:171","msg":"trace[889199227] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-190b7c29-8059-4213-bd38-b87a835de5db; range_end:; response_count:1; response_revision:1873; }","duration":"1.226792128s","start":"2026-04-08T01:24:20.031522Z","end":"2026-04-08T01:24:21.258314Z","steps":["trace[889199227] 'agreement among raft nodes before linearized reading' (duration: 1.226665585s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:19.622335Z","time spent":"1.635809562s","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T01:24:21.258349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.620153ms","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":"warn","ts":"2026-04-08T01:24:21.258377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.586592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:21.258376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.031477Z","time spent":"1.22688719s","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-190b7c29-8059-4213-bd38-b87a835de5db\" "} {"level":"warn","ts":"2026-04-08T01:24:21.258387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.651186ms","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-08T01:24:21.258407Z","caller":"traceutil/trace.go:171","msg":"trace[1750204914] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1873; }","duration":"465.713075ms","start":"2026-04-08T01:24:20.792678Z","end":"2026-04-08T01:24:21.258391Z","steps":["trace[1750204914] 'agreement among raft nodes before linearized reading' (duration: 465.463428ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.258419Z","caller":"traceutil/trace.go:171","msg":"trace[668471783] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1873; }","duration":"710.646994ms","start":"2026-04-08T01:24:20.54775Z","end":"2026-04-08T01:24:21.258397Z","steps":["trace[668471783] 'agreement among raft nodes before linearized reading' (duration: 710.607493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.547733Z","time spent":"710.710185ms","remote":"127.0.0.1:43342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:24:21.258455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.792658Z","time spent":"465.785077ms","remote":"127.0.0.1:37646","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":"info","ts":"2026-04-08T01:24:21.258337Z","caller":"traceutil/trace.go:171","msg":"trace[2119484420] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1873; }","duration":"667.202699ms","start":"2026-04-08T01:24:20.591122Z","end":"2026-04-08T01:24:21.258325Z","steps":["trace[2119484420] 'agreement among raft nodes before linearized reading' (duration: 667.138128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.59105Z","time spent":"667.489126ms","remote":"127.0.0.1:43518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:24:21.258662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.462276888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:24:21.258699Z","caller":"traceutil/trace.go:171","msg":"trace[1228374559] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"202.597452ms","start":"2026-04-08T01:24:21.056084Z","end":"2026-04-08T01:24:21.258682Z","steps":["trace[1228374559] 'process raft request' (duration: 201.591606ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.258722Z","caller":"traceutil/trace.go:171","msg":"trace[498880565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"1.462372472s","start":"2026-04-08T01:24:19.796336Z","end":"2026-04-08T01:24:21.258708Z","steps":["trace[498880565] 'agreement among raft nodes before linearized reading' (duration: 1.4622868s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:19.796316Z","time spent":"1.462441374s","remote":"127.0.0.1:37360","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-08T01:24:21.258415Z","caller":"traceutil/trace.go:171","msg":"trace[788759598] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1873; }","duration":"542.697067ms","start":"2026-04-08T01:24:20.71571Z","end":"2026-04-08T01:24:21.258407Z","steps":["trace[788759598] 'agreement among raft nodes before linearized reading' (duration: 542.611455ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.258298Z","caller":"traceutil/trace.go:171","msg":"trace[1376587548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1873; }","duration":"493.085061ms","start":"2026-04-08T01:24:20.765201Z","end":"2026-04-08T01:24:21.258286Z","steps":["trace[1376587548] 'agreement among raft nodes before linearized reading' (duration: 493.02784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.258868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.715701Z","time spent":"543.155928ms","remote":"127.0.0.1:37646","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-08T01:24:21.258884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.765162Z","time spent":"493.710228ms","remote":"127.0.0.1:43332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:24:21.258671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.68154ms","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-08T01:24:21.258972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.220987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:24:21.259Z","caller":"traceutil/trace.go:171","msg":"trace[603725770] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1873; }","duration":"335.279069ms","start":"2026-04-08T01:24:20.923711Z","end":"2026-04-08T01:24:21.258991Z","steps":["trace[603725770] 'agreement among raft nodes before linearized reading' (duration: 335.231757ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.258992Z","caller":"traceutil/trace.go:171","msg":"trace[1758547709] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1873; }","duration":"715.031099ms","start":"2026-04-08T01:24:20.543944Z","end":"2026-04-08T01:24:21.258975Z","steps":["trace[1758547709] 'agreement among raft nodes before linearized reading' (duration: 714.638949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.259033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.923693Z","time spent":"335.332939ms","remote":"127.0.0.1:37656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:24:21.259054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.54392Z","time spent":"715.118812ms","remote":"127.0.0.1:37646","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-08T01:24:21.258036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.204217678s","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-08T01:24:21.259238Z","caller":"traceutil/trace.go:171","msg":"trace[1291965082] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1873; }","duration":"1.2054524s","start":"2026-04-08T01:24:20.053774Z","end":"2026-04-08T01:24:21.259226Z","steps":["trace[1291965082] 'agreement among raft nodes before linearized reading' (duration: 1.204213328s)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.25925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.418362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"warn","ts":"2026-04-08T01:24:21.259283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.053747Z","time spent":"1.205515971s","remote":"127.0.0.1:43392","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-08T01:24:21.259284Z","caller":"traceutil/trace.go:171","msg":"trace[590216066] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1873; }","duration":"402.485694ms","start":"2026-04-08T01:24:20.856788Z","end":"2026-04-08T01:24:21.259274Z","steps":["trace[590216066] 'agreement among raft nodes before linearized reading' (duration: 402.420352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.25932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.856773Z","time spent":"402.540836ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-08T01:24:21.259378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.955334ms","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-08T01:24:21.259435Z","caller":"traceutil/trace.go:171","msg":"trace[1884982636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1873; }","duration":"375.043306ms","start":"2026-04-08T01:24:20.884378Z","end":"2026-04-08T01:24:21.259421Z","steps":["trace[1884982636] 'agreement among raft nodes before linearized reading' (duration: 374.905103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.259483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:20.884357Z","time spent":"375.114837ms","remote":"127.0.0.1:37646","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-08T01:24:21.65462Z","caller":"traceutil/trace.go:171","msg":"trace[1762920899] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"390.199834ms","start":"2026-04-08T01:24:21.264396Z","end":"2026-04-08T01:24:21.654596Z","steps":["trace[1762920899] 'process raft request' (duration: 390.008569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.654787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.264376Z","time spent":"390.320227ms","remote":"127.0.0.1:37646","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-08T01:24:21.654839Z","caller":"traceutil/trace.go:171","msg":"trace[1037669186] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"390.281985ms","start":"2026-04-08T01:24:21.26454Z","end":"2026-04-08T01:24:21.654822Z","steps":["trace[1037669186] 'process raft request' (duration: 390.014278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.65493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.26453Z","time spent":"390.357838ms","remote":"127.0.0.1:37646","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-08T01:24:21.655163Z","caller":"traceutil/trace.go:171","msg":"trace[1666183180] linearizableReadLoop","detail":"{readStateIndex:1947; appliedIndex:1942; }","duration":"390.274456ms","start":"2026-04-08T01:24:21.264868Z","end":"2026-04-08T01:24:21.655143Z","steps":["trace[1666183180] 'read index received' (duration: 12.259771ms)","trace[1666183180] 'applied index is now lower than readState.Index' (duration: 378.013965ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:21.655191Z","caller":"traceutil/trace.go:171","msg":"trace[507761289] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"390.388839ms","start":"2026-04-08T01:24:21.264757Z","end":"2026-04-08T01:24:21.655146Z","steps":["trace[507761289] 'process raft request' (duration: 390.240614ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.655245Z","caller":"traceutil/trace.go:171","msg":"trace[1505983384] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"390.533753ms","start":"2026-04-08T01:24:21.26464Z","end":"2026-04-08T01:24:21.655174Z","steps":["trace[1505983384] 'process raft request' (duration: 390.121282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.65534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.46675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-08T01:24:21.655351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.264735Z","time spent":"390.536052ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:21.655394Z","caller":"traceutil/trace.go:171","msg":"trace[256595649] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1879; }","duration":"390.547553ms","start":"2026-04-08T01:24:21.264832Z","end":"2026-04-08T01:24:21.655379Z","steps":["trace[256595649] 'agreement among raft nodes before linearized reading' (duration: 390.41285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.65532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.99639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:24:21.655439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.264822Z","time spent":"390.609634ms","remote":"127.0.0.1:37648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-04-08T01:24:21.655535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.264633Z","time spent":"390.757598ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:21.655209Z","caller":"traceutil/trace.go:171","msg":"trace[2127262353] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"390.093031ms","start":"2026-04-08T01:24:21.265099Z","end":"2026-04-08T01:24:21.655192Z","steps":["trace[2127262353] 'process raft request' (duration: 389.994108ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:21.655521Z","caller":"traceutil/trace.go:171","msg":"trace[1742884563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1879; }","duration":"387.161014ms","start":"2026-04-08T01:24:21.268284Z","end":"2026-04-08T01:24:21.655445Z","steps":["trace[1742884563] 'agreement among raft nodes before linearized reading' (duration: 386.99305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:21.655633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.26508Z","time spent":"390.510022ms","remote":"127.0.0.1:37646","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-08T01:24:21.655681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:21.268275Z","time spent":"387.367059ms","remote":"127.0.0.1:37356","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-08T01:24:21.905833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.960318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:24:21.905942Z","caller":"traceutil/trace.go:171","msg":"trace[1703515130] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:1879; }","duration":"191.144924ms","start":"2026-04-08T01:24:21.714776Z","end":"2026-04-08T01:24:21.905921Z","steps":["trace[1703515130] 'count revisions from in-memory index tree' (duration: 190.858176ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:33.502508Z","caller":"traceutil/trace.go:171","msg":"trace[585828480] transaction","detail":"{read_only:false; response_revision:1971; number_of_response:1; }","duration":"352.681374ms","start":"2026-04-08T01:24:33.149794Z","end":"2026-04-08T01:24:33.502475Z","steps":["trace[585828480] 'process raft request' (duration: 352.499639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.502701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.149766Z","time spent":"352.834307ms","remote":"127.0.0.1:37694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1712,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:33.677572Z","caller":"traceutil/trace.go:171","msg":"trace[567183954] transaction","detail":"{read_only:false; response_revision:1972; number_of_response:1; }","duration":"526.076641ms","start":"2026-04-08T01:24:33.151466Z","end":"2026-04-08T01:24:33.677542Z","steps":["trace[567183954] 'process raft request' (duration: 518.71867ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:24:33.677616Z","caller":"traceutil/trace.go:171","msg":"trace[1924340456] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"424.424166ms","start":"2026-04-08T01:24:33.253154Z","end":"2026-04-08T01:24:33.677579Z","steps":["trace[1924340456] 'process raft request' (duration: 424.291093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.677711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.151438Z","time spent":"526.199805ms","remote":"127.0.0.1:37912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5636,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:33.677807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.253136Z","time spent":"424.5694ms","remote":"127.0.0.1:37646","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-08T01:24:33.677876Z","caller":"traceutil/trace.go:171","msg":"trace[27406120] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"412.168957ms","start":"2026-04-08T01:24:33.26568Z","end":"2026-04-08T01:24:33.677849Z","steps":["trace[27406120] 'process raft request' (duration: 411.841218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.67803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.265654Z","time spent":"412.299331ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:24:33.678077Z","caller":"traceutil/trace.go:171","msg":"trace[1080134338] transaction","detail":"{read_only:false; response_revision:1975; number_of_response:1; }","duration":"380.868999ms","start":"2026-04-08T01:24:33.297195Z","end":"2026-04-08T01:24:33.678064Z","steps":["trace[1080134338] 'process raft request' (duration: 380.569651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.678148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.297173Z","time spent":"380.93999ms","remote":"127.0.0.1:37646","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-08T01:24:33.678413Z","caller":"traceutil/trace.go:171","msg":"trace[1133932184] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2041; }","duration":"351.897571ms","start":"2026-04-08T01:24:33.326499Z","end":"2026-04-08T01:24:33.678397Z","steps":["trace[1133932184] 'read index received' (duration: 175.852583ms)","trace[1133932184] 'applied index is now lower than readState.Index' (duration: 176.043968ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:24:33.678668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.162139ms","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-08T01:24:33.678712Z","caller":"traceutil/trace.go:171","msg":"trace[491936112] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1976; }","duration":"352.247711ms","start":"2026-04-08T01:24:33.326454Z","end":"2026-04-08T01:24:33.678701Z","steps":["trace[491936112] 'agreement among raft nodes before linearized reading' (duration: 352.081706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.678742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.326434Z","time spent":"352.300833ms","remote":"127.0.0.1:37646","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":"info","ts":"2026-04-08T01:24:33.678827Z","caller":"traceutil/trace.go:171","msg":"trace[2112667895] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"379.333899ms","start":"2026-04-08T01:24:33.299463Z","end":"2026-04-08T01:24:33.678797Z","steps":["trace[2112667895] 'process raft request' (duration: 378.534519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.678854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.116714ms","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-08T01:24:33.678967Z","caller":"traceutil/trace.go:171","msg":"trace[1242635407] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1976; }","duration":"335.248258ms","start":"2026-04-08T01:24:33.34369Z","end":"2026-04-08T01:24:33.678939Z","steps":["trace[1242635407] 'agreement among raft nodes before linearized reading' (duration: 334.986581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:33.679082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.343671Z","time spent":"335.35179ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T01:24:33.678962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:33.299437Z","time spent":"379.457252ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:37.200285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261355467,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:24:37.53143Z","caller":"traceutil/trace.go:171","msg":"trace[302061182] linearizableReadLoop","detail":"{readStateIndex:2074; appliedIndex:2073; }","duration":"832.004265ms","start":"2026-04-08T01:24:36.699393Z","end":"2026-04-08T01:24:37.531397Z","steps":["trace[302061182] 'read index received' (duration: 831.761908ms)","trace[302061182] 'applied index is now lower than readState.Index' (duration: 241.167µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:24:37.531492Z","caller":"traceutil/trace.go:171","msg":"trace[1763615743] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"868.475747ms","start":"2026-04-08T01:24:36.662987Z","end":"2026-04-08T01:24:37.531463Z","steps":["trace[1763615743] 'process raft request' (duration: 868.231191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.531678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:36.662971Z","time spent":"868.584701ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:24:37.531702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.296792ms","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-08T01:24:37.531756Z","caller":"traceutil/trace.go:171","msg":"trace[1508223] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2002; }","duration":"832.366093ms","start":"2026-04-08T01:24:36.699372Z","end":"2026-04-08T01:24:37.531738Z","steps":["trace[1508223] 'agreement among raft nodes before linearized reading' (duration: 832.182619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.53181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:36.699363Z","time spent":"832.436136ms","remote":"127.0.0.1:35064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-08T01:24:37.531815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.462295ms","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":"info","ts":"2026-04-08T01:24:37.531939Z","caller":"traceutil/trace.go:171","msg":"trace[1599548637] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2002; }","duration":"564.671531ms","start":"2026-04-08T01:24:36.967242Z","end":"2026-04-08T01:24:37.531913Z","steps":["trace[1599548637] 'agreement among raft nodes before linearized reading' (duration: 564.438585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.532005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:36.967215Z","time spent":"564.777833ms","remote":"127.0.0.1:43492","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-08T01:24:37.531831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.71789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:24:37.532157Z","caller":"traceutil/trace.go:171","msg":"trace[773009961] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2002; }","duration":"555.106891ms","start":"2026-04-08T01:24:36.977027Z","end":"2026-04-08T01:24:37.532134Z","steps":["trace[773009961] 'agreement among raft nodes before linearized reading' (duration: 554.668869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:24:37.532217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:24:36.976995Z","time spent":"555.208254ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":15,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:25:10.192008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.243401ms","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-08T01:25:10.192093Z","caller":"traceutil/trace.go:171","msg":"trace[248094908] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2184; }","duration":"256.384824ms","start":"2026-04-08T01:25:09.935685Z","end":"2026-04-08T01:25:10.19207Z","steps":["trace[248094908] 'range keys from in-memory index tree' (duration: 255.915291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:10.192155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.90536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:25:10.19226Z","caller":"traceutil/trace.go:171","msg":"trace[927592862] linearizableReadLoop","detail":"{readStateIndex:2264; appliedIndex:2263; }","duration":"227.159516ms","start":"2026-04-08T01:25:09.965084Z","end":"2026-04-08T01:25:10.192243Z","steps":["trace[927592862] 'read index received' (duration: 68.072451ms)","trace[927592862] 'applied index is now lower than readState.Index' (duration: 159.085935ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:25:10.192358Z","caller":"traceutil/trace.go:171","msg":"trace[1347114729] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"251.925399ms","start":"2026-04-08T01:25:09.940396Z","end":"2026-04-08T01:25:10.192322Z","steps":["trace[1347114729] 'process raft request' (duration: 92.765632ms)","trace[1347114729] 'compare' (duration: 158.697594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:25:10.192473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.259207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T01:25:10.19252Z","caller":"traceutil/trace.go:171","msg":"trace[1734939146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2185; }","duration":"152.340409ms","start":"2026-04-08T01:25:10.040158Z","end":"2026-04-08T01:25:10.192498Z","steps":["trace[1734939146] 'agreement among raft nodes before linearized reading' (duration: 152.183275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:10.192542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.432482ms","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-08T01:25:10.192602Z","caller":"traceutil/trace.go:171","msg":"trace[1513835858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2185; }","duration":"227.533374ms","start":"2026-04-08T01:25:09.965054Z","end":"2026-04-08T01:25:10.192588Z","steps":["trace[1513835858] 'agreement among raft nodes before linearized reading' (duration: 227.260727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:10.192607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.404445ms","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-08T01:25:10.192668Z","caller":"traceutil/trace.go:171","msg":"trace[96319830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2185; }","duration":"151.511818ms","start":"2026-04-08T01:25:10.041138Z","end":"2026-04-08T01:25:10.19265Z","steps":["trace[96319830] 'agreement among raft nodes before linearized reading' (duration: 151.319083ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:15.999669Z","caller":"traceutil/trace.go:171","msg":"trace[1403160828] linearizableReadLoop","detail":"{readStateIndex:2293; appliedIndex:2292; }","duration":"202.470473ms","start":"2026-04-08T01:25:15.797171Z","end":"2026-04-08T01:25:15.999641Z","steps":["trace[1403160828] 'read index received' (duration: 202.302439ms)","trace[1403160828] 'applied index is now lower than readState.Index' (duration: 165.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:25:15.999731Z","caller":"traceutil/trace.go:171","msg":"trace[1712951734] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"246.506348ms","start":"2026-04-08T01:25:15.753178Z","end":"2026-04-08T01:25:15.999684Z","steps":["trace[1712951734] 'process raft request' (duration: 246.288333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:15.999923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.717379ms","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-08T01:25:15.999989Z","caller":"traceutil/trace.go:171","msg":"trace[1977316650] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2212; }","duration":"202.840933ms","start":"2026-04-08T01:25:15.797129Z","end":"2026-04-08T01:25:15.99997Z","steps":["trace[1977316650] 'agreement among raft nodes before linearized reading' (duration: 202.643177ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:16.015569Z","caller":"traceutil/trace.go:171","msg":"trace[1140744134] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"120.668148ms","start":"2026-04-08T01:25:15.894875Z","end":"2026-04-08T01:25:16.015543Z","steps":["trace[1140744134] 'process raft request' (duration: 120.40431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.015841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.111709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:25:16.015899Z","caller":"traceutil/trace.go:171","msg":"trace[1661228516] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2216; }","duration":"218.218582ms","start":"2026-04-08T01:25:15.797667Z","end":"2026-04-08T01:25:16.015886Z","steps":["trace[1661228516] 'agreement among raft nodes before linearized reading' (duration: 218.112849ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:16.385607Z","caller":"traceutil/trace.go:171","msg":"trace[1357466786] linearizableReadLoop","detail":"{readStateIndex:2298; appliedIndex:2297; }","duration":"159.042113ms","start":"2026-04-08T01:25:16.226534Z","end":"2026-04-08T01:25:16.385576Z","steps":["trace[1357466786] 'read index received' (duration: 158.822918ms)","trace[1357466786] 'applied index is now lower than readState.Index' (duration: 218.145µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:25:16.385826Z","caller":"traceutil/trace.go:171","msg":"trace[533624554] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"163.553451ms","start":"2026-04-08T01:25:16.222255Z","end":"2026-04-08T01:25:16.385809Z","steps":["trace[533624554] 'process raft request' (duration: 163.13129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.386096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.540566ms","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-08T01:25:16.386167Z","caller":"traceutil/trace.go:171","msg":"trace[1299856365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2217; }","duration":"159.663449ms","start":"2026-04-08T01:25:16.226485Z","end":"2026-04-08T01:25:16.386149Z","steps":["trace[1299856365] 'agreement among raft nodes before linearized reading' (duration: 159.482935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.939424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.81954ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:25:16.939765Z","caller":"traceutil/trace.go:171","msg":"trace[567544271] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2298; }","duration":"373.615832ms","start":"2026-04-08T01:25:16.566131Z","end":"2026-04-08T01:25:16.939747Z","steps":["trace[567544271] 'read index received' (duration: 197.287868ms)","trace[567544271] 'applied index is now lower than readState.Index' (duration: 176.326944ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:25:16.939821Z","caller":"traceutil/trace.go:171","msg":"trace[168193876] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"548.641171ms","start":"2026-04-08T01:25:16.391159Z","end":"2026-04-08T01:25:16.9398Z","steps":["trace[168193876] 'process raft request' (duration: 548.526918ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:16.939838Z","caller":"traceutil/trace.go:171","msg":"trace[1588435513] transaction","detail":"{read_only:false; response_revision:2218; number_of_response:1; }","duration":"549.299978ms","start":"2026-04-08T01:25:16.390508Z","end":"2026-04-08T01:25:16.939808Z","steps":["trace[1588435513] 'process raft request' (duration: 373.003525ms)","trace[1588435513] 'compare' (duration: 175.537133ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:25:16.939941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:16.391133Z","time spent":"548.745204ms","remote":"127.0.0.1:37646","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-08T01:25:16.939996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:16.390489Z","time spent":"549.423422ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:25:16.940072Z","caller":"traceutil/trace.go:171","msg":"trace[1628191527] transaction","detail":"{read_only:false; response_revision:2221; number_of_response:1; }","duration":"548.629301ms","start":"2026-04-08T01:25:16.391256Z","end":"2026-04-08T01:25:16.939885Z","steps":["trace[1628191527] 'process raft request' (duration: 548.460967ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:25:16.94013Z","caller":"traceutil/trace.go:171","msg":"trace[1563952538] transaction","detail":"{read_only:false; response_revision:2219; number_of_response:1; }","duration":"549.146013ms","start":"2026-04-08T01:25:16.390629Z","end":"2026-04-08T01:25:16.939775Z","steps":["trace[1563952538] 'process raft request' (duration: 548.99447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.940191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:16.391246Z","time spent":"548.888217ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:25:16.940193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.356845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:25:16.9402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.007271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T01:25:16.940285Z","caller":"traceutil/trace.go:171","msg":"trace[3413643] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:2221; }","duration":"273.470998ms","start":"2026-04-08T01:25:16.666797Z","end":"2026-04-08T01:25:16.940268Z","steps":["trace[3413643] 'agreement among raft nodes before linearized reading' (duration: 273.296813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.940331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:16.390605Z","time spent":"549.585166ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:25:16.940377Z","caller":"traceutil/trace.go:171","msg":"trace[2013591916] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2221; }","duration":"374.227478ms","start":"2026-04-08T01:25:16.566087Z","end":"2026-04-08T01:25:16.940314Z","steps":["trace[2013591916] 'agreement among raft nodes before linearized reading' (duration: 373.906009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:16.940526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:25:16.566061Z","time spent":"374.406222ms","remote":"127.0.0.1:37918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":5,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:25:59.026828Z","caller":"traceutil/trace.go:171","msg":"trace[1185487295] linearizableReadLoop","detail":"{readStateIndex:2715; appliedIndex:2714; }","duration":"221.079978ms","start":"2026-04-08T01:25:58.805723Z","end":"2026-04-08T01:25:59.026803Z","steps":["trace[1185487295] 'read index received' (duration: 220.871732ms)","trace[1185487295] 'applied index is now lower than readState.Index' (duration: 207.456µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:25:59.026983Z","caller":"traceutil/trace.go:171","msg":"trace[1865891277] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"221.361574ms","start":"2026-04-08T01:25:58.80558Z","end":"2026-04-08T01:25:59.026942Z","steps":["trace[1865891277] 'process raft request' (duration: 221.074257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:25:59.027109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.377416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"} {"level":"info","ts":"2026-04-08T01:25:59.027149Z","caller":"traceutil/trace.go:171","msg":"trace[595797506] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2619; }","duration":"221.473738ms","start":"2026-04-08T01:25:58.805662Z","end":"2026-04-08T01:25:59.027136Z","steps":["trace[595797506] 'agreement among raft nodes before linearized reading' (duration: 221.295653ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:32.973353Z","caller":"traceutil/trace.go:171","msg":"trace[1898977634] linearizableReadLoop","detail":"{readStateIndex:2928; appliedIndex:2927; }","duration":"175.841937ms","start":"2026-04-08T01:26:32.797488Z","end":"2026-04-08T01:26:32.97333Z","steps":["trace[1898977634] 'read index received' (duration: 175.61725ms)","trace[1898977634] 'applied index is now lower than readState.Index' (duration: 223.727µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:26:32.973406Z","caller":"traceutil/trace.go:171","msg":"trace[1702289066] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"203.702152ms","start":"2026-04-08T01:26:32.769671Z","end":"2026-04-08T01:26:32.973373Z","steps":["trace[1702289066] 'process raft request' (duration: 203.525727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:26:32.973542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.031042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:26:32.973588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.61366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-08T01:26:32.973635Z","caller":"traceutil/trace.go:171","msg":"trace[139534285] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2824; }","duration":"175.674821ms","start":"2026-04-08T01:26:32.797949Z","end":"2026-04-08T01:26:32.973624Z","steps":["trace[139534285] 'agreement among raft nodes before linearized reading' (duration: 175.523577ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:26:32.973639Z","caller":"traceutil/trace.go:171","msg":"trace[269631626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2824; }","duration":"176.176315ms","start":"2026-04-08T01:26:32.797445Z","end":"2026-04-08T01:26:32.973622Z","steps":["trace[269631626] 'agreement among raft nodes before linearized reading' (duration: 176.021391ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:53.095307Z","caller":"traceutil/trace.go:171","msg":"trace[1965169050] transaction","detail":"{read_only:false; response_revision:3762; number_of_response:1; }","duration":"248.802975ms","start":"2026-04-08T01:28:52.846482Z","end":"2026-04-08T01:28:53.095285Z","steps":["trace[1965169050] 'process raft request' (duration: 248.709903ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:28:53.095341Z","caller":"traceutil/trace.go:171","msg":"trace[1155104067] transaction","detail":"{read_only:false; response_revision:3761; number_of_response:1; }","duration":"273.924783ms","start":"2026-04-08T01:28:52.82139Z","end":"2026-04-08T01:28:53.095315Z","steps":["trace[1155104067] 'process raft request' (duration: 241.611677ms)","trace[1155104067] 'compare' (duration: 31.927665ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:53.095341Z","caller":"traceutil/trace.go:171","msg":"trace[1754190123] linearizableReadLoop","detail":"{readStateIndex:3902; appliedIndex:3899; }","duration":"173.75539ms","start":"2026-04-08T01:28:52.921568Z","end":"2026-04-08T01:28:53.095323Z","steps":["trace[1754190123] 'read index received' (duration: 141.407293ms)","trace[1754190123] 'applied index is now lower than readState.Index' (duration: 32.347017ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:28:53.095526Z","caller":"traceutil/trace.go:171","msg":"trace[1059570677] transaction","detail":"{read_only:false; response_revision:3763; number_of_response:1; }","duration":"244.285387ms","start":"2026-04-08T01:28:52.851228Z","end":"2026-04-08T01:28:53.095513Z","steps":["trace[1059570677] 'process raft request' (duration: 244.0211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:28:53.09556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.976545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-08T01:28:53.095621Z","caller":"traceutil/trace.go:171","msg":"trace[737804976] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:3763; }","duration":"174.053997ms","start":"2026-04-08T01:28:52.921551Z","end":"2026-04-08T01:28:53.095605Z","steps":["trace[737804976] 'agreement among raft nodes before linearized reading' (duration: 173.832882ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:19.340664Z","caller":"traceutil/trace.go:171","msg":"trace[2050651074] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"184.249886ms","start":"2026-04-08T01:30:19.156377Z","end":"2026-04-08T01:30:19.340627Z","steps":["trace[2050651074] 'process raft request' (duration: 183.581329ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:19.340888Z","caller":"traceutil/trace.go:171","msg":"trace[1840826908] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4637; }","duration":"133.456597ms","start":"2026-04-08T01:30:19.207383Z","end":"2026-04-08T01:30:19.340839Z","steps":["trace[1840826908] 'process raft request' (duration: 133.19002ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:19.34704Z","caller":"traceutil/trace.go:171","msg":"trace[732373401] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"100.691718ms","start":"2026-04-08T01:30:19.24631Z","end":"2026-04-08T01:30:19.347002Z","steps":["trace[732373401] 'process raft request' (duration: 100.271887ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:26.317508Z","caller":"traceutil/trace.go:171","msg":"trace[804085131] linearizableReadLoop","detail":"{readStateIndex:5021; appliedIndex:5020; }","duration":"160.786641ms","start":"2026-04-08T01:30:26.156696Z","end":"2026-04-08T01:30:26.317483Z","steps":["trace[804085131] 'read index received' (duration: 160.73517ms)","trace[804085131] 'applied index is now lower than readState.Index' (duration: 50.281µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:26.317648Z","caller":"traceutil/trace.go:171","msg":"trace[1159794424] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"169.795468ms","start":"2026-04-08T01:30:26.147813Z","end":"2026-04-08T01:30:26.317608Z","steps":["trace[1159794424] 'process raft request' (duration: 169.51803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:26.317786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.07477ms","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-08T01:30:26.317832Z","caller":"traceutil/trace.go:171","msg":"trace[2012823506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4840; }","duration":"161.175712ms","start":"2026-04-08T01:30:26.156643Z","end":"2026-04-08T01:30:26.317819Z","steps":["trace[2012823506] 'agreement among raft nodes before linearized reading' (duration: 160.981047ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:26.463989Z","caller":"traceutil/trace.go:171","msg":"trace[1215254598] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"121.755519ms","start":"2026-04-08T01:30:26.342208Z","end":"2026-04-08T01:30:26.463964Z","steps":["trace[1215254598] 'process raft request' (duration: 121.524543ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:26.464382Z","caller":"traceutil/trace.go:171","msg":"trace[787630219] transaction","detail":"{read_only:false; response_revision:4845; number_of_response:1; }","duration":"113.330939ms","start":"2026-04-08T01:30:26.351039Z","end":"2026-04-08T01:30:26.46437Z","steps":["trace[787630219] 'process raft request' (duration: 112.808526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:26.464602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.831403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-08T01:30:26.46464Z","caller":"traceutil/trace.go:171","msg":"trace[114637153] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4845; }","duration":"123.904346ms","start":"2026-04-08T01:30:26.340727Z","end":"2026-04-08T01:30:26.464631Z","steps":["trace[114637153] 'agreement among raft nodes before linearized reading' (duration: 123.782562ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963721Z","caller":"traceutil/trace.go:171","msg":"trace[185828924] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"118.293269ms","start":"2026-04-08T01:30:29.845404Z","end":"2026-04-08T01:30:29.963697Z","steps":["trace[185828924] 'process raft request' (duration: 118.180045ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963784Z","caller":"traceutil/trace.go:171","msg":"trace[821007260] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"118.062073ms","start":"2026-04-08T01:30:29.845698Z","end":"2026-04-08T01:30:29.96376Z","steps":["trace[821007260] 'process raft request' (duration: 117.953169ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963828Z","caller":"traceutil/trace.go:171","msg":"trace[1988894498] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"118.068703ms","start":"2026-04-08T01:30:29.845741Z","end":"2026-04-08T01:30:29.96381Z","steps":["trace[1988894498] 'process raft request' (duration: 117.94852ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963853Z","caller":"traceutil/trace.go:171","msg":"trace[937447569] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"118.438782ms","start":"2026-04-08T01:30:29.845394Z","end":"2026-04-08T01:30:29.963833Z","steps":["trace[937447569] 'process raft request' (duration: 116.383959ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963906Z","caller":"traceutil/trace.go:171","msg":"trace[823822177] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"115.553777ms","start":"2026-04-08T01:30:29.848323Z","end":"2026-04-08T01:30:29.963877Z","steps":["trace[823822177] 'process raft request' (duration: 115.476095ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.963941Z","caller":"traceutil/trace.go:171","msg":"trace[432528307] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"116.45512ms","start":"2026-04-08T01:30:29.847464Z","end":"2026-04-08T01:30:29.963919Z","steps":["trace[432528307] 'process raft request' (duration: 116.275965ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.96401Z","caller":"traceutil/trace.go:171","msg":"trace[578845196] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"114.102138ms","start":"2026-04-08T01:30:29.849894Z","end":"2026-04-08T01:30:29.963996Z","steps":["trace[578845196] 'process raft request' (duration: 113.972795ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.964044Z","caller":"traceutil/trace.go:171","msg":"trace[2054787839] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"113.390831ms","start":"2026-04-08T01:30:29.850646Z","end":"2026-04-08T01:30:29.964037Z","steps":["trace[2054787839] 'process raft request' (duration: 113.248007ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:29.964129Z","caller":"traceutil/trace.go:171","msg":"trace[295650898] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"115.602728ms","start":"2026-04-08T01:30:29.848515Z","end":"2026-04-08T01:30:29.964118Z","steps":["trace[295650898] 'process raft request' (duration: 115.323111ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:32.139348Z","caller":"traceutil/trace.go:171","msg":"trace[861577870] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"138.20776ms","start":"2026-04-08T01:30:32.001103Z","end":"2026-04-08T01:30:32.13931Z","steps":["trace[861577870] 'process raft request' (duration: 138.053347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:32.522235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.882007ms","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-08T01:30:32.522398Z","caller":"traceutil/trace.go:171","msg":"trace[816601835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5013; }","duration":"121.112343ms","start":"2026-04-08T01:30:32.401265Z","end":"2026-04-08T01:30:32.522377Z","steps":["trace[816601835] 'range keys from in-memory index tree' (duration: 120.66417ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:32.678751Z","caller":"traceutil/trace.go:171","msg":"trace[218794886] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5198; }","duration":"151.392637ms","start":"2026-04-08T01:30:32.527327Z","end":"2026-04-08T01:30:32.678719Z","steps":["trace[218794886] 'read index received' (duration: 151.136059ms)","trace[218794886] 'applied index is now lower than readState.Index' (duration: 252.098µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:32.678881Z","caller":"traceutil/trace.go:171","msg":"trace[99960830] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"151.959711ms","start":"2026-04-08T01:30:32.526877Z","end":"2026-04-08T01:30:32.678837Z","steps":["trace[99960830] 'process raft request' (duration: 151.596831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:32.67905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.687174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:30:32.679139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.263677ms","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-08T01:30:32.679176Z","caller":"traceutil/trace.go:171","msg":"trace[527409116] range","detail":"{range_begin:/registry/clusterroles/vector; range_end:; response_count:0; response_revision:5014; }","duration":"151.853508ms","start":"2026-04-08T01:30:32.5273Z","end":"2026-04-08T01:30:32.679154Z","steps":["trace[527409116] 'agreement among raft nodes before linearized reading' (duration: 151.639343ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:32.679188Z","caller":"traceutil/trace.go:171","msg":"trace[480840269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5014; }","duration":"142.361849ms","start":"2026-04-08T01:30:32.536813Z","end":"2026-04-08T01:30:32.679174Z","steps":["trace[480840269] 'agreement among raft nodes before linearized reading' (duration: 142.131123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:32.679096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.699844ms","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-08T01:30:32.679253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.874579ms","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-08T01:30:32.679326Z","caller":"traceutil/trace.go:171","msg":"trace[1439878433] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5014; }","duration":"127.945961ms","start":"2026-04-08T01:30:32.551342Z","end":"2026-04-08T01:30:32.679288Z","steps":["trace[1439878433] 'agreement among raft nodes before linearized reading' (duration: 127.620033ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:32.679402Z","caller":"traceutil/trace.go:171","msg":"trace[1012913478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5014; }","duration":"127.993083ms","start":"2026-04-08T01:30:32.551355Z","end":"2026-04-08T01:30:32.679348Z","steps":["trace[1012913478] 'agreement among raft nodes before linearized reading' (duration: 127.670264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:32.679601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.205433ms","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-08T01:30:32.679672Z","caller":"traceutil/trace.go:171","msg":"trace[636139788] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5014; }","duration":"140.295585ms","start":"2026-04-08T01:30:32.539358Z","end":"2026-04-08T01:30:32.679654Z","steps":["trace[636139788] 'agreement among raft nodes before linearized reading' (duration: 139.844863ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:43.693857Z","caller":"traceutil/trace.go:171","msg":"trace[1147957285] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"327.628743ms","start":"2026-04-08T01:30:43.366208Z","end":"2026-04-08T01:30:43.693836Z","steps":["trace[1147957285] 'process raft request' (duration: 228.509587ms)","trace[1147957285] 'compare' (duration: 98.974742ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:30:43.694177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:43.366183Z","time spent":"327.786048ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1046,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:43.738648Z","caller":"traceutil/trace.go:171","msg":"trace[684968327] linearizableReadLoop","detail":"{readStateIndex:5437; appliedIndex:5430; }","duration":"150.507093ms","start":"2026-04-08T01:30:43.588102Z","end":"2026-04-08T01:30:43.738609Z","steps":["trace[684968327] 'read index received' (duration: 6.654105ms)","trace[684968327] 'applied index is now lower than readState.Index' (duration: 143.852108ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:43.738788Z","caller":"traceutil/trace.go:171","msg":"trace[972151337] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"182.411769ms","start":"2026-04-08T01:30:43.556355Z","end":"2026-04-08T01:30:43.738767Z","steps":["trace[972151337] 'process raft request' (duration: 182.137321ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:43.738804Z","caller":"traceutil/trace.go:171","msg":"trace[243815912] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"181.393103ms","start":"2026-04-08T01:30:43.557397Z","end":"2026-04-08T01:30:43.73879Z","steps":["trace[243815912] 'process raft request' (duration: 181.141316ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:43.73891Z","caller":"traceutil/trace.go:171","msg":"trace[463934903] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"298.795327ms","start":"2026-04-08T01:30:43.440106Z","end":"2026-04-08T01:30:43.738902Z","steps":["trace[463934903] 'process raft request' (duration: 298.325554ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:43.738915Z","caller":"traceutil/trace.go:171","msg":"trace[1879994373] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"371.463871ms","start":"2026-04-08T01:30:43.367444Z","end":"2026-04-08T01:30:43.738908Z","steps":["trace[1879994373] 'process raft request' (duration: 370.754733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:43.738911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.78353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-k7bpj.18a43d8c5212e34d\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-08T01:30:43.738957Z","caller":"traceutil/trace.go:171","msg":"trace[319861110] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"180.836757ms","start":"2026-04-08T01:30:43.558114Z","end":"2026-04-08T01:30:43.738951Z","steps":["trace[319861110] 'process raft request' (duration: 180.459707ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:43.738966Z","caller":"traceutil/trace.go:171","msg":"trace[676051763] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-k7bpj.18a43d8c5212e34d; range_end:; response_count:1; response_revision:5245; }","duration":"150.886393ms","start":"2026-04-08T01:30:43.588061Z","end":"2026-04-08T01:30:43.738947Z","steps":["trace[676051763] 'agreement among raft nodes before linearized reading' (duration: 150.680278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:43.738988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:43.367424Z","time spent":"371.505213ms","remote":"127.0.0.1:37648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1564,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:43.739006Z","caller":"traceutil/trace.go:171","msg":"trace[680581619] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"365.415122ms","start":"2026-04-08T01:30:43.373585Z","end":"2026-04-08T01:30:43.739Z","steps":["trace[680581619] 'process raft request' (duration: 364.779836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:43.739036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:43.373568Z","time spent":"365.447104ms","remote":"127.0.0.1:37906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5085,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:51.626721Z","caller":"traceutil/trace.go:171","msg":"trace[2026595873] linearizableReadLoop","detail":"{readStateIndex:5595; appliedIndex:5594; }","duration":"265.617129ms","start":"2026-04-08T01:30:51.361081Z","end":"2026-04-08T01:30:51.626698Z","steps":["trace[2026595873] 'read index received' (duration: 265.389722ms)","trace[2026595873] 'applied index is now lower than readState.Index' (duration: 226.457µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:51.626778Z","caller":"traceutil/trace.go:171","msg":"trace[1779191099] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"299.551907ms","start":"2026-04-08T01:30:51.3272Z","end":"2026-04-08T01:30:51.626752Z","steps":["trace[1779191099] 'process raft request' (duration: 299.320921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:51.626876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.784583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f06be300-5586-4361-82ec-0426d456f05a\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-04-08T01:30:51.626914Z","caller":"traceutil/trace.go:171","msg":"trace[1347866976] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f06be300-5586-4361-82ec-0426d456f05a; range_end:; response_count:1; response_revision:5398; }","duration":"265.879165ms","start":"2026-04-08T01:30:51.361024Z","end":"2026-04-08T01:30:51.626903Z","steps":["trace[1347866976] 'agreement among raft nodes before linearized reading' (duration: 265.797103ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:51.917317Z","caller":"traceutil/trace.go:171","msg":"trace[1454867479] transaction","detail":"{read_only:false; response_revision:5399; number_of_response:1; }","duration":"275.073196ms","start":"2026-04-08T01:30:51.642214Z","end":"2026-04-08T01:30:51.917287Z","steps":["trace[1454867479] 'process raft request' (duration: 249.334552ms)","trace[1454867479] 'compare' (duration: 25.415305ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:52.166161Z","caller":"traceutil/trace.go:171","msg":"trace[816470803] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"396.967788ms","start":"2026-04-08T01:30:51.769159Z","end":"2026-04-08T01:30:52.166126Z","steps":["trace[816470803] 'process raft request' (duration: 362.401253ms)","trace[816470803] 'compare' (duration: 34.316909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:30:52.166374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.769138Z","time spent":"397.129763ms","remote":"127.0.0.1:37646","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-08T01:30:52.166348Z","caller":"traceutil/trace.go:171","msg":"trace[111874292] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"397.173223ms","start":"2026-04-08T01:30:51.76916Z","end":"2026-04-08T01:30:52.166333Z","steps":["trace[111874292] 'process raft request' (duration: 396.914167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.166596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.769127Z","time spent":"397.39985ms","remote":"127.0.0.1:37646","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-08T01:30:52.166883Z","caller":"traceutil/trace.go:171","msg":"trace[1286819278] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"397.599596ms","start":"2026-04-08T01:30:51.769267Z","end":"2026-04-08T01:30:52.166866Z","steps":["trace[1286819278] 'process raft request' (duration: 397.452682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.166959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.769255Z","time spent":"397.662877ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:52.16698Z","caller":"traceutil/trace.go:171","msg":"trace[1903500097] linearizableReadLoop","detail":"{readStateIndex:5600; appliedIndex:5595; }","duration":"370.28382ms","start":"2026-04-08T01:30:51.796674Z","end":"2026-04-08T01:30:52.166958Z","steps":["trace[1903500097] 'read index received' (duration: 94.956938ms)","trace[1903500097] 'applied index is now lower than readState.Index' (duration: 275.325872ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:30:52.16714Z","caller":"traceutil/trace.go:171","msg":"trace[644863084] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"358.342926ms","start":"2026-04-08T01:30:51.80879Z","end":"2026-04-08T01:30:52.167133Z","steps":["trace[644863084] 'process raft request' (duration: 358.018988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.167165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.486196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:30:52.167193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.808777Z","time spent":"358.394068ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:52.166929Z","caller":"traceutil/trace.go:171","msg":"trace[1503333905] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"397.688457ms","start":"2026-04-08T01:30:51.769162Z","end":"2026-04-08T01:30:52.16685Z","steps":["trace[1503333905] 'process raft request' (duration: 397.119912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.167527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.769127Z","time spent":"398.181061ms","remote":"127.0.0.1:37646","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-08T01:30:52.167202Z","caller":"traceutil/trace.go:171","msg":"trace[1611212029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5405; }","duration":"370.572439ms","start":"2026-04-08T01:30:51.796619Z","end":"2026-04-08T01:30:52.167192Z","steps":["trace[1611212029] 'agreement among raft nodes before linearized reading' (duration: 370.490896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.167633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.796599Z","time spent":"371.018179ms","remote":"127.0.0.1:37356","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-08T01:30:52.16713Z","caller":"traceutil/trace.go:171","msg":"trace[1331080654] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"352.681909ms","start":"2026-04-08T01:30:51.81434Z","end":"2026-04-08T01:30:52.167022Z","steps":["trace[1331080654] 'process raft request' (duration: 352.555485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.167767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.814318Z","time spent":"353.392327ms","remote":"127.0.0.1:37528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18274,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:52.335727Z","caller":"traceutil/trace.go:171","msg":"trace[559058634] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"408.382517ms","start":"2026-04-08T01:30:51.927315Z","end":"2026-04-08T01:30:52.335698Z","steps":["trace[559058634] 'process raft request' (duration: 397.677047ms)","trace[559058634] 'compare' (duration: 10.496285ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:30:52.335924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.927303Z","time spent":"408.507801ms","remote":"127.0.0.1:37906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3912,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:30:52.336033Z","caller":"traceutil/trace.go:171","msg":"trace[1864948157] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"408.545143ms","start":"2026-04-08T01:30:51.927457Z","end":"2026-04-08T01:30:52.336002Z","steps":["trace[1864948157] 'process raft request' (duration: 408.178543ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:52.336095Z","caller":"traceutil/trace.go:171","msg":"trace[2115887184] linearizableReadLoop","detail":"{readStateIndex:5605; appliedIndex:5602; }","duration":"169.020489ms","start":"2026-04-08T01:30:52.167047Z","end":"2026-04-08T01:30:52.336068Z","steps":["trace[2115887184] 'read index received' (duration: 157.837425ms)","trace[2115887184] 'applied index is now lower than readState.Index' (duration: 11.181294ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:30:52.336181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.927437Z","time spent":"408.655115ms","remote":"127.0.0.1:37648","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1433,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:30:52.33622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.476325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tr9p\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-08T01:30:52.336289Z","caller":"traceutil/trace.go:171","msg":"trace[21232186] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tr9p; range_end:; response_count:1; response_revision:5408; }","duration":"228.592228ms","start":"2026-04-08T01:30:52.107679Z","end":"2026-04-08T01:30:52.336271Z","steps":["trace[21232186] 'agreement among raft nodes before linearized reading' (duration: 228.420253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.336326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.04688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f06be300-5586-4361-82ec-0426d456f05a\" ","response":"range_response_count:1 size:3762"} {"level":"info","ts":"2026-04-08T01:30:52.336371Z","caller":"traceutil/trace.go:171","msg":"trace[39546665] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f06be300-5586-4361-82ec-0426d456f05a; range_end:; response_count:1; response_revision:5408; }","duration":"413.135583ms","start":"2026-04-08T01:30:51.923214Z","end":"2026-04-08T01:30:52.33635Z","steps":["trace[39546665] 'agreement among raft nodes before linearized reading' (duration: 412.978009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.336393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.177561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2102"} {"level":"warn","ts":"2026-04-08T01:30:52.336403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.92319Z","time spent":"413.206815ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3785,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f06be300-5586-4361-82ec-0426d456f05a\" "} {"level":"info","ts":"2026-04-08T01:30:52.336433Z","caller":"traceutil/trace.go:171","msg":"trace[698628182] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5408; }","duration":"503.243293ms","start":"2026-04-08T01:30:51.833179Z","end":"2026-04-08T01:30:52.336422Z","steps":["trace[698628182] 'agreement among raft nodes before linearized reading' (duration: 503.0881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.33646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.833168Z","time spent":"503.287944ms","remote":"127.0.0.1:34758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":1,"response size":2125,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" "} {"level":"warn","ts":"2026-04-08T01:30:52.336476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.41282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:30:52.336521Z","caller":"traceutil/trace.go:171","msg":"trace[717592317] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5408; }","duration":"426.486542ms","start":"2026-04-08T01:30:51.91002Z","end":"2026-04-08T01:30:52.336507Z","steps":["trace[717592317] 'agreement among raft nodes before linearized reading' (duration: 426.414471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.336553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.910002Z","time spent":"426.542413ms","remote":"127.0.0.1:45696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:30:52.336569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.118264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:30:52.336523Z","caller":"traceutil/trace.go:171","msg":"trace[1921526072] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"408.876811ms","start":"2026-04-08T01:30:51.927636Z","end":"2026-04-08T01:30:52.336512Z","steps":["trace[1921526072] 'process raft request' (duration: 408.230814ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:30:52.336598Z","caller":"traceutil/trace.go:171","msg":"trace[693333319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5408; }","duration":"168.172427ms","start":"2026-04-08T01:30:52.16842Z","end":"2026-04-08T01:30:52.336592Z","steps":["trace[693333319] 'agreement among raft nodes before linearized reading' (duration: 168.126154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:30:52.336634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:30:51.927607Z","time spent":"409.001335ms","remote":"127.0.0.1:37518","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":917,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:31:04.328684Z","caller":"traceutil/trace.go:171","msg":"trace[2018918289] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"118.367731ms","start":"2026-04-08T01:31:04.210295Z","end":"2026-04-08T01:31:04.328663Z","steps":["trace[2018918289] 'process raft request' (duration: 118.193876ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:31:04.348825Z","caller":"traceutil/trace.go:171","msg":"trace[1452837776] transaction","detail":"{read_only:false; response_revision:5569; number_of_response:1; }","duration":"112.772725ms","start":"2026-04-08T01:31:04.236025Z","end":"2026-04-08T01:31:04.348798Z","steps":["trace[1452837776] 'process raft request' (duration: 112.59496ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:31:04.349032Z","caller":"traceutil/trace.go:171","msg":"trace[2020618727] transaction","detail":"{read_only:false; response_revision:5570; number_of_response:1; }","duration":"108.974265ms","start":"2026-04-08T01:31:04.240039Z","end":"2026-04-08T01:31:04.349013Z","steps":["trace[2020618727] 'process raft request' (duration: 108.719178ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:31:04.34905Z","caller":"traceutil/trace.go:171","msg":"trace[1771730535] transaction","detail":"{read_only:false; response_revision:5571; number_of_response:1; }","duration":"108.131024ms","start":"2026-04-08T01:31:04.240901Z","end":"2026-04-08T01:31:04.349032Z","steps":["trace[1771730535] 'process raft request' (duration: 108.054952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:31:50.627867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.383945ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:31:50.628091Z","caller":"traceutil/trace.go:171","msg":"trace[1014115964] transaction","detail":"{read_only:false; response_revision:5980; number_of_response:1; }","duration":"120.24279ms","start":"2026-04-08T01:31:50.507721Z","end":"2026-04-08T01:31:50.627964Z","steps":["trace[1014115964] 'process raft request' (duration: 12.492915ms)","trace[1014115964] 'compare' (duration: 106.895532ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:32:06.30372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006} {"level":"info","ts":"2026-04-08T01:32:06.389162Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"83.919954ms","hash":1357020312,"current-db-size-bytes":58408960,"current-db-size":"58 MB","current-db-size-in-use-bytes":31547392,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-08T01:32:06.389249Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1357020312,"revision":3006,"compact-revision":-1} {"level":"info","ts":"2026-04-08T01:35:50.511237Z","caller":"traceutil/trace.go:171","msg":"trace[1499903064] transaction","detail":"{read_only:false; response_revision:7604; number_of_response:1; }","duration":"112.935027ms","start":"2026-04-08T01:35:50.398278Z","end":"2026-04-08T01:35:50.511213Z","steps":["trace[1499903064] 'process raft request' (duration: 112.752152ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:50.544835Z","caller":"traceutil/trace.go:171","msg":"trace[1277408177] transaction","detail":"{read_only:false; response_revision:7606; number_of_response:1; }","duration":"144.440794ms","start":"2026-04-08T01:35:50.400362Z","end":"2026-04-08T01:35:50.544803Z","steps":["trace[1277408177] 'process raft request' (duration: 144.337671ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:35:50.544956Z","caller":"traceutil/trace.go:171","msg":"trace[1125637056] transaction","detail":"{read_only:false; response_revision:7605; number_of_response:1; }","duration":"145.273916ms","start":"2026-04-08T01:35:50.399655Z","end":"2026-04-08T01:35:50.544929Z","steps":["trace[1125637056] 'process raft request' (duration: 144.926537ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:37:06.312511Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6093} {"level":"info","ts":"2026-04-08T01:37:06.424367Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6093,"took":"109.857626ms","hash":3022700254,"current-db-size-bytes":58408960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21557248,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T01:37:06.424452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3022700254,"revision":6093,"compact-revision":3006} {"level":"warn","ts":"2026-04-08T01:37:24.481723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.728423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:37:24.481878Z","caller":"traceutil/trace.go:171","msg":"trace[255256533] transaction","detail":"{read_only:false; response_revision:8380; number_of_response:1; }","duration":"722.837818ms","start":"2026-04-08T01:37:23.759011Z","end":"2026-04-08T01:37:24.481849Z","steps":["trace[255256533] 'process raft request' (duration: 468.877688ms)","trace[255256533] 'compare' (duration: 253.478017ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:37:24.481969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:23.758993Z","time spent":"722.92946ms","remote":"127.0.0.1:37646","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-08T01:37:24.536994Z","caller":"traceutil/trace.go:171","msg":"trace[640735091] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"688.105249ms","start":"2026-04-08T01:37:23.848859Z","end":"2026-04-08T01:37:24.536964Z","steps":["trace[640735091] 'process raft request' (duration: 687.904104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:37:24.537157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:23.848835Z","time spent":"688.239411ms","remote":"127.0.0.1:37646","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-08T01:37:24.537221Z","caller":"traceutil/trace.go:171","msg":"trace[227294196] transaction","detail":"{read_only:false; response_revision:8382; number_of_response:1; }","duration":"668.46994ms","start":"2026-04-08T01:37:23.86871Z","end":"2026-04-08T01:37:24.53718Z","steps":["trace[227294196] 'process raft request' (duration: 668.208232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:37:24.537378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:23.868686Z","time spent":"668.598742ms","remote":"127.0.0.1:37646","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-08T01:37:35.197174Z","caller":"traceutil/trace.go:171","msg":"trace[1702707854] transaction","detail":"{read_only:false; response_revision:8435; number_of_response:1; }","duration":"164.352138ms","start":"2026-04-08T01:37:35.032696Z","end":"2026-04-08T01:37:35.197048Z","steps":["trace[1702707854] 'process raft request' (duration: 163.753592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:37:35.69968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.275188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:37:35.699926Z","caller":"traceutil/trace.go:171","msg":"trace[935707200] transaction","detail":"{read_only:false; response_revision:8438; number_of_response:1; }","duration":"495.448096ms","start":"2026-04-08T01:37:35.204459Z","end":"2026-04-08T01:37:35.699907Z","steps":["trace[935707200] 'process raft request' (duration: 495.400124ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:37:35.699938Z","caller":"traceutil/trace.go:171","msg":"trace[416109755] transaction","detail":"{read_only:false; response_revision:8437; number_of_response:1; }","duration":"496.783019ms","start":"2026-04-08T01:37:35.203125Z","end":"2026-04-08T01:37:35.699908Z","steps":["trace[416109755] 'process raft request' (duration: 496.675986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:37:35.700001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:35.204449Z","time spent":"495.520157ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:37:35.699946Z","caller":"traceutil/trace.go:171","msg":"trace[1215934557] transaction","detail":"{read_only:false; response_revision:8436; number_of_response:1; }","duration":"497.944209ms","start":"2026-04-08T01:37:35.201952Z","end":"2026-04-08T01:37:35.699896Z","steps":["trace[1215934557] 'process raft request' (duration: 204.371854ms)","trace[1215934557] 'compare' (duration: 292.98597ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:37:35.700127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:35.203087Z","time spent":"496.941753ms","remote":"127.0.0.1:37646","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-08T01:37:35.700335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:37:35.201923Z","time spent":"498.254878ms","remote":"127.0.0.1:37646","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-08T01:37:36.8173Z","caller":"traceutil/trace.go:171","msg":"trace[1897913808] transaction","detail":"{read_only:false; response_revision:8440; number_of_response:1; }","duration":"297.818555ms","start":"2026-04-08T01:37:36.519456Z","end":"2026-04-08T01:37:36.817275Z","steps":["trace[1897913808] 'process raft request' (duration: 297.636381ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:37:36.894154Z","caller":"traceutil/trace.go:171","msg":"trace[1297542536] linearizableReadLoop","detail":"{readStateIndex:8737; appliedIndex:8734; }","duration":"231.871227ms","start":"2026-04-08T01:37:36.662259Z","end":"2026-04-08T01:37:36.89413Z","steps":["trace[1297542536] 'read index received' (duration: 154.853951ms)","trace[1297542536] 'applied index is now lower than readState.Index' (duration: 77.016276ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:37:36.894177Z","caller":"traceutil/trace.go:171","msg":"trace[572567583] transaction","detail":"{read_only:false; response_revision:8441; number_of_response:1; }","duration":"285.750533ms","start":"2026-04-08T01:37:36.608399Z","end":"2026-04-08T01:37:36.894149Z","steps":["trace[572567583] 'process raft request' (duration: 285.513047ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:37:36.89425Z","caller":"traceutil/trace.go:171","msg":"trace[247745441] transaction","detail":"{read_only:false; response_revision:8442; number_of_response:1; }","duration":"239.403033ms","start":"2026-04-08T01:37:36.654808Z","end":"2026-04-08T01:37:36.894211Z","steps":["trace[247745441] 'process raft request' (duration: 239.259239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:37:36.894418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.832469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:37:36.894445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.162474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5tr9p\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-08T01:37:36.89448Z","caller":"traceutil/trace.go:171","msg":"trace[369246281] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:8442; }","duration":"196.956312ms","start":"2026-04-08T01:37:36.697509Z","end":"2026-04-08T01:37:36.894465Z","steps":["trace[369246281] 'agreement among raft nodes before linearized reading' (duration: 196.842099ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:37:36.894529Z","caller":"traceutil/trace.go:171","msg":"trace[47845106] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5tr9p; range_end:; response_count:1; response_revision:8442; }","duration":"232.305699ms","start":"2026-04-08T01:37:36.662204Z","end":"2026-04-08T01:37:36.89451Z","steps":["trace[47845106] 'agreement among raft nodes before linearized reading' (duration: 232.029401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:05.891351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.203236ms","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-08T01:38:05.891423Z","caller":"traceutil/trace.go:171","msg":"trace[167753509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8650; }","duration":"823.301959ms","start":"2026-04-08T01:38:05.068108Z","end":"2026-04-08T01:38:05.89141Z","steps":["trace[167753509] 'range keys from in-memory index tree' (duration: 823.084933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:05.891451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:05.068094Z","time spent":"823.35044ms","remote":"127.0.0.1:37646","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-08T01:38:05.891622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.513094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:38:05.891662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.753285ms","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-08T01:38:05.891691Z","caller":"traceutil/trace.go:171","msg":"trace[332847661] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:8650; }","duration":"410.630967ms","start":"2026-04-08T01:38:05.481042Z","end":"2026-04-08T01:38:05.891673Z","steps":["trace[332847661] 'count revisions from in-memory index tree' (duration: 410.31801ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:05.891766Z","caller":"traceutil/trace.go:171","msg":"trace[507721625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8650; }","duration":"514.91643ms","start":"2026-04-08T01:38:05.376825Z","end":"2026-04-08T01:38:05.891742Z","steps":["trace[507721625] 'range keys from in-memory index tree' (duration: 514.513278ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:05.89181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:05.481022Z","time spent":"410.775192ms","remote":"127.0.0.1:35084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:38:05.891816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:05.376807Z","time spent":"515.000441ms","remote":"127.0.0.1:37646","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-08T01:38:05.891892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.827896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228879"} {"level":"info","ts":"2026-04-08T01:38:05.891929Z","caller":"traceutil/trace.go:171","msg":"trace[631881485] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8650; }","duration":"827.892627ms","start":"2026-04-08T01:38:05.064028Z","end":"2026-04-08T01:38:05.89192Z","steps":["trace[631881485] 'range keys from in-memory index tree' (duration: 827.125748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:05.891968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:05.064011Z","time spent":"827.947939ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":26,"response size":228902,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-04-08T01:38:05.893166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.689228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:38:05.893221Z","caller":"traceutil/trace.go:171","msg":"trace[1937312944] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:8650; }","duration":"674.787831ms","start":"2026-04-08T01:38:05.218419Z","end":"2026-04-08T01:38:05.893207Z","steps":["trace[1937312944] 'count revisions from in-memory index tree' (duration: 674.585205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:05.893262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:05.218401Z","time spent":"674.851423ms","remote":"127.0.0.1:43502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-08T01:38:06.150985Z","caller":"traceutil/trace.go:171","msg":"trace[1429943990] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"253.64071ms","start":"2026-04-08T01:38:05.89732Z","end":"2026-04-08T01:38:06.150961Z","steps":["trace[1429943990] 'process raft request' (duration: 253.477596ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:06.197452Z","caller":"traceutil/trace.go:171","msg":"trace[1783126784] linearizableReadLoop","detail":"{readStateIndex:8956; appliedIndex:8953; }","duration":"288.155134ms","start":"2026-04-08T01:38:05.909278Z","end":"2026-04-08T01:38:06.197433Z","steps":["trace[1783126784] 'read index received' (duration: 241.65019ms)","trace[1783126784] 'applied index is now lower than readState.Index' (duration: 46.504254ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:38:06.197481Z","caller":"traceutil/trace.go:171","msg":"trace[559950503] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"291.981224ms","start":"2026-04-08T01:38:05.905475Z","end":"2026-04-08T01:38:06.197456Z","steps":["trace[559950503] 'process raft request' (duration: 291.83726ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:06.197539Z","caller":"traceutil/trace.go:171","msg":"trace[931222320] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"291.946773ms","start":"2026-04-08T01:38:05.905584Z","end":"2026-04-08T01:38:06.197531Z","steps":["trace[931222320] 'process raft request' (duration: 291.82353ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:06.197738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.455732ms","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-08T01:38:06.197762Z","caller":"traceutil/trace.go:171","msg":"trace[2020394701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8653; }","duration":"288.522414ms","start":"2026-04-08T01:38:05.909234Z","end":"2026-04-08T01:38:06.197757Z","steps":["trace[2020394701] 'agreement among raft nodes before linearized reading' (duration: 288.419992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:06.19775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.887886ms","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-08T01:38:06.197833Z","caller":"traceutil/trace.go:171","msg":"trace[241205944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8653; }","duration":"279.017339ms","start":"2026-04-08T01:38:05.918799Z","end":"2026-04-08T01:38:06.197816Z","steps":["trace[241205944] 'agreement among raft nodes before linearized reading' (duration: 278.814123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:06.197925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.57807ms","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-08T01:38:06.197975Z","caller":"traceutil/trace.go:171","msg":"trace[1803144900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8653; }","duration":"265.687983ms","start":"2026-04-08T01:38:05.932275Z","end":"2026-04-08T01:38:06.197963Z","steps":["trace[1803144900] 'agreement among raft nodes before linearized reading' (duration: 265.53115ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:09.167294Z","caller":"traceutil/trace.go:171","msg":"trace[398115970] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"243.97708ms","start":"2026-04-08T01:38:08.923289Z","end":"2026-04-08T01:38:09.167266Z","steps":["trace[398115970] 'process raft request' (duration: 243.807236ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:09.283581Z","caller":"traceutil/trace.go:171","msg":"trace[1294947635] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"276.02481ms","start":"2026-04-08T01:38:09.007531Z","end":"2026-04-08T01:38:09.283555Z","steps":["trace[1294947635] 'process raft request' (duration: 265.58428ms)","trace[1294947635] 'compare' (duration: 10.063061ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:38:09.283808Z","caller":"traceutil/trace.go:171","msg":"trace[847662935] linearizableReadLoop","detail":"{readStateIndex:8975; appliedIndex:8972; }","duration":"177.864177ms","start":"2026-04-08T01:38:09.105896Z","end":"2026-04-08T01:38:09.28376Z","steps":["trace[847662935] 'read index received' (duration: 61.299987ms)","trace[847662935] 'applied index is now lower than readState.Index' (duration: 116.56235ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:38:09.284043Z","caller":"traceutil/trace.go:171","msg":"trace[447968372] transaction","detail":"{read_only:false; response_revision:8672; number_of_response:1; }","duration":"276.36308ms","start":"2026-04-08T01:38:09.007667Z","end":"2026-04-08T01:38:09.28403Z","steps":["trace[447968372] 'process raft request' (duration: 275.821906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:09.284083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.168555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-08T01:38:09.284147Z","caller":"traceutil/trace.go:171","msg":"trace[1392495038] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8672; }","duration":"178.275637ms","start":"2026-04-08T01:38:09.105855Z","end":"2026-04-08T01:38:09.28413Z","steps":["trace[1392495038] 'agreement among raft nodes before linearized reading' (duration: 178.056292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:09.531947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.374865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-08T01:38:09.532037Z","caller":"traceutil/trace.go:171","msg":"trace[1633577014] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:8672; }","duration":"106.504269ms","start":"2026-04-08T01:38:09.425511Z","end":"2026-04-08T01:38:09.532015Z","steps":["trace[1633577014] 'range keys from in-memory index tree' (duration: 106.116289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.296764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.767748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T01:38:19.296906Z","caller":"traceutil/trace.go:171","msg":"trace[379466999] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"251.201788ms","start":"2026-04-08T01:38:19.045677Z","end":"2026-04-08T01:38:19.296879Z","steps":["trace[379466999] 'process raft request' (duration: 103.178514ms)","trace[379466999] 'compare' (duration: 147.313456ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:38:19.619239Z","caller":"traceutil/trace.go:171","msg":"trace[2058621741] transaction","detail":"{read_only:false; response_revision:8764; number_of_response:1; }","duration":"416.970252ms","start":"2026-04-08T01:38:19.202241Z","end":"2026-04-08T01:38:19.619211Z","steps":["trace[2058621741] 'process raft request' (duration: 416.769526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.619393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.202212Z","time spent":"417.101326ms","remote":"127.0.0.1:37646","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-08T01:38:19.759182Z","caller":"traceutil/trace.go:171","msg":"trace[677677895] transaction","detail":"{read_only:false; response_revision:8766; number_of_response:1; }","duration":"442.597606ms","start":"2026-04-08T01:38:19.316561Z","end":"2026-04-08T01:38:19.759159Z","steps":["trace[677677895] 'process raft request' (duration: 442.529424ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:19.759229Z","caller":"traceutil/trace.go:171","msg":"trace[180271215] transaction","detail":"{read_only:false; response_revision:8765; number_of_response:1; }","duration":"444.577178ms","start":"2026-04-08T01:38:19.314611Z","end":"2026-04-08T01:38:19.759188Z","steps":["trace[180271215] 'process raft request' (duration: 436.234302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.759335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.316547Z","time spent":"442.710969ms","remote":"127.0.0.1:37646","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-08T01:38:19.759348Z","caller":"traceutil/trace.go:171","msg":"trace[6345883] linearizableReadLoop","detail":"{readStateIndex:9074; appliedIndex:9071; }","duration":"397.918339ms","start":"2026-04-08T01:38:19.361414Z","end":"2026-04-08T01:38:19.759332Z","steps":["trace[6345883] 'read index received' (duration: 257.584613ms)","trace[6345883] 'applied index is now lower than readState.Index' (duration: 140.332756ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:38:19.759386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.314587Z","time spent":"444.717551ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:38:19.759466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.039852ms","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-08T01:38:19.759456Z","caller":"traceutil/trace.go:171","msg":"trace[441973307] transaction","detail":"{read_only:false; response_revision:8767; number_of_response:1; }","duration":"338.93988ms","start":"2026-04-08T01:38:19.420476Z","end":"2026-04-08T01:38:19.759416Z","steps":["trace[441973307] 'process raft request' (duration: 338.662952ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:19.7595Z","caller":"traceutil/trace.go:171","msg":"trace[2085724803] 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:8767; }","duration":"398.116404ms","start":"2026-04-08T01:38:19.361372Z","end":"2026-04-08T01:38:19.759488Z","steps":["trace[2085724803] 'agreement among raft nodes before linearized reading' (duration: 398.049242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.759533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.361354Z","time spent":"398.171325ms","remote":"127.0.0.1:43536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-08T01:38:19.759619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.989332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-08T01:38:19.759622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.420458Z","time spent":"339.074414ms","remote":"127.0.0.1:37610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:38:19.759651Z","caller":"traceutil/trace.go:171","msg":"trace[360348803] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8767; }","duration":"261.121104ms","start":"2026-04-08T01:38:19.498519Z","end":"2026-04-08T01:38:19.75964Z","steps":["trace[360348803] 'agreement among raft nodes before linearized reading' (duration: 261.003641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.759637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.449894ms","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-08T01:38:19.759733Z","caller":"traceutil/trace.go:171","msg":"trace[1832288421] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8767; }","duration":"383.590477ms","start":"2026-04-08T01:38:19.376117Z","end":"2026-04-08T01:38:19.759708Z","steps":["trace[1832288421] 'agreement among raft nodes before linearized reading' (duration: 383.351071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.759777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.376096Z","time spent":"383.671999ms","remote":"127.0.0.1:58890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5755,"request content":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" "} {"level":"warn","ts":"2026-04-08T01:38:19.759785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.369591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-08T01:38:19.759831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.041952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:38:19.759841Z","caller":"traceutil/trace.go:171","msg":"trace[1187102037] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:8767; }","duration":"334.454594ms","start":"2026-04-08T01:38:19.42537Z","end":"2026-04-08T01:38:19.759824Z","steps":["trace[1187102037] 'agreement among raft nodes before linearized reading' (duration: 334.29542ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:19.759864Z","caller":"traceutil/trace.go:171","msg":"trace[2068208446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:8767; }","duration":"117.111554ms","start":"2026-04-08T01:38:19.642742Z","end":"2026-04-08T01:38:19.759854Z","steps":["trace[2068208446] 'agreement among raft nodes before linearized reading' (duration: 117.058802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.75988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:19.425358Z","time spent":"334.513595ms","remote":"127.0.0.1:37384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.57\" "} {"level":"info","ts":"2026-04-08T01:38:19.905272Z","caller":"traceutil/trace.go:171","msg":"trace[1936327906] transaction","detail":"{read_only:false; response_revision:8768; number_of_response:1; }","duration":"131.790474ms","start":"2026-04-08T01:38:19.773445Z","end":"2026-04-08T01:38:19.905236Z","steps":["trace[1936327906] 'process raft request' (duration: 117.297909ms)","trace[1936327906] 'compare' (duration: 14.324531ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:38:19.905324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.303962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:38:19.905395Z","caller":"traceutil/trace.go:171","msg":"trace[1601821258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8768; }","duration":"109.415624ms","start":"2026-04-08T01:38:19.795962Z","end":"2026-04-08T01:38:19.905378Z","steps":["trace[1601821258] 'agreement among raft nodes before linearized reading' (duration: 109.26577ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:19.918448Z","caller":"traceutil/trace.go:171","msg":"trace[927488178] transaction","detail":"{read_only:false; response_revision:8769; number_of_response:1; }","duration":"101.695854ms","start":"2026-04-08T01:38:19.816737Z","end":"2026-04-08T01:38:19.918432Z","steps":["trace[927488178] 'process raft request' (duration: 101.563501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:19.918595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.081988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19383"} {"level":"info","ts":"2026-04-08T01:38:19.918662Z","caller":"traceutil/trace.go:171","msg":"trace[1294964186] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8769; }","duration":"101.186451ms","start":"2026-04-08T01:38:19.817459Z","end":"2026-04-08T01:38:19.918645Z","steps":["trace[1294964186] 'agreement among raft nodes before linearized reading' (duration: 101.000056ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:20.654043Z","caller":"traceutil/trace.go:171","msg":"trace[1403824264] transaction","detail":"{read_only:false; response_revision:8773; number_of_response:1; }","duration":"333.86974ms","start":"2026-04-08T01:38:20.320129Z","end":"2026-04-08T01:38:20.653999Z","steps":["trace[1403824264] 'process raft request' (duration: 310.122404ms)","trace[1403824264] 'compare' (duration: 23.503559ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:38:20.654198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:20.320111Z","time spent":"334.007793ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T01:38:20.744522Z","caller":"traceutil/trace.go:171","msg":"trace[180260190] transaction","detail":"{read_only:false; response_revision:8774; number_of_response:1; }","duration":"422.555108ms","start":"2026-04-08T01:38:20.321944Z","end":"2026-04-08T01:38:20.744499Z","steps":["trace[180260190] 'process raft request' (duration: 422.402344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:20.744649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:20.321933Z","time spent":"422.64921ms","remote":"127.0.0.1:37646","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-08T01:38:20.744914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.638323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:16 size:111899"} {"level":"info","ts":"2026-04-08T01:38:20.744995Z","caller":"traceutil/trace.go:171","msg":"trace[1509718891] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:8774; }","duration":"421.744377ms","start":"2026-04-08T01:38:20.323232Z","end":"2026-04-08T01:38:20.744977Z","steps":["trace[1509718891] 'agreement among raft nodes before linearized reading' (duration: 421.366886ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:20.744971Z","caller":"traceutil/trace.go:171","msg":"trace[1331558378] linearizableReadLoop","detail":"{readStateIndex:9083; appliedIndex:9081; }","duration":"421.699196ms","start":"2026-04-08T01:38:20.323255Z","end":"2026-04-08T01:38:20.744954Z","steps":["trace[1331558378] 'read index received' (duration: 307.002594ms)","trace[1331558378] 'applied index is now lower than readState.Index' (duration: 114.694712ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:38:20.745039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:20.323225Z","time spent":"421.804348ms","remote":"127.0.0.1:37544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":16,"response size":111922,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"warn","ts":"2026-04-08T01:38:20.745223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.899599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:38:20.745313Z","caller":"traceutil/trace.go:171","msg":"trace[855170241] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8774; }","duration":"210.050032ms","start":"2026-04-08T01:38:20.535239Z","end":"2026-04-08T01:38:20.745289Z","steps":["trace[855170241] 'agreement among raft nodes before linearized reading' (duration: 209.888528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:20.745316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.266761ms","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-08T01:38:20.745244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.19593ms","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-08T01:38:20.745394Z","caller":"traceutil/trace.go:171","msg":"trace[196915074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8774; }","duration":"419.363824ms","start":"2026-04-08T01:38:20.326017Z","end":"2026-04-08T01:38:20.745381Z","steps":["trace[196915074] 'agreement among raft nodes before linearized reading' (duration: 419.16423ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:20.74541Z","caller":"traceutil/trace.go:171","msg":"trace[681004294] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8774; }","duration":"419.379805ms","start":"2026-04-08T01:38:20.326011Z","end":"2026-04-08T01:38:20.74539Z","steps":["trace[681004294] 'agreement among raft nodes before linearized reading' (duration: 419.095128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:20.745431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:20.325963Z","time spent":"419.459446ms","remote":"127.0.0.1:37646","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-08T01:38:20.745493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:38:20.325999Z","time spent":"419.446936ms","remote":"127.0.0.1:37646","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":"info","ts":"2026-04-08T01:38:20.904627Z","caller":"traceutil/trace.go:171","msg":"trace[114207709] linearizableReadLoop","detail":"{readStateIndex:9086; appliedIndex:9084; }","duration":"118.11671ms","start":"2026-04-08T01:38:20.786489Z","end":"2026-04-08T01:38:20.904606Z","steps":["trace[114207709] 'read index received' (duration: 117.878513ms)","trace[114207709] 'applied index is now lower than readState.Index' (duration: 237.247µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:38:20.904708Z","caller":"traceutil/trace.go:171","msg":"trace[1594085054] transaction","detail":"{read_only:false; response_revision:8776; number_of_response:1; }","duration":"154.562534ms","start":"2026-04-08T01:38:20.750104Z","end":"2026-04-08T01:38:20.904666Z","steps":["trace[1594085054] 'process raft request' (duration: 154.314487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:38:20.904813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.297854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-08T01:38:20.904808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.030138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:38:20.904736Z","caller":"traceutil/trace.go:171","msg":"trace[1149921914] transaction","detail":"{read_only:false; response_revision:8777; number_of_response:1; }","duration":"144.611757ms","start":"2026-04-08T01:38:20.760114Z","end":"2026-04-08T01:38:20.904726Z","steps":["trace[1149921914] 'process raft request' (duration: 144.414411ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:20.904855Z","caller":"traceutil/trace.go:171","msg":"trace[960711159] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8777; }","duration":"118.382467ms","start":"2026-04-08T01:38:20.786463Z","end":"2026-04-08T01:38:20.904845Z","steps":["trace[960711159] 'agreement among raft nodes before linearized reading' (duration: 118.291985ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:20.904899Z","caller":"traceutil/trace.go:171","msg":"trace[347053591] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8777; }","duration":"108.120221ms","start":"2026-04-08T01:38:20.796732Z","end":"2026-04-08T01:38:20.904852Z","steps":["trace[347053591] 'agreement among raft nodes before linearized reading' (duration: 108.033879ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:21.223271Z","caller":"traceutil/trace.go:171","msg":"trace[1553521627] transaction","detail":"{read_only:false; response_revision:8778; number_of_response:1; }","duration":"192.444665ms","start":"2026-04-08T01:38:21.030795Z","end":"2026-04-08T01:38:21.223239Z","steps":["trace[1553521627] 'process raft request' (duration: 192.162027ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:21.333875Z","caller":"traceutil/trace.go:171","msg":"trace[2097241203] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"101.726306ms","start":"2026-04-08T01:38:21.232124Z","end":"2026-04-08T01:38:21.333851Z","steps":["trace[2097241203] 'process raft request' (duration: 50.385045ms)","trace[2097241203] 'compare' (duration: 50.869748ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:38:32.296679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.468574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/ceph-object-controller-detect-version-pdfgz\" ","response":"range_response_count:1 size:4558"} {"level":"info","ts":"2026-04-08T01:38:32.296779Z","caller":"traceutil/trace.go:171","msg":"trace[1045350782] range","detail":"{range_begin:/registry/pods/openstack/ceph-object-controller-detect-version-pdfgz; range_end:; response_count:1; response_revision:8868; }","duration":"146.584047ms","start":"2026-04-08T01:38:32.150173Z","end":"2026-04-08T01:38:32.296757Z","steps":["trace[1045350782] 'range keys from in-memory index tree' (duration: 146.269239ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:38:36.151304Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243b.wal"} {"level":"info","ts":"2026-04-08T01:39:22.791394Z","caller":"traceutil/trace.go:171","msg":"trace[1713192553] transaction","detail":"{read_only:false; response_revision:9436; number_of_response:1; }","duration":"118.037798ms","start":"2026-04-08T01:39:22.673335Z","end":"2026-04-08T01:39:22.791373Z","steps":["trace[1713192553] 'process raft request' (duration: 117.913725ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:39:35.165179Z","caller":"traceutil/trace.go:171","msg":"trace[1939812985] transaction","detail":"{read_only:false; response_revision:9507; number_of_response:1; }","duration":"133.153431ms","start":"2026-04-08T01:39:35.031994Z","end":"2026-04-08T01:39:35.165147Z","steps":["trace[1939812985] 'process raft request' (duration: 132.890723ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:39:35.537614Z","caller":"traceutil/trace.go:171","msg":"trace[647980136] linearizableReadLoop","detail":"{readStateIndex:9839; appliedIndex:9838; }","duration":"187.990942ms","start":"2026-04-08T01:39:35.349596Z","end":"2026-04-08T01:39:35.537587Z","steps":["trace[647980136] 'read index received' (duration: 123.573263ms)","trace[647980136] 'applied index is now lower than readState.Index' (duration: 64.416359ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:39:35.537776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.164067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:39:35.537835Z","caller":"traceutil/trace.go:171","msg":"trace[2004897660] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:9510; }","duration":"188.274189ms","start":"2026-04-08T01:39:35.349547Z","end":"2026-04-08T01:39:35.537822Z","steps":["trace[2004897660] 'agreement among raft nodes before linearized reading' (duration: 188.163046ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:39:35.537642Z","caller":"traceutil/trace.go:171","msg":"trace[1514035345] transaction","detail":"{read_only:false; response_revision:9510; number_of_response:1; }","duration":"224.881958ms","start":"2026-04-08T01:39:35.312729Z","end":"2026-04-08T01:39:35.537611Z","steps":["trace[1514035345] 'process raft request' (duration: 160.409527ms)","trace[1514035345] 'compare' (duration: 64.298586ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:39:35.538242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.854933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:39:35.53839Z","caller":"traceutil/trace.go:171","msg":"trace[961851674] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:9510; }","duration":"133.033967ms","start":"2026-04-08T01:39:35.405335Z","end":"2026-04-08T01:39:35.538369Z","steps":["trace[961851674] 'agreement among raft nodes before linearized reading' (duration: 132.843743ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:39:55.267919Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b6478f0ac5aeb8e1","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T01:39:55.274828Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T01:39:55.275037Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T01:42:06.321737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8120} {"level":"info","ts":"2026-04-08T01:42:06.39142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8120,"took":"65.722642ms","hash":2743987109,"current-db-size-bytes":58408960,"current-db-size":"58 MB","current-db-size-in-use-bytes":28729344,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T01:42:06.391509Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2743987109,"revision":8120,"compact-revision":6093} {"level":"info","ts":"2026-04-08T01:44:11.309712Z","caller":"traceutil/trace.go:171","msg":"trace[2000718931] transaction","detail":"{read_only:false; response_revision:11332; number_of_response:1; }","duration":"597.720407ms","start":"2026-04-08T01:44:10.711948Z","end":"2026-04-08T01:44:11.309668Z","steps":["trace[2000718931] 'process raft request' (duration: 597.45782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:11.309979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:10.711926Z","time spent":"597.915412ms","remote":"127.0.0.1:37646","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-08T01:44:11.310534Z","caller":"traceutil/trace.go:171","msg":"trace[1020841930] linearizableReadLoop","detail":"{readStateIndex:11726; appliedIndex:11724; }","duration":"468.769831ms","start":"2026-04-08T01:44:10.841744Z","end":"2026-04-08T01:44:11.310514Z","steps":["trace[1020841930] 'read index received' (duration: 467.613931ms)","trace[1020841930] 'applied index is now lower than readState.Index' (duration: 1.15513ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:44:11.310701Z","caller":"traceutil/trace.go:171","msg":"trace[406161377] transaction","detail":"{read_only:false; response_revision:11335; number_of_response:1; }","duration":"291.37535ms","start":"2026-04-08T01:44:11.019306Z","end":"2026-04-08T01:44:11.310682Z","steps":["trace[406161377] 'process raft request' (duration: 291.180215ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:11.310807Z","caller":"traceutil/trace.go:171","msg":"trace[1543570212] transaction","detail":"{read_only:false; response_revision:11334; number_of_response:1; }","duration":"291.608875ms","start":"2026-04-08T01:44:11.019175Z","end":"2026-04-08T01:44:11.310784Z","steps":["trace[1543570212] 'process raft request' (duration: 291.283608ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:11.310575Z","caller":"traceutil/trace.go:171","msg":"trace[71910594] transaction","detail":"{read_only:false; response_revision:11333; number_of_response:1; }","duration":"469.185181ms","start":"2026-04-08T01:44:10.841366Z","end":"2026-04-08T01:44:11.310551Z","steps":["trace[71910594] 'process raft request' (duration: 468.967985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:11.311106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.349716ms","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-08T01:44:11.311132Z","caller":"traceutil/trace.go:171","msg":"trace[1803603421] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11335; }","duration":"469.455289ms","start":"2026-04-08T01:44:10.841671Z","end":"2026-04-08T01:44:11.311126Z","steps":["trace[1803603421] 'agreement among raft nodes before linearized reading' (duration: 469.308005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:11.31115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:10.841652Z","time spent":"469.493299ms","remote":"127.0.0.1:37646","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-08T01:44:11.311345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.464102ms","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-08T01:44:11.311363Z","caller":"traceutil/trace.go:171","msg":"trace[1667221361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11335; }","duration":"337.531654ms","start":"2026-04-08T01:44:10.973824Z","end":"2026-04-08T01:44:11.311356Z","steps":["trace[1667221361] 'agreement among raft nodes before linearized reading' (duration: 337.478323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:11.311378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:10.973794Z","time spent":"337.578805ms","remote":"127.0.0.1:37646","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-08T01:44:11.311373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.103639ms","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-08T01:44:11.311406Z","caller":"traceutil/trace.go:171","msg":"trace[95097217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11335; }","duration":"469.18796ms","start":"2026-04-08T01:44:10.842209Z","end":"2026-04-08T01:44:11.311397Z","steps":["trace[95097217] 'agreement among raft nodes before linearized reading' (duration: 469.045117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:11.311439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:10.84219Z","time spent":"469.242792ms","remote":"127.0.0.1:37646","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-08T01:44:11.311569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:10.841332Z","time spent":"470.154206ms","remote":"127.0.0.1:37646","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-08T01:44:47.753379Z","caller":"traceutil/trace.go:171","msg":"trace[1113803196] transaction","detail":"{read_only:false; response_revision:11515; number_of_response:1; }","duration":"316.084558ms","start":"2026-04-08T01:44:47.437246Z","end":"2026-04-08T01:44:47.753331Z","steps":["trace[1113803196] 'process raft request' (duration: 315.239807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:47.75357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:47.437227Z","time spent":"316.244283ms","remote":"127.0.0.1:37646","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-08T01:44:47.754249Z","caller":"traceutil/trace.go:171","msg":"trace[1227098371] transaction","detail":"{read_only:false; response_revision:11516; number_of_response:1; }","duration":"302.023965ms","start":"2026-04-08T01:44:47.452212Z","end":"2026-04-08T01:44:47.754236Z","steps":["trace[1227098371] 'process raft request' (duration: 301.905412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:47.754358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:47.452204Z","time spent":"302.122259ms","remote":"127.0.0.1:37646","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-08T01:44:47.754428Z","caller":"traceutil/trace.go:171","msg":"trace[981902983] transaction","detail":"{read_only:false; response_revision:11517; number_of_response:1; }","duration":"302.095798ms","start":"2026-04-08T01:44:47.452316Z","end":"2026-04-08T01:44:47.754412Z","steps":["trace[981902983] 'process raft request' (duration: 301.888242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:47.754541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:47.45228Z","time spent":"302.205241ms","remote":"127.0.0.1:37646","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-08T01:44:47.754918Z","caller":"traceutil/trace.go:171","msg":"trace[259307139] linearizableReadLoop","detail":"{readStateIndex:11917; appliedIndex:11914; }","duration":"274.900653ms","start":"2026-04-08T01:44:47.479998Z","end":"2026-04-08T01:44:47.754898Z","steps":["trace[259307139] 'read index received' (duration: 272.45751ms)","trace[259307139] 'applied index is now lower than readState.Index' (duration: 2.442233ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:44:47.755247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.219731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T01:44:47.755353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.028437ms","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-08T01:44:47.755343Z","caller":"traceutil/trace.go:171","msg":"trace[1556773684] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:11518; }","duration":"275.327414ms","start":"2026-04-08T01:44:47.479993Z","end":"2026-04-08T01:44:47.755321Z","steps":["trace[1556773684] 'agreement among raft nodes before linearized reading' (duration: 275.1593ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:47.755464Z","caller":"traceutil/trace.go:171","msg":"trace[235587571] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11518; }","duration":"263.16207ms","start":"2026-04-08T01:44:47.492275Z","end":"2026-04-08T01:44:47.755437Z","steps":["trace[235587571] 'agreement among raft nodes before linearized reading' (duration: 262.847542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:47.755479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.846078ms","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-08T01:44:47.755552Z","caller":"traceutil/trace.go:171","msg":"trace[1724544086] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11518; }","duration":"265.931101ms","start":"2026-04-08T01:44:47.489598Z","end":"2026-04-08T01:44:47.755529Z","steps":["trace[1724544086] 'agreement among raft nodes before linearized reading' (duration: 265.415019ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:47.91245Z","caller":"traceutil/trace.go:171","msg":"trace[795981439] transaction","detail":"{read_only:false; response_revision:11521; number_of_response:1; }","duration":"151.971602ms","start":"2026-04-08T01:44:47.760453Z","end":"2026-04-08T01:44:47.912424Z","steps":["trace[795981439] 'process raft request' (duration: 151.920181ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:47.913127Z","caller":"traceutil/trace.go:171","msg":"trace[448180954] transaction","detail":"{read_only:false; response_revision:11520; number_of_response:1; }","duration":"152.935017ms","start":"2026-04-08T01:44:47.760128Z","end":"2026-04-08T01:44:47.913063Z","steps":["trace[448180954] 'process raft request' (duration: 152.125836ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:47.913365Z","caller":"traceutil/trace.go:171","msg":"trace[1512527318] linearizableReadLoop","detail":"{readStateIndex:11921; appliedIndex:11921; }","duration":"150.874805ms","start":"2026-04-08T01:44:47.762475Z","end":"2026-04-08T01:44:47.91335Z","steps":["trace[1512527318] 'read index received' (duration: 150.862714ms)","trace[1512527318] 'applied index is now lower than readState.Index' (duration: 11.301µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T01:44:47.913846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.356076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-08T01:44:47.913881Z","caller":"traceutil/trace.go:171","msg":"trace[1297924032] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11521; }","duration":"151.436809ms","start":"2026-04-08T01:44:47.762435Z","end":"2026-04-08T01:44:47.913872Z","steps":["trace[1297924032] 'agreement among raft nodes before linearized reading' (duration: 151.289605ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T01:44:53.582559Z","caller":"traceutil/trace.go:171","msg":"trace[484101219] transaction","detail":"{read_only:false; response_revision:11542; number_of_response:1; }","duration":"467.853947ms","start":"2026-04-08T01:44:53.114673Z","end":"2026-04-08T01:44:53.582527Z","steps":["trace[484101219] 'process raft request' (duration: 467.61964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:53.582738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:53.114645Z","time spent":"467.996291ms","remote":"127.0.0.1:37646","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-08T01:44:53.696057Z","caller":"traceutil/trace.go:171","msg":"trace[165647785] transaction","detail":"{read_only:false; response_revision:11543; number_of_response:1; }","duration":"581.277933ms","start":"2026-04-08T01:44:53.114759Z","end":"2026-04-08T01:44:53.696037Z","steps":["trace[165647785] 'process raft request' (duration: 581.111938ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:53.69618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:53.11475Z","time spent":"581.363035ms","remote":"127.0.0.1:37646","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-08T01:44:53.696279Z","caller":"traceutil/trace.go:171","msg":"trace[496330943] linearizableReadLoop","detail":"{readStateIndex:11945; appliedIndex:11942; }","duration":"432.082981ms","start":"2026-04-08T01:44:53.264174Z","end":"2026-04-08T01:44:53.696257Z","steps":["trace[496330943] 'read index received' (duration: 318.098821ms)","trace[496330943] 'applied index is now lower than readState.Index' (duration: 113.98313ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:44:53.696441Z","caller":"traceutil/trace.go:171","msg":"trace[1848050833] transaction","detail":"{read_only:false; response_revision:11544; number_of_response:1; }","duration":"575.453181ms","start":"2026-04-08T01:44:53.120971Z","end":"2026-04-08T01:44:53.696424Z","steps":["trace[1848050833] 'process raft request' (duration: 575.032401ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:53.696565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:53.120958Z","time spent":"575.519074ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:44:53.696615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.45224ms","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-08T01:44:53.696639Z","caller":"traceutil/trace.go:171","msg":"trace[1660442532] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:11544; }","duration":"432.533112ms","start":"2026-04-08T01:44:53.264099Z","end":"2026-04-08T01:44:53.696632Z","steps":["trace[1660442532] 'agreement among raft nodes before linearized reading' (duration: 432.494061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:44:53.696657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:44:53.264073Z","time spent":"432.578264ms","remote":"127.0.0.1:37876","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-08T01:47:06.327508Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10664} {"level":"info","ts":"2026-04-08T01:47:06.417123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10664,"took":"84.922928ms","hash":2155023140,"current-db-size-bytes":58408960,"current-db-size":"58 MB","current-db-size-in-use-bytes":21426176,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-08T01:47:06.417182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2155023140,"revision":10664,"compact-revision":8120} {"level":"warn","ts":"2026-04-08T01:47:09.562528Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13322102254261382030,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-08T01:47:09.602013Z","caller":"traceutil/trace.go:171","msg":"trace[1960031611] transaction","detail":"{read_only:false; response_revision:12238; number_of_response:1; }","duration":"797.894408ms","start":"2026-04-08T01:47:08.804086Z","end":"2026-04-08T01:47:09.601981Z","steps":["trace[1960031611] 'process raft request' (duration: 797.737494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.602174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:08.804067Z","time spent":"798.022ms","remote":"127.0.0.1:37646","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-08T01:47:09.603269Z","caller":"traceutil/trace.go:171","msg":"trace[1844328073] linearizableReadLoop","detail":"{readStateIndex:12669; appliedIndex:12667; }","duration":"541.767298ms","start":"2026-04-08T01:47:09.061477Z","end":"2026-04-08T01:47:09.603244Z","steps":["trace[1844328073] 'read index received' (duration: 540.423473ms)","trace[1844328073] 'applied index is now lower than readState.Index' (duration: 1.342635ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T01:47:09.603342Z","caller":"traceutil/trace.go:171","msg":"trace[699126041] transaction","detail":"{read_only:false; response_revision:12239; number_of_response:1; }","duration":"749.452794ms","start":"2026-04-08T01:47:08.853852Z","end":"2026-04-08T01:47:09.603304Z","steps":["trace[699126041] 'process raft request' (duration: 749.259918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.60355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:08.853825Z","time spent":"749.604828ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T01:47:09.603607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.270179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-controller-certificates\" ","response":"range_response_count:1 size:1466"} {"level":"info","ts":"2026-04-08T01:47:09.603654Z","caller":"traceutil/trace.go:171","msg":"trace[1298122293] range","detail":"{range_begin:/registry/clusterroles/cert-manager-controller-certificates; range_end:; response_count:1; response_revision:12239; }","duration":"460.347251ms","start":"2026-04-08T01:47:09.143293Z","end":"2026-04-08T01:47:09.60364Z","steps":["trace[1298122293] 'agreement among raft nodes before linearized reading' (duration: 460.240619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.603686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:09.143277Z","time spent":"460.401362ms","remote":"127.0.0.1:37732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":1489,"request content":"key:\"/registry/clusterroles/cert-manager-controller-certificates\" "} {"level":"warn","ts":"2026-04-08T01:47:09.603679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.278583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cert-manager-controller-approve:cert-manager-io\" ","response":"range_response_count:1 size:1134"} {"level":"warn","ts":"2026-04-08T01:47:09.603708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.649054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T01:47:09.603751Z","caller":"traceutil/trace.go:171","msg":"trace[569749118] range","detail":"{range_begin:/registry/clusterroles/cert-manager-controller-approve:cert-manager-io; range_end:; response_count:1; response_revision:12239; }","duration":"457.374535ms","start":"2026-04-08T01:47:09.146355Z","end":"2026-04-08T01:47:09.603729Z","steps":["trace[569749118] 'agreement among raft nodes before linearized reading' (duration: 457.155169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.603804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:09.146339Z","time spent":"457.450997ms","remote":"127.0.0.1:37732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":1157,"request content":"key:\"/registry/clusterroles/cert-manager-controller-approve:cert-manager-io\" "} {"level":"info","ts":"2026-04-08T01:47:09.603804Z","caller":"traceutil/trace.go:171","msg":"trace[1118902049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12239; }","duration":"476.795108ms","start":"2026-04-08T01:47:09.126982Z","end":"2026-04-08T01:47:09.603777Z","steps":["trace[1118902049] 'agreement among raft nodes before linearized reading' (duration: 476.591813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.603858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:09.126965Z","time spent":"476.884731ms","remote":"127.0.0.1:37356","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-08T01:47:09.603837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.545451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.57\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T01:47:09.603926Z","caller":"traceutil/trace.go:171","msg":"trace[588578852] range","detail":"{range_begin:/registry/masterleases/199.204.45.57; range_end:; response_count:1; response_revision:12239; }","duration":"151.688946ms","start":"2026-04-08T01:47:09.452212Z","end":"2026-04-08T01:47:09.603901Z","steps":["trace[588578852] 'agreement among raft nodes before linearized reading' (duration: 151.397988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.603896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.454626ms","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-08T01:47:09.604094Z","caller":"traceutil/trace.go:171","msg":"trace[1246894389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12239; }","duration":"479.670952ms","start":"2026-04-08T01:47:09.124393Z","end":"2026-04-08T01:47:09.604064Z","steps":["trace[1246894389] 'agreement among raft nodes before linearized reading' (duration: 479.117697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.603973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.002624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-04-08T01:47:09.604154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:09.124371Z","time spent":"479.766304ms","remote":"127.0.0.1:37646","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-08T01:47:09.604208Z","caller":"traceutil/trace.go:171","msg":"trace[722449529] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:12239; }","duration":"542.728062ms","start":"2026-04-08T01:47:09.061445Z","end":"2026-04-08T01:47:09.604173Z","steps":["trace[722449529] 'agreement among raft nodes before linearized reading' (duration: 541.928992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T01:47:09.604281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T01:47:09.061431Z","time spent":"542.830066ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-08T01:47:10.553387Z","caller":"traceutil/trace.go:171","msg":"trace[270659742] transaction","detail":"{read_only:false; response_revision:12251; number_of_response:1; }","duration":"113.916948ms","start":"2026-04-08T01:47:10.439444Z","end":"2026-04-08T01:47:10.553361Z","steps":["trace[270659742] 'process raft request' (duration: 112.05665ms)"],"step_count":1}