{"level":"warn","ts":"2026-06-13T06:14:09.322593Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T06:14:09.322695Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-06-13T06:14:09.32278Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-13T06:14:09.322794Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-13T06:14:09.322836Z","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-06-13T06:14:09.323694Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-06-13T06:14:09.323791Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-06-13T06:14:09.465211Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"106.413232ms"} {"level":"info","ts":"2026-06-13T06:14:09.480289Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-06-13T06:14:09.480391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T06:14:09.480412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-06-13T06:14:09.480428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T06:14:09.480438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-06-13T06:14:09.480481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-06-13T06:14:09.489479Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T06:14:09.491089Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T06:14:09.495614Z","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-06-13T06:14:09.499291Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T06:14:09.501015Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T06:14:09.50139Z","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-06-13T06:14:09.50151Z","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-06-13T06:14:09.501528Z","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-06-13T06:14:09.502242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-06-13T06:14:09.502343Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-13T06:14:09.504504Z","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-06-13T06:14:09.504553Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-13T06:14:09.504622Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-13T06:14:09.504835Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T06:14:09.504868Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T06:14:09.581754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T06:14:09.581796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T06:14:09.581838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-06-13T06:14:09.581857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-06-13T06:14:09.581954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-13T06:14:09.581983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-06-13T06:14:09.581997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-13T06:14:09.583017Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T06:14:09.58454Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T06:14:09.584453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T06:14:09.585366Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:14:09.585512Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T06:14:09.585566Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T06:14:09.586772Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:14:09.586924Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T06:14:09.588616Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T06:14:09.589012Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-06-13T06:14:09.594983Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-13T06:14:12.933111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.76744ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:12.933264Z","caller":"traceutil/trace.go:171","msg":"trace[197149666] transaction","detail":"{read_only:false; response_revision:158; number_of_response:1; }","duration":"167.589739ms","start":"2026-06-13T06:14:12.765653Z","end":"2026-06-13T06:14:12.933243Z","steps":["trace[197149666] 'process raft request' (duration: 46.037091ms)","trace[197149666] 'compare' (duration: 120.598596ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:13.981657Z","caller":"traceutil/trace.go:171","msg":"trace[480644665] transaction","detail":"{read_only:false; response_revision:171; number_of_response:1; }","duration":"525.303785ms","start":"2026-06-13T06:14:13.456314Z","end":"2026-06-13T06:14:13.981618Z","steps":["trace[480644665] 'process raft request' (duration: 498.886119ms)","trace[480644665] 'compare' (duration: 26.234312ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:13.98187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:13.456298Z","time spent":"525.47287ms","remote":"127.0.0.1:36286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":764,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:15.736964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.232359403s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-06-13T06:14:15.737163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.235908Z","time spent":"501.251044ms","remote":"127.0.0.1:36018","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-13T06:14:15.73731Z","caller":"traceutil/trace.go:171","msg":"trace[2146741988] transaction","detail":"{read_only:false; response_revision:172; number_of_response:1; }","duration":"1.749279559s","start":"2026-06-13T06:14:13.988005Z","end":"2026-06-13T06:14:15.737284Z","steps":["trace[2146741988] 'process raft request' (duration: 516.529057ms)","trace[2146741988] 'compare' (duration: 1.231984604s)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:15.737314Z","caller":"traceutil/trace.go:171","msg":"trace[680212871] linearizableReadLoop","detail":"{readStateIndex:176; appliedIndex:175; }","duration":"1.473254449s","start":"2026-06-13T06:14:14.264035Z","end":"2026-06-13T06:14:15.73729Z","steps":["trace[680212871] 'read index received' (duration: 240.426916ms)","trace[680212871] 'applied index is now lower than readState.Index' (duration: 1.232825503s)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:15.737377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:13.987984Z","time spent":"1.749364261s","remote":"127.0.0.1:36286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":732,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:15.737487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.442693826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:15.737531Z","caller":"traceutil/trace.go:171","msg":"trace[519904069] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:172; }","duration":"1.442818989s","start":"2026-06-13T06:14:14.294701Z","end":"2026-06-13T06:14:15.73752Z","steps":["trace[519904069] 'agreement among raft nodes before linearized reading' (duration: 1.442709446s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:15.737568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:14.294674Z","time spent":"1.44288521s","remote":"127.0.0.1:35940","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-06-13T06:14:15.737701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.186986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:15.737747Z","caller":"traceutil/trace.go:171","msg":"trace[1513290500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:172; }","duration":"236.255987ms","start":"2026-06-13T06:14:15.50148Z","end":"2026-06-13T06:14:15.737736Z","steps":["trace[1513290500] 'agreement among raft nodes before linearized reading' (duration: 236.189435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:15.737766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.318482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:15.737825Z","caller":"traceutil/trace.go:171","msg":"trace[352078933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:172; }","duration":"519.383624ms","start":"2026-06-13T06:14:15.218402Z","end":"2026-06-13T06:14:15.737785Z","steps":["trace[352078933] 'agreement among raft nodes before linearized reading' (duration: 519.340243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:15.737865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.218371Z","time spent":"519.481266ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T06:14:15.738484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.474330525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:15.738639Z","caller":"traceutil/trace.go:171","msg":"trace[866543101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:172; }","duration":"1.474639833s","start":"2026-06-13T06:14:14.263975Z","end":"2026-06-13T06:14:15.738615Z","steps":["trace[866543101] 'agreement among raft nodes before linearized reading' (duration: 1.473358932s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:15.738795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:14.263953Z","time spent":"1.474809286s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T06:14:16.423964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.836869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:16.424105Z","caller":"traceutil/trace.go:171","msg":"trace[1052066154] linearizableReadLoop","detail":"{readStateIndex:178; appliedIndex:177; }","duration":"682.822206ms","start":"2026-06-13T06:14:15.741266Z","end":"2026-06-13T06:14:16.424088Z","steps":["trace[1052066154] 'read index received' (duration: 321.832653ms)","trace[1052066154] 'applied index is now lower than readState.Index' (duration: 360.988283ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:16.42424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.966069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:16.424275Z","caller":"traceutil/trace.go:171","msg":"trace[1992510922] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:statefulset-controller; range_end:; response_count:0; response_revision:173; }","duration":"683.027501ms","start":"2026-06-13T06:14:15.741235Z","end":"2026-06-13T06:14:16.424263Z","steps":["trace[1992510922] 'agreement among raft nodes before linearized reading' (duration: 682.908248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:16.424317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.74122Z","time spent":"683.090092ms","remote":"127.0.0.1:36286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/clusterrolebindings/system:controller:statefulset-controller\" "} {"level":"info","ts":"2026-06-13T06:14:16.424504Z","caller":"traceutil/trace.go:171","msg":"trace[1734111575] transaction","detail":"{read_only:false; response_revision:173; number_of_response:1; }","duration":"684.510086ms","start":"2026-06-13T06:14:15.739982Z","end":"2026-06-13T06:14:16.424492Z","steps":["trace[1734111575] 'process raft request' (duration: 323.063233ms)","trace[1734111575] 'compare' (duration: 360.716676ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:16.424556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.73996Z","time spent":"684.574407ms","remote":"127.0.0.1:36018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:16.444684Z","caller":"traceutil/trace.go:171","msg":"trace[1685366911] transaction","detail":"{read_only:false; response_revision:174; number_of_response:1; }","duration":"702.461151ms","start":"2026-06-13T06:14:15.742189Z","end":"2026-06-13T06:14:16.44465Z","steps":["trace[1685366911] 'process raft request' (duration: 702.264966ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:16.444719Z","caller":"traceutil/trace.go:171","msg":"trace[581300522] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"702.42137ms","start":"2026-06-13T06:14:15.742276Z","end":"2026-06-13T06:14:16.444697Z","steps":["trace[581300522] 'process raft request' (duration: 702.289877ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:16.444832Z","caller":"traceutil/trace.go:171","msg":"trace[706291526] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"702.443931ms","start":"2026-06-13T06:14:15.742323Z","end":"2026-06-13T06:14:16.444767Z","steps":["trace[706291526] 'process raft request' (duration: 702.271147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:16.4449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.742269Z","time spent":"702.583145ms","remote":"127.0.0.1:36202","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-06-13T06:14:16.444906Z","caller":"traceutil/trace.go:171","msg":"trace[15141476] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"700.941545ms","start":"2026-06-13T06:14:15.74394Z","end":"2026-06-13T06:14:16.444881Z","steps":["trace[15141476] 'process raft request' (duration: 700.676329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:16.444979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.742165Z","time spent":"702.598005ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:16.445041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.74392Z","time spent":"701.060588ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:16.445051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.742317Z","time spent":"702.631395ms","remote":"127.0.0.1:36202","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-06-13T06:14:16.445193Z","caller":"traceutil/trace.go:171","msg":"trace[830102568] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"493.537422ms","start":"2026-06-13T06:14:15.951643Z","end":"2026-06-13T06:14:16.44518Z","steps":["trace[830102568] 'process raft request' (duration: 493.185624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:16.445279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:15.951617Z","time spent":"493.636014ms","remote":"127.0.0.1:36108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3953,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:22.602395Z","caller":"traceutil/trace.go:171","msg":"trace[1530494730] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:377; }","duration":"139.549167ms","start":"2026-06-13T06:14:22.462825Z","end":"2026-06-13T06:14:22.602374Z","steps":["trace[1530494730] 'read index received' (duration: 43.363598ms)","trace[1530494730] 'applied index is now lower than readState.Index' (duration: 96.184699ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:22.602482Z","caller":"traceutil/trace.go:171","msg":"trace[970963038] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"139.772191ms","start":"2026-06-13T06:14:22.462675Z","end":"2026-06-13T06:14:22.602447Z","steps":["trace[970963038] 'process raft request' (duration: 139.645198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:22.602591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.198041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T06:14:22.602595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.751071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-06-13T06:14:22.602695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.222418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-13T06:14:22.60269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.900021ms","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-06-13T06:14:22.60271Z","caller":"traceutil/trace.go:171","msg":"trace[1762822902] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:365; }","duration":"139.897475ms","start":"2026-06-13T06:14:22.462787Z","end":"2026-06-13T06:14:22.602685Z","steps":["trace[1762822902] 'agreement among raft nodes before linearized reading' (duration: 139.69357ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.60273Z","caller":"traceutil/trace.go:171","msg":"trace[1857131915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:365; }","duration":"120.27706ms","start":"2026-06-13T06:14:22.482444Z","end":"2026-06-13T06:14:22.602721Z","steps":["trace[1857131915] 'agreement among raft nodes before linearized reading' (duration: 120.223339ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.602746Z","caller":"traceutil/trace.go:171","msg":"trace[1737903898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:365; }","duration":"119.991213ms","start":"2026-06-13T06:14:22.482737Z","end":"2026-06-13T06:14:22.602728Z","steps":["trace[1737903898] 'agreement among raft nodes before linearized reading' (duration: 119.85115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:22.602786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.130073ms","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-06-13T06:14:22.602637Z","caller":"traceutil/trace.go:171","msg":"trace[225961037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:365; }","duration":"121.281694ms","start":"2026-06-13T06:14:22.481343Z","end":"2026-06-13T06:14:22.602625Z","steps":["trace[225961037] 'agreement among raft nodes before linearized reading' (duration: 121.182471ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.602885Z","caller":"traceutil/trace.go:171","msg":"trace[1621248758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:365; }","duration":"119.259515ms","start":"2026-06-13T06:14:22.4836Z","end":"2026-06-13T06:14:22.602859Z","steps":["trace[1621248758] 'agreement among raft nodes before linearized reading' (duration: 119.015029ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.603081Z","caller":"traceutil/trace.go:171","msg":"trace[644881458] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"141.854071ms","start":"2026-06-13T06:14:22.461206Z","end":"2026-06-13T06:14:22.60306Z","steps":["trace[644881458] 'process raft request' (duration: 107.803444ms)","trace[644881458] 'compare' (duration: 33.193067ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:22.854468Z","caller":"traceutil/trace.go:171","msg":"trace[76033804] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"148.676263ms","start":"2026-06-13T06:14:22.705772Z","end":"2026-06-13T06:14:22.854449Z","steps":["trace[76033804] 'process raft request' (duration: 148.636212ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.854499Z","caller":"traceutil/trace.go:171","msg":"trace[1040855903] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"150.503036ms","start":"2026-06-13T06:14:22.703965Z","end":"2026-06-13T06:14:22.854468Z","steps":["trace[1040855903] 'process raft request' (duration: 150.322902ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:22.854694Z","caller":"traceutil/trace.go:171","msg":"trace[1594908618] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"150.293251ms","start":"2026-06-13T06:14:22.704388Z","end":"2026-06-13T06:14:22.854682Z","steps":["trace[1594908618] 'process raft request' (duration: 149.972684ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.043409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.107009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:23.043644Z","caller":"traceutil/trace.go:171","msg":"trace[711326457] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"245.910677ms","start":"2026-06-13T06:14:22.797701Z","end":"2026-06-13T06:14:23.043611Z","steps":["trace[711326457] 'process raft request' (duration: 97.522781ms)","trace[711326457] 'compare' (duration: 147.942455ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:23.043679Z","caller":"traceutil/trace.go:171","msg":"trace[1061323714] linearizableReadLoop","detail":"{readStateIndex:395; appliedIndex:392; }","duration":"185.538786ms","start":"2026-06-13T06:14:22.858123Z","end":"2026-06-13T06:14:23.043661Z","steps":["trace[1061323714] 'read index received' (duration: 37.283263ms)","trace[1061323714] 'applied index is now lower than readState.Index' (duration: 148.252103ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:23.043787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.653048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-13T06:14:23.043773Z","caller":"traceutil/trace.go:171","msg":"trace[1411131936] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"245.895536ms","start":"2026-06-13T06:14:22.797837Z","end":"2026-06-13T06:14:23.043732Z","steps":["trace[1411131936] 'process raft request' (duration: 245.705452ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:23.043824Z","caller":"traceutil/trace.go:171","msg":"trace[933042417] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:380; }","duration":"185.74639ms","start":"2026-06-13T06:14:22.858068Z","end":"2026-06-13T06:14:23.043814Z","steps":["trace[933042417] 'agreement among raft nodes before linearized reading' (duration: 185.646128ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:23.043827Z","caller":"traceutil/trace.go:171","msg":"trace[1676485047] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"245.430325ms","start":"2026-06-13T06:14:22.79837Z","end":"2026-06-13T06:14:23.0438Z","steps":["trace[1676485047] 'process raft request' (duration: 245.242541ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:23.090567Z","caller":"traceutil/trace.go:171","msg":"trace[1306995719] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"229.831745ms","start":"2026-06-13T06:14:22.860712Z","end":"2026-06-13T06:14:23.090544Z","steps":["trace[1306995719] 'process raft request' (duration: 229.715303ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:23.090655Z","caller":"traceutil/trace.go:171","msg":"trace[839553433] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"231.479484ms","start":"2026-06-13T06:14:22.859142Z","end":"2026-06-13T06:14:23.090621Z","steps":["trace[839553433] 'process raft request' (duration: 231.211838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.385291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.340283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:23.385418Z","caller":"traceutil/trace.go:171","msg":"trace[677575392] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:398; }","duration":"255.893462ms","start":"2026-06-13T06:14:23.129507Z","end":"2026-06-13T06:14:23.3854Z","steps":["trace[677575392] 'read index received' (duration: 110.369485ms)","trace[677575392] 'applied index is now lower than readState.Index' (duration: 145.522747ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:23.385484Z","caller":"traceutil/trace.go:171","msg":"trace[1748028843] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"283.438696ms","start":"2026-06-13T06:14:23.102013Z","end":"2026-06-13T06:14:23.385451Z","steps":["trace[1748028843] 'process raft request' (duration: 137.863537ms)","trace[1748028843] 'compare' (duration: 145.19642ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:23.385627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.63839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-06-13T06:14:23.385714Z","caller":"traceutil/trace.go:171","msg":"trace[2133187965] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:384; }","duration":"283.745733ms","start":"2026-06-13T06:14:23.101952Z","end":"2026-06-13T06:14:23.385698Z","steps":["trace[2133187965] 'agreement among raft nodes before linearized reading' (duration: 283.517257ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:23.457188Z","caller":"traceutil/trace.go:171","msg":"trace[346432748] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"317.01179ms","start":"2026-06-13T06:14:23.140148Z","end":"2026-06-13T06:14:23.45716Z","steps":["trace[346432748] 'process raft request' (duration: 316.766595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.457276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.962729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2839"} {"level":"warn","ts":"2026-06-13T06:14:23.457276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.572446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:23.457394Z","caller":"traceutil/trace.go:171","msg":"trace[2051979076] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:385; }","duration":"325.132653ms","start":"2026-06-13T06:14:23.132235Z","end":"2026-06-13T06:14:23.457368Z","steps":["trace[2051979076] 'agreement among raft nodes before linearized reading' (duration: 324.877787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.457404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.228917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-06-13T06:14:23.457422Z","caller":"traceutil/trace.go:171","msg":"trace[581807361] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:385; }","duration":"212.771691ms","start":"2026-06-13T06:14:23.24463Z","end":"2026-06-13T06:14:23.457402Z","steps":["trace[581807361] 'agreement among raft nodes before linearized reading' (duration: 212.571346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.457459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:23.132217Z","time spent":"325.232495ms","remote":"127.0.0.1:36398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2862,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-06-13T06:14:23.457484Z","caller":"traceutil/trace.go:171","msg":"trace[1950363658] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:385; }","duration":"220.430382ms","start":"2026-06-13T06:14:23.237013Z","end":"2026-06-13T06:14:23.457443Z","steps":["trace[1950363658] 'agreement among raft nodes before linearized reading' (duration: 220.221817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:23.457612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:23.140129Z","time spent":"317.158454ms","remote":"127.0.0.1:36108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4443,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:40.893786Z","caller":"traceutil/trace.go:171","msg":"trace[1484869525] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"103.26355ms","start":"2026-06-13T06:14:40.790498Z","end":"2026-06-13T06:14:40.893761Z","steps":["trace[1484869525] 'process raft request' (duration: 87.47076ms)","trace[1484869525] 'compare' (duration: 15.679767ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:40.894035Z","caller":"traceutil/trace.go:171","msg":"trace[817272304] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"102.580133ms","start":"2026-06-13T06:14:40.791428Z","end":"2026-06-13T06:14:40.894008Z","steps":["trace[817272304] 'process raft request' (duration: 102.43944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:42.607099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.527891ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T06:14:42.607214Z","caller":"traceutil/trace.go:171","msg":"trace[1744547755] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:497; }","duration":"363.323553ms","start":"2026-06-13T06:14:42.243866Z","end":"2026-06-13T06:14:42.607189Z","steps":["trace[1744547755] 'read index received' (duration: 44.711µs)","trace[1744547755] 'applied index is now lower than readState.Index' (duration: 363.276832ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:42.607314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.440076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:42.607356Z","caller":"traceutil/trace.go:171","msg":"trace[193188511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"363.534118ms","start":"2026-06-13T06:14:42.243807Z","end":"2026-06-13T06:14:42.607342Z","steps":["trace[193188511] 'agreement among raft nodes before linearized reading' (duration: 363.448106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:42.607402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:42.24378Z","time spent":"363.61027ms","remote":"127.0.0.1:35940","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-06-13T06:14:43.348285Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173792038,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T06:14:43.353849Z","caller":"traceutil/trace.go:171","msg":"trace[435966771] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"506.177301ms","start":"2026-06-13T06:14:42.847646Z","end":"2026-06-13T06:14:43.353823Z","steps":["trace[435966771] 'read index received' (duration: 505.936036ms)","trace[435966771] 'applied index is now lower than readState.Index' (duration: 217.655µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:43.353968Z","caller":"traceutil/trace.go:171","msg":"trace[1441117262] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"556.902879ms","start":"2026-06-13T06:14:42.797053Z","end":"2026-06-13T06:14:43.353956Z","steps":["trace[1441117262] 'process raft request' (duration: 556.599742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:43.354113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.469898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-13T06:14:43.354097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.566984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:43.354158Z","caller":"traceutil/trace.go:171","msg":"trace[460193262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"506.54387ms","start":"2026-06-13T06:14:42.847601Z","end":"2026-06-13T06:14:43.354145Z","steps":["trace[460193262] 'agreement among raft nodes before linearized reading' (duration: 506.472308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:43.354159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.315669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-13T06:14:43.354188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:42.84758Z","time spent":"506.601161ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T06:14:43.354177Z","caller":"traceutil/trace.go:171","msg":"trace[325510297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:479; }","duration":"108.716438ms","start":"2026-06-13T06:14:43.245441Z","end":"2026-06-13T06:14:43.354157Z","steps":["trace[325510297] 'agreement among raft nodes before linearized reading' (duration: 108.572325ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:43.354236Z","caller":"traceutil/trace.go:171","msg":"trace[1653162961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:479; }","duration":"455.439172ms","start":"2026-06-13T06:14:42.898783Z","end":"2026-06-13T06:14:43.354222Z","steps":["trace[1653162961] 'agreement among raft nodes before linearized reading' (duration: 455.263837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:43.354268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:42.89877Z","time spent":"455.491883ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T06:14:43.35473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:42.797018Z","time spent":"556.984641ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:43.354098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.459976ms","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-06-13T06:14:43.355307Z","caller":"traceutil/trace.go:171","msg":"trace[1964273764] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:479; }","duration":"457.658434ms","start":"2026-06-13T06:14:42.897613Z","end":"2026-06-13T06:14:43.355271Z","steps":["trace[1964273764] 'agreement among raft nodes before linearized reading' (duration: 456.374434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:43.355356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:42.897529Z","time spent":"457.811648ms","remote":"127.0.0.1:36202","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-06-13T06:14:49.736347Z","caller":"traceutil/trace.go:171","msg":"trace[1182736382] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"452.485082ms","start":"2026-06-13T06:14:49.283796Z","end":"2026-06-13T06:14:49.736281Z","steps":["trace[1182736382] 'process raft request' (duration: 452.412ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:49.736455Z","caller":"traceutil/trace.go:171","msg":"trace[941075931] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"453.480986ms","start":"2026-06-13T06:14:49.282958Z","end":"2026-06-13T06:14:49.736439Z","steps":["trace[941075931] 'process raft request' (duration: 453.196199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.736575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.283786Z","time spent":"452.666247ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:49.736325Z","caller":"traceutil/trace.go:171","msg":"trace[206699887] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"457.445498ms","start":"2026-06-13T06:14:49.278809Z","end":"2026-06-13T06:14:49.736255Z","steps":["trace[206699887] 'process raft request' (duration: 428.984141ms)","trace[206699887] 'compare' (duration: 28.036487ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:49.736635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.282856Z","time spent":"453.66772ms","remote":"127.0.0.1:36444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:49.736831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.278802Z","time spent":"457.893819ms","remote":"127.0.0.1:36444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:49.73739Z","caller":"traceutil/trace.go:171","msg":"trace[306670143] transaction","detail":"{read_only:false; number_of_response:0; response_revision:541; }","duration":"455.499663ms","start":"2026-06-13T06:14:49.281858Z","end":"2026-06-13T06:14:49.737357Z","steps":["trace[306670143] 'process raft request' (duration: 454.253534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.737548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.27807Z","time spent":"459.405745ms","remote":"127.0.0.1:36444","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:49.790539Z","caller":"traceutil/trace.go:171","msg":"trace[49724965] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"502.103465ms","start":"2026-06-13T06:14:49.288418Z","end":"2026-06-13T06:14:49.790521Z","steps":["trace[49724965] 'process raft request' (duration: 501.87845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.790663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.288409Z","time spent":"502.183737ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:49.790931Z","caller":"traceutil/trace.go:171","msg":"trace[1421025298] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"497.003085ms","start":"2026-06-13T06:14:49.293911Z","end":"2026-06-13T06:14:49.790915Z","steps":["trace[1421025298] 'process raft request' (duration: 496.547065ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:49.791064Z","caller":"traceutil/trace.go:171","msg":"trace[1784144280] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"486.456538ms","start":"2026-06-13T06:14:49.304592Z","end":"2026-06-13T06:14:49.791048Z","steps":["trace[1784144280] 'process raft request' (duration: 486.317085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.791128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.304571Z","time spent":"486.530061ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:49.791227Z","caller":"traceutil/trace.go:171","msg":"trace[185790011] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"484.033461ms","start":"2026-06-13T06:14:49.307183Z","end":"2026-06-13T06:14:49.791217Z","steps":["trace[185790011] 'process raft request' (duration: 483.856197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.791281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.307176Z","time spent":"484.077533ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:49.791247Z","caller":"traceutil/trace.go:171","msg":"trace[1722116092] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"484.322059ms","start":"2026-06-13T06:14:49.306879Z","end":"2026-06-13T06:14:49.791201Z","steps":["trace[1722116092] 'process raft request' (duration: 484.106094ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:49.791412Z","caller":"traceutil/trace.go:171","msg":"trace[1197604242] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"355.807267ms","start":"2026-06-13T06:14:49.435594Z","end":"2026-06-13T06:14:49.791401Z","steps":["trace[1197604242] 'process raft request' (duration: 355.662103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.79146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.435554Z","time spent":"355.885859ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:49.791515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.430531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T06:14:49.790998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.293903Z","time spent":"497.062966ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:49.791345Z","caller":"traceutil/trace.go:171","msg":"trace[1571769377] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:564; }","duration":"350.244897ms","start":"2026-06-13T06:14:49.441075Z","end":"2026-06-13T06:14:49.79132Z","steps":["trace[1571769377] 'read index received' (duration: 266.813152ms)","trace[1571769377] 'applied index is now lower than readState.Index' (duration: 83.430625ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:49.791567Z","caller":"traceutil/trace.go:171","msg":"trace[799110202] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"350.488832ms","start":"2026-06-13T06:14:49.441068Z","end":"2026-06-13T06:14:49.791556Z","steps":["trace[799110202] 'agreement among raft nodes before linearized reading' (duration: 350.317618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.791615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.441024Z","time spent":"350.583265ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T06:14:49.791696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.366765ms","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-06-13T06:14:49.791738Z","caller":"traceutil/trace.go:171","msg":"trace[527599854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:551; }","duration":"340.425617ms","start":"2026-06-13T06:14:49.4513Z","end":"2026-06-13T06:14:49.791726Z","steps":["trace[527599854] 'agreement among raft nodes before linearized reading' (duration: 340.350136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.791766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.451285Z","time spent":"340.475128ms","remote":"127.0.0.1:36202","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-06-13T06:14:49.791366Z","caller":"traceutil/trace.go:171","msg":"trace[2018210854] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"470.061365ms","start":"2026-06-13T06:14:49.321296Z","end":"2026-06-13T06:14:49.791357Z","steps":["trace[2018210854] 'process raft request' (duration: 469.829489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.791965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.250401ms","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-06-13T06:14:49.792003Z","caller":"traceutil/trace.go:171","msg":"trace[548105701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:551; }","duration":"284.311452ms","start":"2026-06-13T06:14:49.507682Z","end":"2026-06-13T06:14:49.791993Z","steps":["trace[548105701] 'agreement among raft nodes before linearized reading' (duration: 284.24674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.792141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.080933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:14:49.792264Z","caller":"traceutil/trace.go:171","msg":"trace[1955285263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:551; }","duration":"283.267067ms","start":"2026-06-13T06:14:49.508973Z","end":"2026-06-13T06:14:49.79224Z","steps":["trace[1955285263] 'agreement among raft nodes before linearized reading' (duration: 282.811677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.792654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.306865Z","time spent":"484.648326ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:49.792666Z","caller":"traceutil/trace.go:171","msg":"trace[1924760537] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"497.617069ms","start":"2026-06-13T06:14:49.293985Z","end":"2026-06-13T06:14:49.791602Z","steps":["trace[1924760537] 'process raft request' (duration: 496.81015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:49.793009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.293964Z","time spent":"498.865859ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:49.793069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.321281Z","time spent":"470.535945ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:50.176091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.758488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:50.176393Z","caller":"traceutil/trace.go:171","msg":"trace[2102612034] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"354.67018ms","start":"2026-06-13T06:14:49.821652Z","end":"2026-06-13T06:14:50.176322Z","steps":["trace[2102612034] 'process raft request' (duration: 111.593684ms)","trace[2102612034] 'compare' (duration: 242.606855ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:50.176625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.821629Z","time spent":"354.848904ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:50.193905Z","caller":"traceutil/trace.go:171","msg":"trace[2004812364] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"340.514289ms","start":"2026-06-13T06:14:49.853374Z","end":"2026-06-13T06:14:50.193889Z","steps":["trace[2004812364] 'process raft request' (duration: 340.273473ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:50.193883Z","caller":"traceutil/trace.go:171","msg":"trace[395664958] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"365.239938ms","start":"2026-06-13T06:14:49.828595Z","end":"2026-06-13T06:14:50.193835Z","steps":["trace[395664958] 'process raft request' (duration: 364.89244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.193973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.853345Z","time spent":"340.593691ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:50.194056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.828574Z","time spent":"365.387531ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:50.194174Z","caller":"traceutil/trace.go:171","msg":"trace[2024494073] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"332.00825ms","start":"2026-06-13T06:14:49.862108Z","end":"2026-06-13T06:14:50.194116Z","steps":["trace[2024494073] 'process raft request' (duration: 331.686882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.195097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.8621Z","time spent":"332.203024ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:50.195229Z","caller":"traceutil/trace.go:171","msg":"trace[1051205059] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"329.275935ms","start":"2026-06-13T06:14:49.865934Z","end":"2026-06-13T06:14:50.19521Z","steps":["trace[1051205059] 'process raft request' (duration: 327.982795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.195319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.865925Z","time spent":"329.329686ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:50.199135Z","caller":"traceutil/trace.go:171","msg":"trace[1775921925] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"331.59992ms","start":"2026-06-13T06:14:49.867362Z","end":"2026-06-13T06:14:50.198962Z","steps":["trace[1775921925] 'process raft request' (duration: 327.993846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.199304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.867332Z","time spent":"331.896386ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:50.202176Z","caller":"traceutil/trace.go:171","msg":"trace[12501770] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"301.398673ms","start":"2026-06-13T06:14:49.900735Z","end":"2026-06-13T06:14:50.202134Z","steps":["trace[12501770] 'process raft request' (duration: 300.966813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.202314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:49.900683Z","time spent":"301.576287ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:50.512432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.049111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:50.51256Z","caller":"traceutil/trace.go:171","msg":"trace[1094320188] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"297.088192ms","start":"2026-06-13T06:14:50.215451Z","end":"2026-06-13T06:14:50.512539Z","steps":["trace[1094320188] 'process raft request' (duration: 92.831646ms)","trace[1094320188] 'compare' (duration: 203.876607ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:50.809643Z","caller":"traceutil/trace.go:171","msg":"trace[1045235189] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"590.278931ms","start":"2026-06-13T06:14:50.219335Z","end":"2026-06-13T06:14:50.809614Z","steps":["trace[1045235189] 'process raft request' (duration: 495.303335ms)","trace[1045235189] 'compare' (duration: 94.531445ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:50.809833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.219326Z","time spent":"590.392994ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:50.809876Z","caller":"traceutil/trace.go:171","msg":"trace[265595824] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:587; }","duration":"565.322576ms","start":"2026-06-13T06:14:50.244522Z","end":"2026-06-13T06:14:50.809845Z","steps":["trace[265595824] 'read index received' (duration: 63.681612ms)","trace[265595824] 'applied index is now lower than readState.Index' (duration: 501.639754ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:50.810031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.47975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:50.810058Z","caller":"traceutil/trace.go:171","msg":"trace[333325967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"565.564602ms","start":"2026-06-13T06:14:50.244485Z","end":"2026-06-13T06:14:50.81005Z","steps":["trace[333325967] 'agreement among raft nodes before linearized reading' (duration: 565.463199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.81009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.244475Z","time spent":"565.605463ms","remote":"127.0.0.1:35940","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-06-13T06:14:50.810157Z","caller":"traceutil/trace.go:171","msg":"trace[1349223220] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"586.313208ms","start":"2026-06-13T06:14:50.22383Z","end":"2026-06-13T06:14:50.810144Z","steps":["trace[1349223220] 'process raft request' (duration: 585.511219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.810214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.223822Z","time spent":"586.366919ms","remote":"127.0.0.1:36444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:50.810337Z","caller":"traceutil/trace.go:171","msg":"trace[326861612] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"525.062313ms","start":"2026-06-13T06:14:50.285266Z","end":"2026-06-13T06:14:50.810328Z","steps":["trace[326861612] 'process raft request' (duration: 524.436099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:50.810423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.28524Z","time spent":"525.123934ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:14:51.271517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.466357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:51.271716Z","caller":"traceutil/trace.go:171","msg":"trace[1644695969] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"402.971791ms","start":"2026-06-13T06:14:50.868726Z","end":"2026-06-13T06:14:51.271698Z","steps":["trace[1644695969] 'process raft request' (duration: 402.904949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:51.271776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.868666Z","time spent":"403.085124ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:14:51.271838Z","caller":"traceutil/trace.go:171","msg":"trace[2080725803] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"448.714443ms","start":"2026-06-13T06:14:50.823086Z","end":"2026-06-13T06:14:51.271801Z","steps":["trace[2080725803] 'process raft request' (duration: 130.875467ms)","trace[2080725803] 'compare' (duration: 317.313134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:51.272014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.823063Z","time spent":"448.851216ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:51.587223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.172982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:14:51.587303Z","caller":"traceutil/trace.go:171","msg":"trace[959602853] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"341.341058ms","start":"2026-06-13T06:14:51.24595Z","end":"2026-06-13T06:14:51.587291Z","steps":["trace[959602853] 'read index received' (duration: 183.94257ms)","trace[959602853] 'applied index is now lower than readState.Index' (duration: 157.397838ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:51.587351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.4142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:51.587363Z","caller":"traceutil/trace.go:171","msg":"trace[1483757557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"341.467081ms","start":"2026-06-13T06:14:51.245891Z","end":"2026-06-13T06:14:51.587358Z","steps":["trace[1483757557] 'agreement among raft nodes before linearized reading' (duration: 341.4272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:51.587382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:51.245868Z","time spent":"341.509952ms","remote":"127.0.0.1:35940","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-06-13T06:14:51.58756Z","caller":"traceutil/trace.go:171","msg":"trace[1541002471] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"686.396302ms","start":"2026-06-13T06:14:50.901155Z","end":"2026-06-13T06:14:51.587551Z","steps":["trace[1541002471] 'process raft request' (duration: 528.83611ms)","trace[1541002471] 'compare' (duration: 157.05055ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:51.587595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:50.901121Z","time spent":"686.459403ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:51.594282Z","caller":"traceutil/trace.go:171","msg":"trace[460694615] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"311.453748ms","start":"2026-06-13T06:14:51.282796Z","end":"2026-06-13T06:14:51.594249Z","steps":["trace[460694615] 'process raft request' (duration: 311.210422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:51.594461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:51.282773Z","time spent":"311.585751ms","remote":"127.0.0.1:35980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:51.594634Z","caller":"traceutil/trace.go:171","msg":"trace[793193346] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"258.381374ms","start":"2026-06-13T06:14:51.336228Z","end":"2026-06-13T06:14:51.594609Z","steps":["trace[793193346] 'process raft request' (duration: 257.925993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:52.598752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.513015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-06-13T06:14:52.598808Z","caller":"traceutil/trace.go:171","msg":"trace[1443523035] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"100.608517ms","start":"2026-06-13T06:14:52.498187Z","end":"2026-06-13T06:14:52.598796Z","steps":["trace[1443523035] 'range keys from in-memory index tree' (duration: 100.31534ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:52.884012Z","caller":"traceutil/trace.go:171","msg":"trace[1449545354] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"149.893872ms","start":"2026-06-13T06:14:52.734069Z","end":"2026-06-13T06:14:52.883963Z","steps":["trace[1449545354] 'read index received' (duration: 148.897369ms)","trace[1449545354] 'applied index is now lower than readState.Index' (duration: 994.573µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:14:52.884108Z","caller":"traceutil/trace.go:171","msg":"trace[1178938710] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"160.951961ms","start":"2026-06-13T06:14:52.723097Z","end":"2026-06-13T06:14:52.884049Z","steps":["trace[1178938710] 'process raft request' (duration: 160.108061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:52.884367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.261211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-06-13T06:14:52.884436Z","caller":"traceutil/trace.go:171","msg":"trace[1925915842] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:607; }","duration":"150.383514ms","start":"2026-06-13T06:14:52.734038Z","end":"2026-06-13T06:14:52.884421Z","steps":["trace[1925915842] 'agreement among raft nodes before linearized reading' (duration: 150.093917ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:53.238221Z","caller":"traceutil/trace.go:171","msg":"trace[1431043105] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"167.344712ms","start":"2026-06-13T06:14:53.07086Z","end":"2026-06-13T06:14:53.238205Z","steps":["trace[1431043105] 'read index received' (duration: 167.015774ms)","trace[1431043105] 'applied index is now lower than readState.Index' (duration: 328.338µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:53.238371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.491575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:15688"} {"level":"info","ts":"2026-06-13T06:14:53.238394Z","caller":"traceutil/trace.go:171","msg":"trace[1512739267] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutefilters.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:610; }","duration":"167.551166ms","start":"2026-06-13T06:14:53.070835Z","end":"2026-06-13T06:14:53.238386Z","steps":["trace[1512739267] 'agreement among raft nodes before linearized reading' (duration: 167.436733ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:53.238379Z","caller":"traceutil/trace.go:171","msg":"trace[57987036] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"183.905059ms","start":"2026-06-13T06:14:53.054412Z","end":"2026-06-13T06:14:53.238317Z","steps":["trace[57987036] 'process raft request' (duration: 183.52898ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:56.725132Z","caller":"traceutil/trace.go:171","msg":"trace[2064127338] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"279.112871ms","start":"2026-06-13T06:14:56.445966Z","end":"2026-06-13T06:14:56.725079Z","steps":["trace[2064127338] 'process raft request' (duration: 278.893355ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:57.236563Z","caller":"traceutil/trace.go:171","msg":"trace[1155099022] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"409.428023ms","start":"2026-06-13T06:14:56.827106Z","end":"2026-06-13T06:14:57.236534Z","steps":["trace[1155099022] 'process raft request' (duration: 408.783088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:57.23676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:56.827077Z","time spent":"409.584697ms","remote":"127.0.0.1:36038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:14:57.40792Z","caller":"traceutil/trace.go:171","msg":"trace[1765071348] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"107.99359ms","start":"2026-06-13T06:14:57.299891Z","end":"2026-06-13T06:14:57.407884Z","steps":["trace[1765071348] 'process raft request' (duration: 106.012044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:58.359048Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173792366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:14:58.860062Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173792366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:14:59.360262Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173792366,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:14:59.614325Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.79891373s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T06:14:59.640929Z","caller":"traceutil/trace.go:171","msg":"trace[964238684] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"1.782092656s","start":"2026-06-13T06:14:57.858811Z","end":"2026-06-13T06:14:59.640903Z","steps":["trace[964238684] 'read index received' (duration: 1.755768419s)","trace[964238684] 'applied index is now lower than readState.Index' (duration: 26.323207ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:59.641655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342593329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:59.641739Z","caller":"traceutil/trace.go:171","msg":"trace[1242587122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"1.342758682s","start":"2026-06-13T06:14:58.298957Z","end":"2026-06-13T06:14:59.641716Z","steps":["trace[1242587122] 'agreement among raft nodes before linearized reading' (duration: 1.342596928s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.641792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:58.298925Z","time spent":"1.342858675s","remote":"127.0.0.1:35940","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-06-13T06:14:59.641992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.751687293s","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-06-13T06:14:59.642073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.453366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:14:59.642156Z","caller":"traceutil/trace.go:171","msg":"trace[1308506851] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"395.550519ms","start":"2026-06-13T06:14:59.246568Z","end":"2026-06-13T06:14:59.642119Z","steps":["trace[1308506851] 'agreement among raft nodes before linearized reading' (duration: 395.426746ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:14:59.642058Z","caller":"traceutil/trace.go:171","msg":"trace[919180391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.751762455s","start":"2026-06-13T06:14:57.890263Z","end":"2026-06-13T06:14:59.642025Z","steps":["trace[919180391] 'agreement among raft nodes before linearized reading' (duration: 1.751595621s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.642251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:57.890254Z","time spent":"1.75198893s","remote":"127.0.0.1:36202","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-06-13T06:14:59.642368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:59.246546Z","time spent":"395.63687ms","remote":"127.0.0.1:35938","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-06-13T06:14:59.642833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.752599415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:14:59.642873Z","caller":"traceutil/trace.go:171","msg":"trace[214647882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"1.752663466s","start":"2026-06-13T06:14:57.890196Z","end":"2026-06-13T06:14:59.642859Z","steps":["trace[214647882] 'agreement among raft nodes before linearized reading' (duration: 1.752326748s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.642937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:57.890186Z","time spent":"1.752733837s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T06:14:59.642965Z","caller":"traceutil/trace.go:171","msg":"trace[1081057756] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"632.955152ms","start":"2026-06-13T06:14:59.009941Z","end":"2026-06-13T06:14:59.642896Z","steps":["trace[1081057756] 'process raft request' (duration: 630.907634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.643138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:59.009898Z","time spent":"633.144636ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:59.643387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784582694s","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-06-13T06:14:59.643436Z","caller":"traceutil/trace.go:171","msg":"trace[1057136307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:637; }","duration":"1.784677176s","start":"2026-06-13T06:14:57.858736Z","end":"2026-06-13T06:14:59.643413Z","steps":["trace[1057136307] 'agreement among raft nodes before linearized reading' (duration: 1.782403583s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.64348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:57.858705Z","time spent":"1.784765978s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-13T06:14:59.643652Z","caller":"traceutil/trace.go:171","msg":"trace[256811564] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.830793487s","start":"2026-06-13T06:14:57.812831Z","end":"2026-06-13T06:14:59.643625Z","steps":["trace[256811564] 'process raft request' (duration: 1.802561875s)","trace[256811564] 'compare' (duration: 24.527485ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:14:59.643752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:57.812793Z","time spent":"1.830883989s","remote":"127.0.0.1:36038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:14:59.64639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.761278438s","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-06-13T06:14:59.646445Z","caller":"traceutil/trace.go:171","msg":"trace[524141179] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"1.762934947s","start":"2026-06-13T06:14:57.883493Z","end":"2026-06-13T06:14:59.646427Z","steps":["trace[524141179] 'agreement among raft nodes before linearized reading' (duration: 1.761027843s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:14:59.646498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:14:57.883482Z","time spent":"1.763000989s","remote":"127.0.0.1:36202","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-06-13T06:15:00.231115Z","caller":"traceutil/trace.go:171","msg":"trace[1098587029] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"122.496631ms","start":"2026-06-13T06:15:00.108592Z","end":"2026-06-13T06:15:00.231089Z","steps":["trace[1098587029] 'process raft request' (duration: 121.707472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:01.894337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.628619ms","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-06-13T06:15:01.894552Z","caller":"traceutil/trace.go:171","msg":"trace[1858084567] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"220.599037ms","start":"2026-06-13T06:15:01.673925Z","end":"2026-06-13T06:15:01.894524Z","steps":["trace[1858084567] 'read index received' (duration: 220.547336ms)","trace[1858084567] 'applied index is now lower than readState.Index' (duration: 50.321µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:15:01.894434Z","caller":"traceutil/trace.go:171","msg":"trace[1682008369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:679; }","duration":"226.769202ms","start":"2026-06-13T06:15:01.667646Z","end":"2026-06-13T06:15:01.894415Z","steps":["trace[1682008369] 'range keys from in-memory index tree' (duration: 226.443065ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:01.894624Z","caller":"traceutil/trace.go:171","msg":"trace[122385814] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"221.419217ms","start":"2026-06-13T06:15:01.673177Z","end":"2026-06-13T06:15:01.894596Z","steps":["trace[122385814] 'process raft request' (duration: 221.231282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:01.894756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.826293ms","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-06-13T06:15:01.894801Z","caller":"traceutil/trace.go:171","msg":"trace[470132468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:680; }","duration":"220.911574ms","start":"2026-06-13T06:15:01.673877Z","end":"2026-06-13T06:15:01.894789Z","steps":["trace[470132468] 'agreement among raft nodes before linearized reading' (duration: 220.75221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:01.89827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.970516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:15:01.89834Z","caller":"traceutil/trace.go:171","msg":"trace[81597319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:681; }","duration":"224.093959ms","start":"2026-06-13T06:15:01.674229Z","end":"2026-06-13T06:15:01.898323Z","steps":["trace[81597319] 'agreement among raft nodes before linearized reading' (duration: 223.902675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:01.898663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.950082ms","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-06-13T06:15:01.899125Z","caller":"traceutil/trace.go:171","msg":"trace[1810388114] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:681; }","duration":"223.585187ms","start":"2026-06-13T06:15:01.675513Z","end":"2026-06-13T06:15:01.899098Z","steps":["trace[1810388114] 'agreement among raft nodes before linearized reading' (duration: 222.779078ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:04.010215Z","caller":"traceutil/trace.go:171","msg":"trace[2105832651] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"100.087856ms","start":"2026-06-13T06:15:03.910102Z","end":"2026-06-13T06:15:04.010189Z","steps":["trace[2105832651] 'process raft request' (duration: 99.911451ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:04.407211Z","caller":"traceutil/trace.go:171","msg":"trace[1793452040] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"131.245995ms","start":"2026-06-13T06:15:04.275943Z","end":"2026-06-13T06:15:04.407189Z","steps":["trace[1793452040] 'process raft request' (duration: 131.077081ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:04.544267Z","caller":"traceutil/trace.go:171","msg":"trace[62593840] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"124.237632ms","start":"2026-06-13T06:15:04.419997Z","end":"2026-06-13T06:15:04.544235Z","steps":["trace[62593840] 'process raft request' (duration: 124.014696ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:04.70541Z","caller":"traceutil/trace.go:171","msg":"trace[1516871793] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"117.3609ms","start":"2026-06-13T06:15:04.588022Z","end":"2026-06-13T06:15:04.705383Z","steps":["trace[1516871793] 'process raft request' (duration: 117.210627ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:05.029849Z","caller":"traceutil/trace.go:171","msg":"trace[1292123471] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"115.119048ms","start":"2026-06-13T06:15:04.914655Z","end":"2026-06-13T06:15:05.029774Z","steps":["trace[1292123471] 'process raft request' (duration: 114.950864ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:05.076575Z","caller":"traceutil/trace.go:171","msg":"trace[339430336] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"105.945863ms","start":"2026-06-13T06:15:04.970607Z","end":"2026-06-13T06:15:05.076553Z","steps":["trace[339430336] 'process raft request' (duration: 87.45728ms)","trace[339430336] 'compare' (duration: 18.37772ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:15:05.364598Z","caller":"traceutil/trace.go:171","msg":"trace[528102846] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"269.208158ms","start":"2026-06-13T06:15:05.095368Z","end":"2026-06-13T06:15:05.364576Z","steps":["trace[528102846] 'process raft request' (duration: 268.158643ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:05.364861Z","caller":"traceutil/trace.go:171","msg":"trace[1293783258] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:749; }","duration":"119.403768ms","start":"2026-06-13T06:15:05.245406Z","end":"2026-06-13T06:15:05.36481Z","steps":["trace[1293783258] 'read index received' (duration: 118.20181ms)","trace[1293783258] 'applied index is now lower than readState.Index' (duration: 1.200448ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:15:05.364907Z","caller":"traceutil/trace.go:171","msg":"trace[307084818] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"268.752048ms","start":"2026-06-13T06:15:05.096121Z","end":"2026-06-13T06:15:05.364873Z","steps":["trace[307084818] 'process raft request' (duration: 268.365488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:05.365153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.740986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:15:05.365211Z","caller":"traceutil/trace.go:171","msg":"trace[224501848] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:722; }","duration":"119.844908ms","start":"2026-06-13T06:15:05.245346Z","end":"2026-06-13T06:15:05.365191Z","steps":["trace[224501848] 'agreement among raft nodes before linearized reading' (duration: 119.672864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:17.548203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.031216ms","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-06-13T06:15:17.548368Z","caller":"traceutil/trace.go:171","msg":"trace[164175757] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:807; }","duration":"118.269671ms","start":"2026-06-13T06:15:17.430072Z","end":"2026-06-13T06:15:17.548341Z","steps":["trace[164175757] 'range keys from in-memory index tree' (duration: 117.784391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:17.548596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.011541711s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w64ln\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-06-13T06:15:17.548691Z","caller":"traceutil/trace.go:171","msg":"trace[2110445355] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w64ln; range_end:; response_count:1; response_revision:807; }","duration":"1.011709826s","start":"2026-06-13T06:15:16.536956Z","end":"2026-06-13T06:15:17.548666Z","steps":["trace[2110445355] 'range keys from in-memory index tree' (duration: 1.011302866s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:17.548736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:16.536921Z","time spent":"1.011806097s","remote":"127.0.0.1:36108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-w64ln\" "} {"level":"warn","ts":"2026-06-13T06:15:17.549234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.600667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-13T06:15:17.549366Z","caller":"traceutil/trace.go:171","msg":"trace[982479620] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:807; }","duration":"849.778061ms","start":"2026-06-13T06:15:16.699569Z","end":"2026-06-13T06:15:17.549347Z","steps":["trace[982479620] 'range keys from in-memory index tree' (duration: 849.056174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:17.549406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:16.699546Z","time spent":"849.850473ms","remote":"127.0.0.1:35958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"info","ts":"2026-06-13T06:15:17.69149Z","caller":"traceutil/trace.go:171","msg":"trace[1376567384] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"137.733367ms","start":"2026-06-13T06:15:17.553714Z","end":"2026-06-13T06:15:17.691447Z","steps":["trace[1376567384] 'process raft request' (duration: 136.415647ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:17.696373Z","caller":"traceutil/trace.go:171","msg":"trace[1909263207] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"134.733167ms","start":"2026-06-13T06:15:17.55686Z","end":"2026-06-13T06:15:17.691593Z","steps":["trace[1909263207] 'process raft request' (duration: 133.951308ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:19.676409Z","caller":"traceutil/trace.go:171","msg":"trace[1038428014] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"107.619512ms","start":"2026-06-13T06:15:19.568762Z","end":"2026-06-13T06:15:19.676381Z","steps":["trace[1038428014] 'process raft request' (duration: 107.471418ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:32.024828Z","caller":"traceutil/trace.go:171","msg":"trace[1848259992] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"212.409817ms","start":"2026-06-13T06:15:31.812397Z","end":"2026-06-13T06:15:32.024806Z","steps":["trace[1848259992] 'process raft request' (duration: 212.269834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:32.457112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.34145ms","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-06-13T06:15:32.457188Z","caller":"traceutil/trace.go:171","msg":"trace[1360658891] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:935; }","duration":"193.460193ms","start":"2026-06-13T06:15:32.263711Z","end":"2026-06-13T06:15:32.457172Z","steps":["trace[1360658891] 'range keys from in-memory index tree' (duration: 193.172976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:32.457513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.230034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T06:15:32.45711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.091525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T06:15:32.457576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.3762ms","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-06-13T06:15:32.457689Z","caller":"traceutil/trace.go:171","msg":"trace[168704459] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:935; }","duration":"251.543313ms","start":"2026-06-13T06:15:32.206127Z","end":"2026-06-13T06:15:32.45767Z","steps":["trace[168704459] 'range keys from in-memory index tree' (duration: 250.911349ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:32.457694Z","caller":"traceutil/trace.go:171","msg":"trace[1541870395] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:935; }","duration":"129.699319ms","start":"2026-06-13T06:15:32.327954Z","end":"2026-06-13T06:15:32.457654Z","steps":["trace[1541870395] 'range keys from in-memory index tree' (duration: 128.959662ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:32.45762Z","caller":"traceutil/trace.go:171","msg":"trace[326811846] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:935; }","duration":"122.379718ms","start":"2026-06-13T06:15:32.335212Z","end":"2026-06-13T06:15:32.457592Z","steps":["trace[326811846] 'count revisions from in-memory index tree' (duration: 122.169832ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:52.688741Z","caller":"traceutil/trace.go:171","msg":"trace[872739177] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"125.139142ms","start":"2026-06-13T06:15:52.563577Z","end":"2026-06-13T06:15:52.688716Z","steps":["trace[872739177] 'read index received' (duration: 125.05757ms)","trace[872739177] 'applied index is now lower than readState.Index' (duration: 80.752µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:15:52.688791Z","caller":"traceutil/trace.go:171","msg":"trace[1289579681] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"126.258629ms","start":"2026-06-13T06:15:52.562514Z","end":"2026-06-13T06:15:52.688773Z","steps":["trace[1289579681] 'process raft request' (duration: 126.042024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:52.688952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.356008ms","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-06-13T06:15:52.689019Z","caller":"traceutil/trace.go:171","msg":"trace[1281405037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1021; }","duration":"125.45919ms","start":"2026-06-13T06:15:52.563549Z","end":"2026-06-13T06:15:52.689008Z","steps":["trace[1281405037] 'agreement among raft nodes before linearized reading' (duration: 125.293686ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:52.704339Z","caller":"traceutil/trace.go:171","msg":"trace[309664934] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"138.937589ms","start":"2026-06-13T06:15:52.56539Z","end":"2026-06-13T06:15:52.704327Z","steps":["trace[309664934] 'process raft request' (duration: 138.753534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:52.704469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.775053ms","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-06-13T06:15:52.704562Z","caller":"traceutil/trace.go:171","msg":"trace[625024138] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"140.909626ms","start":"2026-06-13T06:15:52.563626Z","end":"2026-06-13T06:15:52.704536Z","steps":["trace[625024138] 'agreement among raft nodes before linearized reading' (duration: 140.707831ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:52.897512Z","caller":"traceutil/trace.go:171","msg":"trace[1188853098] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"204.542122ms","start":"2026-06-13T06:15:52.692932Z","end":"2026-06-13T06:15:52.897474Z","steps":["trace[1188853098] 'process raft request' (duration: 137.237809ms)","trace[1188853098] 'compare' (duration: 67.146389ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:15:52.897515Z","caller":"traceutil/trace.go:171","msg":"trace[651903696] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"188.941792ms","start":"2026-06-13T06:15:52.708545Z","end":"2026-06-13T06:15:52.897487Z","steps":["trace[651903696] 'process raft request' (duration: 188.877951ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:15:54.160639Z","caller":"traceutil/trace.go:171","msg":"trace[937491487] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"900.275653ms","start":"2026-06-13T06:15:53.260341Z","end":"2026-06-13T06:15:54.160617Z","steps":["trace[937491487] 'process raft request' (duration: 900.113239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:54.16078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:53.260316Z","time spent":"900.382966ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:15:54.746052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173793196,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-13T06:15:55.561532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.276836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:15:55.561776Z","caller":"traceutil/trace.go:171","msg":"trace[1776130148] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"2.189286528s","start":"2026-06-13T06:15:53.372451Z","end":"2026-06-13T06:15:55.561738Z","steps":["trace[1776130148] 'process raft request' (duration: 1.641734406s)","trace[1776130148] 'compare' (duration: 546.964988ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:15:55.561915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.316521637s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T06:15:55.561968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:53.372423Z","time spent":"2.189501614s","remote":"127.0.0.1:36202","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-06-13T06:15:55.562012Z","caller":"traceutil/trace.go:171","msg":"trace[294708052] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1026; }","duration":"1.316661959s","start":"2026-06-13T06:15:54.245328Z","end":"2026-06-13T06:15:55.56199Z","steps":["trace[294708052] 'agreement among raft nodes before linearized reading' (duration: 1.316506566s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.562057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.24531Z","time spent":"1.316738752s","remote":"127.0.0.1:35940","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-06-13T06:15:55.562313Z","caller":"traceutil/trace.go:171","msg":"trace[583258424] linearizableReadLoop","detail":"{readStateIndex:1069; appliedIndex:1068; }","duration":"1.316316731s","start":"2026-06-13T06:15:54.245368Z","end":"2026-06-13T06:15:55.561684Z","steps":["trace[583258424] 'read index received' (duration: 768.684707ms)","trace[583258424] 'applied index is now lower than readState.Index' (duration: 547.630734ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:15:55.562491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315848921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-13T06:15:55.562526Z","caller":"traceutil/trace.go:171","msg":"trace[2107273633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"1.315904442s","start":"2026-06-13T06:15:54.246612Z","end":"2026-06-13T06:15:55.562517Z","steps":["trace[2107273633] 'agreement among raft nodes before linearized reading' (duration: 1.315781689s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.562558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.246603Z","time spent":"1.315948213s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T06:15:55.562831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.455548ms","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-06-13T06:15:55.56287Z","caller":"traceutil/trace.go:171","msg":"trace[1787883310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"661.516ms","start":"2026-06-13T06:15:54.901345Z","end":"2026-06-13T06:15:55.562861Z","steps":["trace[1787883310] 'agreement among raft nodes before linearized reading' (duration: 661.424138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.562898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.901334Z","time spent":"661.557701ms","remote":"127.0.0.1:36202","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-06-13T06:15:55.562994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.965499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:15:55.563036Z","caller":"traceutil/trace.go:171","msg":"trace[783677587] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"855.050131ms","start":"2026-06-13T06:15:54.707974Z","end":"2026-06-13T06:15:55.563024Z","steps":["trace[783677587] 'agreement among raft nodes before linearized reading' (duration: 854.936468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.563062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.934234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T06:15:55.56307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.707951Z","time spent":"855.111603ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T06:15:55.563091Z","caller":"traceutil/trace.go:171","msg":"trace[929974721] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1026; }","duration":"869.997745ms","start":"2026-06-13T06:15:54.693085Z","end":"2026-06-13T06:15:55.563082Z","steps":["trace[929974721] 'agreement among raft nodes before linearized reading' (duration: 869.920283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.563118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.693062Z","time spent":"870.050127ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T06:15:55.563303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.599805ms","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-06-13T06:15:55.563333Z","caller":"traceutil/trace.go:171","msg":"trace[389530244] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"662.679487ms","start":"2026-06-13T06:15:54.900645Z","end":"2026-06-13T06:15:55.563324Z","steps":["trace[389530244] 'agreement among raft nodes before linearized reading' (duration: 662.578814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:15:55.563364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:15:54.90062Z","time spent":"662.737579ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T06:16:03.103487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.703466ms","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-06-13T06:16:03.103656Z","caller":"traceutil/trace.go:171","msg":"trace[1129334777] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1051; }","duration":"528.91208ms","start":"2026-06-13T06:16:02.574717Z","end":"2026-06-13T06:16:03.103629Z","steps":["trace[1129334777] 'range keys from in-memory index tree' (duration: 528.683285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:03.104356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.842272ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T06:16:03.104512Z","caller":"traceutil/trace.go:171","msg":"trace[1990559183] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"450.038523ms","start":"2026-06-13T06:16:02.654428Z","end":"2026-06-13T06:16:03.104466Z","steps":["trace[1990559183] 'read index received' (duration: 23.411µs)","trace[1990559183] 'applied index is now lower than readState.Index' (duration: 450.013762ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:03.104624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.181056ms","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-06-13T06:16:03.104668Z","caller":"traceutil/trace.go:171","msg":"trace[616167456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1051; }","duration":"450.264339ms","start":"2026-06-13T06:16:02.654392Z","end":"2026-06-13T06:16:03.104656Z","steps":["trace[616167456] 'agreement among raft nodes before linearized reading' (duration: 450.171757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:03.10471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:02.654377Z","time spent":"450.32363ms","remote":"127.0.0.1:50848","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-06-13T06:16:03.105132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.667282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:16:03.105214Z","caller":"traceutil/trace.go:171","msg":"trace[1216137730] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1051; }","duration":"293.752784ms","start":"2026-06-13T06:16:02.811447Z","end":"2026-06-13T06:16:03.1052Z","steps":["trace[1216137730] 'agreement among raft nodes before linearized reading' (duration: 293.646301ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:16.971267Z","caller":"traceutil/trace.go:171","msg":"trace[4134712] linearizableReadLoop","detail":"{readStateIndex:1145; appliedIndex:1144; }","duration":"210.060153ms","start":"2026-06-13T06:16:16.761182Z","end":"2026-06-13T06:16:16.971242Z","steps":["trace[4134712] 'read index received' (duration: 209.975351ms)","trace[4134712] 'applied index is now lower than readState.Index' (duration: 83.572µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:16.97147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.269138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:16:16.971508Z","caller":"traceutil/trace.go:171","msg":"trace[561875981] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1097; }","duration":"210.3515ms","start":"2026-06-13T06:16:16.761146Z","end":"2026-06-13T06:16:16.971497Z","steps":["trace[561875981] 'agreement among raft nodes before linearized reading' (duration: 210.242798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.022158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.560173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:16:18.022407Z","caller":"traceutil/trace.go:171","msg":"trace[123189188] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"392.84322ms","start":"2026-06-13T06:16:17.629544Z","end":"2026-06-13T06:16:18.022387Z","steps":["trace[123189188] 'process raft request' (duration: 392.728007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.022483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:17.629527Z","time spent":"392.918411ms","remote":"127.0.0.1:36202","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-06-13T06:16:18.022678Z","caller":"traceutil/trace.go:171","msg":"trace[1490151676] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"1.049994176s","start":"2026-06-13T06:16:16.972672Z","end":"2026-06-13T06:16:18.022667Z","steps":["trace[1490151676] 'process raft request' (duration: 498.759986ms)","trace[1490151676] 'compare' (duration: 550.088922ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:18.022729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:16.972644Z","time spent":"1.050057037s","remote":"127.0.0.1:35958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:16:18.02313Z","caller":"traceutil/trace.go:171","msg":"trace[2084909585] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"776.731038ms","start":"2026-06-13T06:16:17.246371Z","end":"2026-06-13T06:16:18.023102Z","steps":["trace[2084909585] 'read index received' (duration: 224.974546ms)","trace[2084909585] 'applied index is now lower than readState.Index' (duration: 551.754572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:18.023359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.966043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T06:16:18.023383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.316323ms","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-06-13T06:16:18.023452Z","caller":"traceutil/trace.go:171","msg":"trace[1857623880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1099; }","duration":"418.440466ms","start":"2026-06-13T06:16:17.604994Z","end":"2026-06-13T06:16:18.023435Z","steps":["trace[1857623880] 'agreement among raft nodes before linearized reading' (duration: 418.321873ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:18.023438Z","caller":"traceutil/trace.go:171","msg":"trace[1860822622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1099; }","duration":"777.078426ms","start":"2026-06-13T06:16:17.246326Z","end":"2026-06-13T06:16:18.023405Z","steps":["trace[1860822622] 'agreement among raft nodes before linearized reading' (duration: 776.952943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.023494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:17.604975Z","time spent":"418.510298ms","remote":"127.0.0.1:50862","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":"warn","ts":"2026-06-13T06:16:18.023492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.310976ms","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-06-13T06:16:18.02354Z","caller":"traceutil/trace.go:171","msg":"trace[1402085336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"253.405739ms","start":"2026-06-13T06:16:17.770121Z","end":"2026-06-13T06:16:18.023527Z","steps":["trace[1402085336] 'agreement among raft nodes before linearized reading' (duration: 253.240255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.023541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:17.246305Z","time spent":"777.221529ms","remote":"127.0.0.1:35940","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-06-13T06:16:18.023555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.325765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:16:18.023604Z","caller":"traceutil/trace.go:171","msg":"trace[2041019594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"247.377767ms","start":"2026-06-13T06:16:17.776213Z","end":"2026-06-13T06:16:18.023591Z","steps":["trace[2041019594] 'agreement among raft nodes before linearized reading' (duration: 247.221043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.023729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.521543ms","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-06-13T06:16:18.023701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.028711ms","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-06-13T06:16:18.023763Z","caller":"traceutil/trace.go:171","msg":"trace[994860626] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1099; }","duration":"365.604865ms","start":"2026-06-13T06:16:17.658149Z","end":"2026-06-13T06:16:18.023754Z","steps":["trace[994860626] 'agreement among raft nodes before linearized reading' (duration: 365.510173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.023792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:17.658128Z","time spent":"365.657646ms","remote":"127.0.0.1:36202","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":"info","ts":"2026-06-13T06:16:18.023788Z","caller":"traceutil/trace.go:171","msg":"trace[1079970975] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1099; }","duration":"354.165944ms","start":"2026-06-13T06:16:17.6696Z","end":"2026-06-13T06:16:18.023766Z","steps":["trace[1079970975] 'agreement among raft nodes before linearized reading' (duration: 353.861316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.023729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.879852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-13T06:16:18.023834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:17.669585Z","time spent":"354.240296ms","remote":"127.0.0.1:36202","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-06-13T06:16:18.023863Z","caller":"traceutil/trace.go:171","msg":"trace[1656488375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1099; }","duration":"249.052176ms","start":"2026-06-13T06:16:17.774801Z","end":"2026-06-13T06:16:18.023854Z","steps":["trace[1656488375] 'agreement among raft nodes before linearized reading' (duration: 248.864711ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:18.220808Z","caller":"traceutil/trace.go:171","msg":"trace[1855612416] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1148; }","duration":"191.996755ms","start":"2026-06-13T06:16:18.02879Z","end":"2026-06-13T06:16:18.220787Z","steps":["trace[1855612416] 'read index received' (duration: 12.878784ms)","trace[1855612416] 'applied index is now lower than readState.Index' (duration: 179.117191ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:18.220821Z","caller":"traceutil/trace.go:171","msg":"trace[48709539] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"192.347503ms","start":"2026-06-13T06:16:18.028438Z","end":"2026-06-13T06:16:18.220785Z","steps":["trace[48709539] 'process raft request' (duration: 180.633196ms)","trace[48709539] 'compare' (duration: 11.476341ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:18.220859Z","caller":"traceutil/trace.go:171","msg":"trace[320916848] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"191.946834ms","start":"2026-06-13T06:16:18.028876Z","end":"2026-06-13T06:16:18.220823Z","steps":["trace[320916848] 'process raft request' (duration: 191.842181ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:18.221124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.117218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-13T06:16:18.221154Z","caller":"traceutil/trace.go:171","msg":"trace[135048471] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1104; }","duration":"192.382714ms","start":"2026-06-13T06:16:18.028762Z","end":"2026-06-13T06:16:18.221145Z","steps":["trace[135048471] 'agreement among raft nodes before linearized reading' (duration: 192.108668ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:18.221331Z","caller":"traceutil/trace.go:171","msg":"trace[1134866602] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"192.807665ms","start":"2026-06-13T06:16:18.028511Z","end":"2026-06-13T06:16:18.221319Z","steps":["trace[1134866602] 'process raft request' (duration: 192.149729ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:18.221338Z","caller":"traceutil/trace.go:171","msg":"trace[1264745526] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"192.390555ms","start":"2026-06-13T06:16:18.028935Z","end":"2026-06-13T06:16:18.221325Z","steps":["trace[1264745526] 'process raft request' (duration: 191.814541ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:20.364393Z","caller":"traceutil/trace.go:171","msg":"trace[658978089] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"319.217648ms","start":"2026-06-13T06:16:20.045149Z","end":"2026-06-13T06:16:20.364367Z","steps":["trace[658978089] 'read index received' (duration: 319.000672ms)","trace[658978089] 'applied index is now lower than readState.Index' (duration: 215.886µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:20.364453Z","caller":"traceutil/trace.go:171","msg":"trace[1371254031] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"335.191686ms","start":"2026-06-13T06:16:20.029224Z","end":"2026-06-13T06:16:20.364415Z","steps":["trace[1371254031] 'process raft request' (duration: 334.996251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.364701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.880494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:16:20.36476Z","caller":"traceutil/trace.go:171","msg":"trace[759479660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"137.965997ms","start":"2026-06-13T06:16:20.22678Z","end":"2026-06-13T06:16:20.364746Z","steps":["trace[759479660] 'agreement among raft nodes before linearized reading' (duration: 137.801833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.364739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.436688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:20.364826Z","caller":"traceutil/trace.go:171","msg":"trace[1959101333] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1105; }","duration":"119.54879ms","start":"2026-06-13T06:16:20.24526Z","end":"2026-06-13T06:16:20.364809Z","steps":["trace[1959101333] 'agreement among raft nodes before linearized reading' (duration: 119.378916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.364702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.525143ms","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-06-13T06:16:20.36492Z","caller":"traceutil/trace.go:171","msg":"trace[1697248285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1105; }","duration":"139.753858ms","start":"2026-06-13T06:16:20.225153Z","end":"2026-06-13T06:16:20.364907Z","steps":["trace[1697248285] 'agreement among raft nodes before linearized reading' (duration: 139.4027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.364762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.512485ms","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-06-13T06:16:20.364962Z","caller":"traceutil/trace.go:171","msg":"trace[100230859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1105; }","duration":"137.773981ms","start":"2026-06-13T06:16:20.227174Z","end":"2026-06-13T06:16:20.364948Z","steps":["trace[100230859] 'agreement among raft nodes before linearized reading' (duration: 137.397232ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.365195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.482512ms","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-06-13T06:16:20.365211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.059427ms","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-06-13T06:16:20.365237Z","caller":"traceutil/trace.go:171","msg":"trace[600459987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"139.576834ms","start":"2026-06-13T06:16:20.22565Z","end":"2026-06-13T06:16:20.365227Z","steps":["trace[600459987] 'agreement among raft nodes before linearized reading' (duration: 139.457761ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:20.365264Z","caller":"traceutil/trace.go:171","msg":"trace[1128103164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1105; }","duration":"320.15483ms","start":"2026-06-13T06:16:20.045096Z","end":"2026-06-13T06:16:20.365251Z","steps":["trace[1128103164] 'agreement among raft nodes before linearized reading' (duration: 319.408842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.365298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.045073Z","time spent":"320.216521ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T06:16:20.365783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.029201Z","time spent":"335.329548ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:16:20.68234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.126364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:16:20.682483Z","caller":"traceutil/trace.go:171","msg":"trace[1094059565] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"313.392688ms","start":"2026-06-13T06:16:20.369066Z","end":"2026-06-13T06:16:20.682459Z","steps":["trace[1094059565] 'process raft request' (duration: 160.051129ms)","trace[1094059565] 'compare' (duration: 153.008121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:20.682561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.369045Z","time spent":"313.483031ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:16:20.745917Z","caller":"traceutil/trace.go:171","msg":"trace[1714858281] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"374.999957ms","start":"2026-06-13T06:16:20.370893Z","end":"2026-06-13T06:16:20.745893Z","steps":["trace[1714858281] 'process raft request' (duration: 374.894184ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:20.74597Z","caller":"traceutil/trace.go:171","msg":"trace[1777115790] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"376.259606ms","start":"2026-06-13T06:16:20.369667Z","end":"2026-06-13T06:16:20.745927Z","steps":["trace[1777115790] 'process raft request' (duration: 376.028161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.746143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.369646Z","time spent":"376.40217ms","remote":"127.0.0.1:36202","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-06-13T06:16:20.746144Z","caller":"traceutil/trace.go:171","msg":"trace[550792550] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"375.185951ms","start":"2026-06-13T06:16:20.370942Z","end":"2026-06-13T06:16:20.746128Z","steps":["trace[550792550] 'process raft request' (duration: 374.908015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.746228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.370935Z","time spent":"375.247822ms","remote":"127.0.0.1:36202","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-06-13T06:16:20.746292Z","caller":"traceutil/trace.go:171","msg":"trace[1560666748] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"374.925905ms","start":"2026-06-13T06:16:20.371347Z","end":"2026-06-13T06:16:20.746273Z","steps":["trace[1560666748] 'process raft request' (duration: 374.698829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:20.746444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.371341Z","time spent":"375.018757ms","remote":"127.0.0.1:36202","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-06-13T06:16:20.746769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:20.370884Z","time spent":"375.098629ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:16:21.271993Z","caller":"traceutil/trace.go:171","msg":"trace[1425161115] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"259.318939ms","start":"2026-06-13T06:16:21.01265Z","end":"2026-06-13T06:16:21.271969Z","steps":["trace[1425161115] 'process raft request' (duration: 259.154165ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:22.898103Z","caller":"traceutil/trace.go:171","msg":"trace[207013108] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"168.97959ms","start":"2026-06-13T06:16:22.729095Z","end":"2026-06-13T06:16:22.898075Z","steps":["trace[207013108] 'read index received' (duration: 168.779166ms)","trace[207013108] 'applied index is now lower than readState.Index' (duration: 199.084µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:22.898208Z","caller":"traceutil/trace.go:171","msg":"trace[559944821] transaction","detail":"{read_only:false; response_revision:1113; number_of_response:1; }","duration":"206.711854ms","start":"2026-06-13T06:16:22.691465Z","end":"2026-06-13T06:16:22.898177Z","steps":["trace[559944821] 'process raft request' (duration: 206.427787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:22.898291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.158235ms","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-06-13T06:16:22.898334Z","caller":"traceutil/trace.go:171","msg":"trace[554053345] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1113; }","duration":"169.258787ms","start":"2026-06-13T06:16:22.729065Z","end":"2026-06-13T06:16:22.898324Z","steps":["trace[554053345] 'agreement among raft nodes before linearized reading' (duration: 169.154775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:22.898542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.713057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-13T06:16:22.89854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.777649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-13T06:16:22.898687Z","caller":"traceutil/trace.go:171","msg":"trace[719903101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1113; }","duration":"147.962343ms","start":"2026-06-13T06:16:22.75071Z","end":"2026-06-13T06:16:22.898672Z","steps":["trace[719903101] 'agreement among raft nodes before linearized reading' (duration: 147.694706ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:22.898635Z","caller":"traceutil/trace.go:171","msg":"trace[1942833026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1113; }","duration":"147.813879ms","start":"2026-06-13T06:16:22.750798Z","end":"2026-06-13T06:16:22.898612Z","steps":["trace[1942833026] 'agreement among raft nodes before linearized reading' (duration: 147.558643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:22.898541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.684486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-13T06:16:22.898962Z","caller":"traceutil/trace.go:171","msg":"trace[727047580] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1113; }","duration":"148.127897ms","start":"2026-06-13T06:16:22.750811Z","end":"2026-06-13T06:16:22.898939Z","steps":["trace[727047580] 'agreement among raft nodes before linearized reading' (duration: 147.578424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:22.899348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.68471ms","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-06-13T06:16:22.899396Z","caller":"traceutil/trace.go:171","msg":"trace[2062200495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1113; }","duration":"148.776183ms","start":"2026-06-13T06:16:22.750609Z","end":"2026-06-13T06:16:22.899385Z","steps":["trace[2062200495] 'agreement among raft nodes before linearized reading' (duration: 147.750068ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:23.176785Z","caller":"traceutil/trace.go:171","msg":"trace[1857841168] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"272.983372ms","start":"2026-06-13T06:16:22.903779Z","end":"2026-06-13T06:16:23.176762Z","steps":["trace[1857841168] 'process raft request' (duration: 215.516292ms)","trace[1857841168] 'compare' (duration: 57.345707ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:23.19951Z","caller":"traceutil/trace.go:171","msg":"trace[928146973] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"295.614478ms","start":"2026-06-13T06:16:22.903875Z","end":"2026-06-13T06:16:23.199489Z","steps":["trace[928146973] 'process raft request' (duration: 295.378933ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:23.199584Z","caller":"traceutil/trace.go:171","msg":"trace[1631128063] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"295.517416ms","start":"2026-06-13T06:16:22.904041Z","end":"2026-06-13T06:16:23.199558Z","steps":["trace[1631128063] 'process raft request' (duration: 295.454344ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:23.199583Z","caller":"traceutil/trace.go:171","msg":"trace[1462474709] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"295.65826ms","start":"2026-06-13T06:16:22.903898Z","end":"2026-06-13T06:16:23.199556Z","steps":["trace[1462474709] 'process raft request' (duration: 295.476695ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:24.546353Z","caller":"traceutil/trace.go:171","msg":"trace[347251042] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"160.569271ms","start":"2026-06-13T06:16:24.385747Z","end":"2026-06-13T06:16:24.546317Z","steps":["trace[347251042] 'process raft request' (duration: 160.335686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:25.05057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.944402ms","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-06-13T06:16:25.050692Z","caller":"traceutil/trace.go:171","msg":"trace[1387263765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1119; }","duration":"148.120356ms","start":"2026-06-13T06:16:24.902547Z","end":"2026-06-13T06:16:25.050667Z","steps":["trace[1387263765] 'range keys from in-memory index tree' (duration: 147.723137ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:25.369078Z","caller":"traceutil/trace.go:171","msg":"trace[1877998319] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"161.626126ms","start":"2026-06-13T06:16:25.207422Z","end":"2026-06-13T06:16:25.369048Z","steps":["trace[1877998319] 'process raft request' (duration: 161.557255ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:25.369533Z","caller":"traceutil/trace.go:171","msg":"trace[1191658019] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"162.420295ms","start":"2026-06-13T06:16:25.207077Z","end":"2026-06-13T06:16:25.369497Z","steps":["trace[1191658019] 'process raft request' (duration: 82.093473ms)","trace[1191658019] 'compare' (duration: 79.673947ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:29.445772Z","caller":"traceutil/trace.go:171","msg":"trace[743302939] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"161.947394ms","start":"2026-06-13T06:16:29.283793Z","end":"2026-06-13T06:16:29.445741Z","steps":["trace[743302939] 'process raft request' (duration: 161.76528ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:29.460025Z","caller":"traceutil/trace.go:171","msg":"trace[2098095934] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"174.830839ms","start":"2026-06-13T06:16:29.285169Z","end":"2026-06-13T06:16:29.46Z","steps":["trace[2098095934] 'process raft request' (duration: 174.45201ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:39.666482Z","caller":"traceutil/trace.go:171","msg":"trace[1069337645] linearizableReadLoop","detail":"{readStateIndex:1272; appliedIndex:1271; }","duration":"182.429569ms","start":"2026-06-13T06:16:39.484028Z","end":"2026-06-13T06:16:39.666457Z","steps":["trace[1069337645] 'read index received' (duration: 182.293106ms)","trace[1069337645] 'applied index is now lower than readState.Index' (duration: 135.313µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:39.666595Z","caller":"traceutil/trace.go:171","msg":"trace[1693986170] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"431.379863ms","start":"2026-06-13T06:16:39.235182Z","end":"2026-06-13T06:16:39.666562Z","steps":["trace[1693986170] 'process raft request' (duration: 431.131597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:39.666722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.624404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-13T06:16:39.666735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:39.235166Z","time spent":"431.495015ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:16:39.666753Z","caller":"traceutil/trace.go:171","msg":"trace[469674182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1218; }","duration":"163.699736ms","start":"2026-06-13T06:16:39.503045Z","end":"2026-06-13T06:16:39.666745Z","steps":["trace[469674182] 'agreement among raft nodes before linearized reading' (duration: 163.571523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:39.666756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.698275ms","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-06-13T06:16:39.666842Z","caller":"traceutil/trace.go:171","msg":"trace[277243825] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1218; }","duration":"182.833859ms","start":"2026-06-13T06:16:39.483986Z","end":"2026-06-13T06:16:39.66682Z","steps":["trace[277243825] 'agreement among raft nodes before linearized reading' (duration: 182.577453ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:41.388744Z","caller":"traceutil/trace.go:171","msg":"trace[1860403362] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1276; }","duration":"279.890757ms","start":"2026-06-13T06:16:41.108836Z","end":"2026-06-13T06:16:41.388727Z","steps":["trace[1860403362] 'read index received' (duration: 279.777155ms)","trace[1860403362] 'applied index is now lower than readState.Index' (duration: 113.022µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:41.388825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.97824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:16:41.388845Z","caller":"traceutil/trace.go:171","msg":"trace[1084465737] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1223; }","duration":"280.016201ms","start":"2026-06-13T06:16:41.108822Z","end":"2026-06-13T06:16:41.388838Z","steps":["trace[1084465737] 'agreement among raft nodes before linearized reading' (duration: 279.96523ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:41.38883Z","caller":"traceutil/trace.go:171","msg":"trace[783284143] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"772.333829ms","start":"2026-06-13T06:16:40.616454Z","end":"2026-06-13T06:16:41.388788Z","steps":["trace[783284143] 'process raft request' (duration: 772.173475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:41.388996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:40.616439Z","time spent":"772.470802ms","remote":"127.0.0.1:36202","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-06-13T06:16:42.171305Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312005173793666,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T06:16:42.478349Z","caller":"traceutil/trace.go:171","msg":"trace[453273736] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"920.066106ms","start":"2026-06-13T06:16:41.558257Z","end":"2026-06-13T06:16:42.478323Z","steps":["trace[453273736] 'process raft request' (duration: 919.884102ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.478551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.558233Z","time spent":"920.190769ms","remote":"127.0.0.1:36202","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-06-13T06:16:42.48276Z","caller":"traceutil/trace.go:171","msg":"trace[1358794975] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1277; }","duration":"811.488195ms","start":"2026-06-13T06:16:41.671255Z","end":"2026-06-13T06:16:42.482743Z","steps":["trace[1358794975] 'read index received' (duration: 806.977919ms)","trace[1358794975] 'applied index is now lower than readState.Index' (duration: 4.509026ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:42.482996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.724701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-13T06:16:42.48307Z","caller":"traceutil/trace.go:171","msg":"trace[1631215220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"811.805853ms","start":"2026-06-13T06:16:41.671244Z","end":"2026-06-13T06:16:42.48305Z","steps":["trace[1631215220] 'agreement among raft nodes before linearized reading' (duration: 811.593698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.483072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.499096ms","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-06-13T06:16:42.483108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.671203Z","time spent":"811.897675ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-13T06:16:42.483151Z","caller":"traceutil/trace.go:171","msg":"trace[1326535039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1224; }","duration":"806.591239ms","start":"2026-06-13T06:16:41.676541Z","end":"2026-06-13T06:16:42.483132Z","steps":["trace[1326535039] 'agreement among raft nodes before linearized reading' (duration: 806.368173ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.483199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.676497Z","time spent":"806.693961ms","remote":"127.0.0.1:36202","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-06-13T06:16:42.48333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.153529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:42.483357Z","caller":"traceutil/trace.go:171","msg":"trace[500358371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1224; }","duration":"238.217561ms","start":"2026-06-13T06:16:42.245132Z","end":"2026-06-13T06:16:42.483349Z","steps":["trace[500358371] 'agreement among raft nodes before linearized reading' (duration: 238.17943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.483476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.271288ms","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-06-13T06:16:42.483513Z","caller":"traceutil/trace.go:171","msg":"trace[2105893515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"805.323028ms","start":"2026-06-13T06:16:41.678181Z","end":"2026-06-13T06:16:42.483504Z","steps":["trace[2105893515] 'agreement among raft nodes before linearized reading' (duration: 805.224096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.483545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.678175Z","time spent":"805.364879ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T06:16:42.483582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.781819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:16:42.483612Z","caller":"traceutil/trace.go:171","msg":"trace[386302440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1224; }","duration":"805.830961ms","start":"2026-06-13T06:16:41.677774Z","end":"2026-06-13T06:16:42.483605Z","steps":["trace[386302440] 'agreement among raft nodes before linearized reading' (duration: 805.755729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.483634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.677764Z","time spent":"805.866521ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T06:16:42.485018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"806.793014ms","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-06-13T06:16:42.485069Z","caller":"traceutil/trace.go:171","msg":"trace[493569494] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1224; }","duration":"806.866645ms","start":"2026-06-13T06:16:41.678189Z","end":"2026-06-13T06:16:42.485056Z","steps":["trace[493569494] 'agreement among raft nodes before linearized reading' (duration: 806.696261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:42.485095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:41.678183Z","time spent":"806.907486ms","remote":"127.0.0.1:36202","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":"info","ts":"2026-06-13T06:16:54.732816Z","caller":"traceutil/trace.go:171","msg":"trace[1255476880] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"105.712073ms","start":"2026-06-13T06:16:54.627061Z","end":"2026-06-13T06:16:54.732773Z","steps":["trace[1255476880] 'process raft request' (duration: 105.597071ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:54.732872Z","caller":"traceutil/trace.go:171","msg":"trace[2085173414] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"105.757594ms","start":"2026-06-13T06:16:54.627046Z","end":"2026-06-13T06:16:54.732803Z","steps":["trace[2085173414] 'process raft request' (duration: 75.072568ms)","trace[2085173414] 'compare' (duration: 30.331308ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:56.09148Z","caller":"traceutil/trace.go:171","msg":"trace[1172716190] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"188.427252ms","start":"2026-06-13T06:16:55.903025Z","end":"2026-06-13T06:16:56.091452Z","steps":["trace[1172716190] 'read index received' (duration: 134.038824ms)","trace[1172716190] 'applied index is now lower than readState.Index' (duration: 54.387418ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:56.091517Z","caller":"traceutil/trace.go:171","msg":"trace[1608152063] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"194.189238ms","start":"2026-06-13T06:16:55.897287Z","end":"2026-06-13T06:16:56.091476Z","steps":["trace[1608152063] 'process raft request' (duration: 139.839191ms)","trace[1608152063] 'compare' (duration: 54.200854ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:16:56.091656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.607586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:56.09169Z","caller":"traceutil/trace.go:171","msg":"trace[1883049425] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1282; }","duration":"188.704158ms","start":"2026-06-13T06:16:55.902976Z","end":"2026-06-13T06:16:56.091681Z","steps":["trace[1883049425] 'agreement among raft nodes before linearized reading' (duration: 188.574095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:56.982665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.605931ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-13T06:16:56.983665Z","caller":"traceutil/trace.go:171","msg":"trace[1076328293] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1344; }","duration":"247.333097ms","start":"2026-06-13T06:16:56.736311Z","end":"2026-06-13T06:16:56.983645Z","steps":["trace[1076328293] 'read index received' (duration: 53.747123ms)","trace[1076328293] 'applied index is now lower than readState.Index' (duration: 193.584994ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:56.983836Z","caller":"traceutil/trace.go:171","msg":"trace[769610979] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"274.702855ms","start":"2026-06-13T06:16:56.709117Z","end":"2026-06-13T06:16:56.98382Z","steps":["trace[769610979] 'process raft request' (duration: 273.64364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:56.984508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.181877ms","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-06-13T06:16:56.984616Z","caller":"traceutil/trace.go:171","msg":"trace[1302130347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1288; }","duration":"248.31413ms","start":"2026-06-13T06:16:56.736252Z","end":"2026-06-13T06:16:56.984566Z","steps":["trace[1302130347] 'agreement among raft nodes before linearized reading' (duration: 248.044284ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:56.98655Z","caller":"traceutil/trace.go:171","msg":"trace[1254268437] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"160.967901ms","start":"2026-06-13T06:16:56.825572Z","end":"2026-06-13T06:16:56.98654Z","steps":["trace[1254268437] 'process raft request' (duration: 160.91038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:56.986934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.571136ms","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-06-13T06:16:56.987039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.244021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:56.98705Z","caller":"traceutil/trace.go:171","msg":"trace[40697381] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1289; }","duration":"248.7375ms","start":"2026-06-13T06:16:56.738288Z","end":"2026-06-13T06:16:56.987025Z","steps":["trace[40697381] 'agreement among raft nodes before linearized reading' (duration: 248.261019ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:56.987074Z","caller":"traceutil/trace.go:171","msg":"trace[1565382894] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1289; }","duration":"113.285892ms","start":"2026-06-13T06:16:56.873779Z","end":"2026-06-13T06:16:56.987065Z","steps":["trace[1565382894] 'agreement among raft nodes before linearized reading' (duration: 113.228391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:57.311234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.606052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:16:57.311368Z","caller":"traceutil/trace.go:171","msg":"trace[1068565077] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"242.729237ms","start":"2026-06-13T06:16:57.068615Z","end":"2026-06-13T06:16:57.311344Z","steps":["trace[1068565077] 'process raft request' (duration: 95.855849ms)","trace[1068565077] 'compare' (duration: 146.49531ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:57.358036Z","caller":"traceutil/trace.go:171","msg":"trace[1543411648] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"288.635954ms","start":"2026-06-13T06:16:57.069378Z","end":"2026-06-13T06:16:57.358014Z","steps":["trace[1543411648] 'process raft request' (duration: 288.495491ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:57.358411Z","caller":"traceutil/trace.go:171","msg":"trace[162884240] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1352; }","duration":"110.280361ms","start":"2026-06-13T06:16:57.248071Z","end":"2026-06-13T06:16:57.358351Z","steps":["trace[162884240] 'read index received' (duration: 109.734128ms)","trace[162884240] 'applied index is now lower than readState.Index' (duration: 543.233µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:57.358595Z","caller":"traceutil/trace.go:171","msg":"trace[1399536677] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"284.253101ms","start":"2026-06-13T06:16:57.074292Z","end":"2026-06-13T06:16:57.358545Z","steps":["trace[1399536677] 'process raft request' (duration: 283.671857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:57.358806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.616839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:57.358861Z","caller":"traceutil/trace.go:171","msg":"trace[1055846694] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"110.836354ms","start":"2026-06-13T06:16:57.24801Z","end":"2026-06-13T06:16:57.358847Z","steps":["trace[1055846694] 'agreement among raft nodes before linearized reading' (duration: 110.561418ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:57.537685Z","caller":"traceutil/trace.go:171","msg":"trace[2097509735] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"100.823797ms","start":"2026-06-13T06:16:57.436841Z","end":"2026-06-13T06:16:57.537664Z","steps":["trace[2097509735] 'process raft request' (duration: 100.634753ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:59.041066Z","caller":"traceutil/trace.go:171","msg":"trace[1454128311] linearizableReadLoop","detail":"{readStateIndex:1356; appliedIndex:1355; }","duration":"330.729091ms","start":"2026-06-13T06:16:58.710318Z","end":"2026-06-13T06:16:59.041047Z","steps":["trace[1454128311] 'read index received' (duration: 330.66545ms)","trace[1454128311] 'applied index is now lower than readState.Index' (duration: 62.361µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:59.041175Z","caller":"traceutil/trace.go:171","msg":"trace[1502799335] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"425.2773ms","start":"2026-06-13T06:16:58.615833Z","end":"2026-06-13T06:16:59.041111Z","steps":["trace[1502799335] 'process raft request' (duration: 425.106016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:59.041258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.921847ms","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-06-13T06:16:59.04128Z","caller":"traceutil/trace.go:171","msg":"trace[164655161] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1298; }","duration":"330.991858ms","start":"2026-06-13T06:16:58.710281Z","end":"2026-06-13T06:16:59.041273Z","steps":["trace[164655161] 'agreement among raft nodes before linearized reading' (duration: 330.865305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:59.041483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:58.710264Z","time spent":"331.214634ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T06:16:59.041479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.19761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:16:59.041562Z","caller":"traceutil/trace.go:171","msg":"trace[1556617653] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1298; }","duration":"276.503097ms","start":"2026-06-13T06:16:58.765039Z","end":"2026-06-13T06:16:59.041542Z","steps":["trace[1556617653] 'agreement among raft nodes before linearized reading' (duration: 276.165299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:59.041641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:58.615814Z","time spent":"425.66564ms","remote":"127.0.0.1:36202","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-06-13T06:16:59.279744Z","caller":"traceutil/trace.go:171","msg":"trace[1964846532] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1356; }","duration":"211.479898ms","start":"2026-06-13T06:16:59.068234Z","end":"2026-06-13T06:16:59.279714Z","steps":["trace[1964846532] 'read index received' (duration: 190.108912ms)","trace[1964846532] 'applied index is now lower than readState.Index' (duration: 21.369906ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:59.279931Z","caller":"traceutil/trace.go:171","msg":"trace[96897593] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"234.506053ms","start":"2026-06-13T06:16:59.045414Z","end":"2026-06-13T06:16:59.27992Z","steps":["trace[96897593] 'process raft request' (duration: 212.979643ms)","trace[96897593] 'compare' (duration: 21.10719ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:16:59.280027Z","caller":"traceutil/trace.go:171","msg":"trace[603579449] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"234.545264ms","start":"2026-06-13T06:16:59.045449Z","end":"2026-06-13T06:16:59.279994Z","steps":["trace[603579449] 'process raft request' (duration: 234.230406ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:16:59.280141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.887787ms","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-06-13T06:16:59.280042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.795045ms","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-06-13T06:16:59.280179Z","caller":"traceutil/trace.go:171","msg":"trace[919992227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"211.946479ms","start":"2026-06-13T06:16:59.06822Z","end":"2026-06-13T06:16:59.280167Z","steps":["trace[919992227] 'agreement among raft nodes before linearized reading' (duration: 211.885967ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:16:59.280219Z","caller":"traceutil/trace.go:171","msg":"trace[1757034043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1300; }","duration":"212.033161ms","start":"2026-06-13T06:16:59.068175Z","end":"2026-06-13T06:16:59.280208Z","steps":["trace[1757034043] 'agreement among raft nodes before linearized reading' (duration: 211.739224ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:00.044922Z","caller":"traceutil/trace.go:171","msg":"trace[759933568] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"757.802143ms","start":"2026-06-13T06:16:59.287092Z","end":"2026-06-13T06:17:00.044895Z","steps":["trace[759933568] 'process raft request' (duration: 757.568058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:00.045178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:59.287083Z","time spent":"757.986109ms","remote":"127.0.0.1:36202","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-06-13T06:17:00.489783Z","caller":"traceutil/trace.go:171","msg":"trace[268453126] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"865.788991ms","start":"2026-06-13T06:16:59.623941Z","end":"2026-06-13T06:17:00.48973Z","steps":["trace[268453126] 'read index received' (duration: 420.700531ms)","trace[268453126] 'applied index is now lower than readState.Index' (duration: 445.0865ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:00.48993Z","caller":"traceutil/trace.go:171","msg":"trace[1791909488] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"945.943889ms","start":"2026-06-13T06:16:59.543953Z","end":"2026-06-13T06:17:00.489897Z","steps":["trace[1791909488] 'process raft request' (duration: 886.171253ms)","trace[1791909488] 'compare' (duration: 59.213873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:00.489963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.008136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:17:00.49012Z","caller":"traceutil/trace.go:171","msg":"trace[333210942] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1303; }","duration":"866.218121ms","start":"2026-06-13T06:16:59.62389Z","end":"2026-06-13T06:17:00.490108Z","steps":["trace[333210942] 'agreement among raft nodes before linearized reading' (duration: 866.017096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:00.490107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:59.543907Z","time spent":"946.103913ms","remote":"127.0.0.1:36202","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-06-13T06:17:00.490111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.791414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T06:17:00.490149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:16:59.623866Z","time spent":"866.275442ms","remote":"127.0.0.1:36370","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-13T06:17:00.490165Z","caller":"traceutil/trace.go:171","msg":"trace[1547259157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1303; }","duration":"243.938857ms","start":"2026-06-13T06:17:00.246211Z","end":"2026-06-13T06:17:00.49015Z","steps":["trace[1547259157] 'agreement among raft nodes before linearized reading' (duration: 243.782923ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:01.813163Z","caller":"traceutil/trace.go:171","msg":"trace[1449510667] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"524.305854ms","start":"2026-06-13T06:17:01.288814Z","end":"2026-06-13T06:17:01.813119Z","steps":["trace[1449510667] 'process raft request' (duration: 524.030078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:01.813471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:01.288794Z","time spent":"524.52503ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:17:02.599265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.058077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:17:02.599459Z","caller":"traceutil/trace.go:171","msg":"trace[1101121553] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1362; }","duration":"1.240881503s","start":"2026-06-13T06:17:01.358549Z","end":"2026-06-13T06:17:02.599431Z","steps":["trace[1101121553] 'read index received' (duration: 454.211015ms)","trace[1101121553] 'applied index is now lower than readState.Index' (duration: 786.667998ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:02.599557Z","caller":"traceutil/trace.go:171","msg":"trace[908280918] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"1.309882107s","start":"2026-06-13T06:17:01.289658Z","end":"2026-06-13T06:17:02.599541Z","steps":["trace[908280918] 'process raft request' (duration: 1.060396319s)","trace[908280918] 'compare' (duration: 248.582996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:02.599636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:01.28964Z","time spent":"1.309949049s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:17:02.599872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.241289283s","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-06-13T06:17:02.599964Z","caller":"traceutil/trace.go:171","msg":"trace[746378368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1306; }","duration":"1.241431416s","start":"2026-06-13T06:17:01.358511Z","end":"2026-06-13T06:17:02.599942Z","steps":["trace[746378368] 'agreement among raft nodes before linearized reading' (duration: 1.24116213s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:02.600015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:01.35849Z","time spent":"1.241515798s","remote":"127.0.0.1:36202","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-06-13T06:17:04.226381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.545770992s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-13T06:17:04.246259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000330776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-13T06:17:04.246342Z","caller":"traceutil/trace.go:171","msg":"trace[667747350] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000455079s","start":"2026-06-13T06:17:02.245851Z","end":"2026-06-13T06:17:04.246306Z","steps":["trace[667747350] 'agreement among raft nodes before linearized reading' (duration: 2.000370177s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.246418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:02.245801Z","time spent":"2.000605694s","remote":"127.0.0.1:35938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/13 06:17:04 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-13T06:17:04.461546Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.779851106s","expected-duration":"1s"} {"level":"info","ts":"2026-06-13T06:17:04.462112Z","caller":"traceutil/trace.go:171","msg":"trace[644075588] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"1.966760942s","start":"2026-06-13T06:17:02.495315Z","end":"2026-06-13T06:17:04.462076Z","steps":["trace[644075588] 'process raft request' (duration: 1.966477685s)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:04.462131Z","caller":"traceutil/trace.go:171","msg":"trace[1629740441] linearizableReadLoop","detail":"{readStateIndex:1366; appliedIndex:1364; }","duration":"1.862563723s","start":"2026-06-13T06:17:02.599497Z","end":"2026-06-13T06:17:04.462061Z","steps":["trace[1629740441] 'read index received' (duration: 82.152544ms)","trace[1629740441] 'applied index is now lower than readState.Index' (duration: 1.780410329s)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:04.462232Z","caller":"traceutil/trace.go:171","msg":"trace[1469724806] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"1.857266368s","start":"2026-06-13T06:17:02.604918Z","end":"2026-06-13T06:17:04.462185Z","steps":["trace[1469724806] 'process raft request' (duration: 1.857088064s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.46228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:02.495293Z","time spent":"1.966889824s","remote":"127.0.0.1:36202","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-06-13T06:17:04.462357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.411872311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-06-13T06:17:04.462414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:02.604893Z","time spent":"1.857402582s","remote":"127.0.0.1:36202","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-06-13T06:17:04.462425Z","caller":"traceutil/trace.go:171","msg":"trace[504697558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1308; }","duration":"2.412025585s","start":"2026-06-13T06:17:02.050388Z","end":"2026-06-13T06:17:04.462413Z","steps":["trace[504697558] 'agreement among raft nodes before linearized reading' (duration: 2.41183649s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.462435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.647825468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T06:17:04.462472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:02.050356Z","time spent":"2.412107307s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-13T06:17:04.462486Z","caller":"traceutil/trace.go:171","msg":"trace[172451102] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1308; }","duration":"2.647914401s","start":"2026-06-13T06:17:01.814542Z","end":"2026-06-13T06:17:04.462457Z","steps":["trace[172451102] 'agreement among raft nodes before linearized reading' (duration: 2.647846309s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.462684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:01.814514Z","time spent":"2.648080804s","remote":"127.0.0.1:36352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"info","ts":"2026-06-13T06:17:04.883815Z","caller":"traceutil/trace.go:171","msg":"trace[2018127117] linearizableReadLoop","detail":"{readStateIndex:1369; appliedIndex:1367; }","duration":"421.583235ms","start":"2026-06-13T06:17:04.462195Z","end":"2026-06-13T06:17:04.883779Z","steps":["trace[2018127117] 'read index received' (duration: 401.600842ms)","trace[2018127117] 'applied index is now lower than readState.Index' (duration: 19.980583ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:04.883974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.737716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:17:04.884033Z","caller":"traceutil/trace.go:171","msg":"trace[1209993054] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1310; }","duration":"627.840618ms","start":"2026-06-13T06:17:04.256178Z","end":"2026-06-13T06:17:04.884018Z","steps":["trace[1209993054] 'agreement among raft nodes before linearized reading' (duration: 627.721235ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:04.884045Z","caller":"traceutil/trace.go:171","msg":"trace[495411114] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"633.919063ms","start":"2026-06-13T06:17:04.250114Z","end":"2026-06-13T06:17:04.884033Z","steps":["trace[495411114] 'process raft request' (duration: 633.590685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.884064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:04.256152Z","time spent":"627.90644ms","remote":"127.0.0.1:35940","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-06-13T06:17:04.884147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:04.25007Z","time spent":"634.010245ms","remote":"127.0.0.1:36018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T06:17:04.884148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066562487s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-13T06:17:04.884194Z","caller":"traceutil/trace.go:171","msg":"trace[1142382157] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.06667098s","start":"2026-06-13T06:17:03.817511Z","end":"2026-06-13T06:17:04.884182Z","steps":["trace[1142382157] 'agreement among raft nodes before linearized reading' (duration: 1.066453665s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.884238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:03.817495Z","time spent":"1.066733011s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-13T06:17:04.883833Z","caller":"traceutil/trace.go:171","msg":"trace[2073664806] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"1.819359182s","start":"2026-06-13T06:17:03.064433Z","end":"2026-06-13T06:17:04.883792Z","steps":["trace[2073664806] 'process raft request' (duration: 1.7994191s)","trace[2073664806] 'compare' (duration: 19.616274ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:04.884422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.81754397s","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-06-13T06:17:04.884448Z","caller":"traceutil/trace.go:171","msg":"trace[131321429] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"1.817615801s","start":"2026-06-13T06:17:03.066825Z","end":"2026-06-13T06:17:04.88444Z","steps":["trace[131321429] 'agreement among raft nodes before linearized reading' (duration: 1.817499199s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.884468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:03.066805Z","time spent":"1.817658462s","remote":"127.0.0.1:36202","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-06-13T06:17:04.884483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18873837s","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":"info","ts":"2026-06-13T06:17:04.884524Z","caller":"traceutil/trace.go:171","msg":"trace[1734844128] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1310; }","duration":"1.188820322s","start":"2026-06-13T06:17:03.695691Z","end":"2026-06-13T06:17:04.884511Z","steps":["trace[1734844128] 'agreement among raft nodes before linearized reading' (duration: 1.18875096s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.884556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:03.69567Z","time spent":"1.188877643s","remote":"127.0.0.1:50824","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-06-13T06:17:04.884533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:03.064386Z","time spent":"1.820038179s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:17:04.891473Z","caller":"traceutil/trace.go:171","msg":"trace[468089053] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"422.778342ms","start":"2026-06-13T06:17:04.468665Z","end":"2026-06-13T06:17:04.891443Z","steps":["trace[468089053] 'process raft request' (duration: 422.588288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.891593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:04.468634Z","time spent":"422.892975ms","remote":"127.0.0.1:36202","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-06-13T06:17:04.891633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.293973ms","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-06-13T06:17:04.891697Z","caller":"traceutil/trace.go:171","msg":"trace[1547467336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1311; }","duration":"287.405336ms","start":"2026-06-13T06:17:04.604278Z","end":"2026-06-13T06:17:04.891683Z","steps":["trace[1547467336] 'agreement among raft nodes before linearized reading' (duration: 287.203271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:04.891712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.534409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:17:04.89182Z","caller":"traceutil/trace.go:171","msg":"trace[511647328] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1311; }","duration":"192.723734ms","start":"2026-06-13T06:17:04.699077Z","end":"2026-06-13T06:17:04.891801Z","steps":["trace[511647328] 'agreement among raft nodes before linearized reading' (duration: 192.396626ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:05.028158Z","caller":"traceutil/trace.go:171","msg":"trace[1164713403] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"133.199354ms","start":"2026-06-13T06:17:04.894931Z","end":"2026-06-13T06:17:05.028131Z","steps":["trace[1164713403] 'process raft request' (duration: 133.142082ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:05.028205Z","caller":"traceutil/trace.go:171","msg":"trace[505169272] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"136.744208ms","start":"2026-06-13T06:17:04.891431Z","end":"2026-06-13T06:17:05.028175Z","steps":["trace[505169272] 'process raft request' (duration: 107.165498ms)","trace[505169272] 'compare' (duration: 29.328414ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:05.967174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.918979ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:17:05.9673Z","caller":"traceutil/trace.go:171","msg":"trace[2072170006] linearizableReadLoop","detail":"{readStateIndex:1377; appliedIndex:1376; }","duration":"485.353372ms","start":"2026-06-13T06:17:05.481916Z","end":"2026-06-13T06:17:05.96727Z","steps":["trace[2072170006] 'read index received' (duration: 240.26883ms)","trace[2072170006] 'applied index is now lower than readState.Index' (duration: 245.083262ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:05.967386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.472375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:17:05.967414Z","caller":"traceutil/trace.go:171","msg":"trace[535062798] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1318; }","duration":"485.532006ms","start":"2026-06-13T06:17:05.481871Z","end":"2026-06-13T06:17:05.967403Z","steps":["trace[535062798] 'agreement among raft nodes before linearized reading' (duration: 485.463585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:05.967446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:05.481846Z","time spent":"485.593197ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-13T06:17:05.967399Z","caller":"traceutil/trace.go:171","msg":"trace[1367111388] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"510.306853ms","start":"2026-06-13T06:17:05.457031Z","end":"2026-06-13T06:17:05.967338Z","steps":["trace[1367111388] 'process raft request' (duration: 265.148938ms)","trace[1367111388] 'compare' (duration: 244.806976ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:05.967649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:05.457014Z","time spent":"510.520957ms","remote":"127.0.0.1:36018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:17:06.174023Z","caller":"traceutil/trace.go:171","msg":"trace[1721392623] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1377; }","duration":"137.557037ms","start":"2026-06-13T06:17:06.036436Z","end":"2026-06-13T06:17:06.173993Z","steps":["trace[1721392623] 'read index received' (duration: 76.648615ms)","trace[1721392623] 'applied index is now lower than readState.Index' (duration: 60.906722ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:06.174055Z","caller":"traceutil/trace.go:171","msg":"trace[2108790893] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"201.813438ms","start":"2026-06-13T06:17:05.972191Z","end":"2026-06-13T06:17:06.174004Z","steps":["trace[2108790893] 'process raft request' (duration: 140.723092ms)","trace[2108790893] 'compare' (duration: 60.80991ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:06.174072Z","caller":"traceutil/trace.go:171","msg":"trace[1996229103] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"201.694826ms","start":"2026-06-13T06:17:05.972343Z","end":"2026-06-13T06:17:06.174037Z","steps":["trace[1996229103] 'process raft request' (duration: 201.591574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:06.174223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.779072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:17:06.174275Z","caller":"traceutil/trace.go:171","msg":"trace[443085955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1320; }","duration":"137.856964ms","start":"2026-06-13T06:17:06.036404Z","end":"2026-06-13T06:17:06.174261Z","steps":["trace[443085955] 'agreement among raft nodes before linearized reading' (duration: 137.701841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:10.770884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.14967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T06:17:10.77121Z","caller":"traceutil/trace.go:171","msg":"trace[584537491] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"283.793468ms","start":"2026-06-13T06:17:10.487392Z","end":"2026-06-13T06:17:10.771185Z","steps":["trace[584537491] 'process raft request' (duration: 283.731267ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:10.771633Z","caller":"traceutil/trace.go:171","msg":"trace[871642897] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1415; }","duration":"297.525883ms","start":"2026-06-13T06:17:10.474086Z","end":"2026-06-13T06:17:10.771612Z","steps":["trace[871642897] 'read index received' (duration: 272.391378ms)","trace[871642897] 'applied index is now lower than readState.Index' (duration: 25.132185ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:10.77178Z","caller":"traceutil/trace.go:171","msg":"trace[1778474120] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"370.01314ms","start":"2026-06-13T06:17:10.40173Z","end":"2026-06-13T06:17:10.771743Z","steps":["trace[1778474120] 'process raft request' (duration: 369.285422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:10.77186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.707218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T06:17:10.771894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.564822ms","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-06-13T06:17:10.771998Z","caller":"traceutil/trace.go:171","msg":"trace[1695425566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1358; }","duration":"280.697555ms","start":"2026-06-13T06:17:10.491265Z","end":"2026-06-13T06:17:10.771963Z","steps":["trace[1695425566] 'agreement among raft nodes before linearized reading' (duration: 280.48151ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:10.772Z","caller":"traceutil/trace.go:171","msg":"trace[213322126] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1358; }","duration":"297.969104ms","start":"2026-06-13T06:17:10.474012Z","end":"2026-06-13T06:17:10.771981Z","steps":["trace[213322126] 'agreement among raft nodes before linearized reading' (duration: 297.718808ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:10.772214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:10.401721Z","time spent":"370.167194ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:17:10.771502Z","caller":"traceutil/trace.go:171","msg":"trace[1546504838] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"370.528192ms","start":"2026-06-13T06:17:10.400905Z","end":"2026-06-13T06:17:10.771433Z","steps":["trace[1546504838] 'process raft request' (duration: 38.727097ms)","trace[1546504838] 'compare' (duration: 330.994786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:17:10.772512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:10.400875Z","time spent":"371.560397ms","remote":"127.0.0.1:36018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":911,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-13T06:17:11.03693Z","caller":"traceutil/trace.go:171","msg":"trace[395173918] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"259.833523ms","start":"2026-06-13T06:17:10.777067Z","end":"2026-06-13T06:17:11.0369Z","steps":["trace[395173918] 'process raft request' (duration: 259.545236ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:11.036919Z","caller":"traceutil/trace.go:171","msg":"trace[1120605368] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1419; }","duration":"148.751043ms","start":"2026-06-13T06:17:10.888129Z","end":"2026-06-13T06:17:11.03688Z","steps":["trace[1120605368] 'read index received' (duration: 148.367384ms)","trace[1120605368] 'applied index is now lower than readState.Index' (duration: 381.889µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:11.036986Z","caller":"traceutil/trace.go:171","msg":"trace[841046648] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"233.305165ms","start":"2026-06-13T06:17:10.803651Z","end":"2026-06-13T06:17:11.036956Z","steps":["trace[841046648] 'process raft request' (duration: 233.146851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:11.037303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.141662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T06:17:11.037388Z","caller":"traceutil/trace.go:171","msg":"trace[1968918420] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1361; }","duration":"149.279714ms","start":"2026-06-13T06:17:10.888091Z","end":"2026-06-13T06:17:11.037371Z","steps":["trace[1968918420] 'agreement among raft nodes before linearized reading' (duration: 148.963017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:11.037635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.684331ms","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-06-13T06:17:11.037702Z","caller":"traceutil/trace.go:171","msg":"trace[1201394156] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1361; }","duration":"118.834754ms","start":"2026-06-13T06:17:10.918853Z","end":"2026-06-13T06:17:11.037688Z","steps":["trace[1201394156] 'agreement among raft nodes before linearized reading' (duration: 118.2533ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:11.159543Z","caller":"traceutil/trace.go:171","msg":"trace[1561840749] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"115.220367ms","start":"2026-06-13T06:17:11.044305Z","end":"2026-06-13T06:17:11.159525Z","steps":["trace[1561840749] 'process raft request' (duration: 98.743678ms)","trace[1561840749] 'compare' (duration: 16.347016ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:11.15969Z","caller":"traceutil/trace.go:171","msg":"trace[84127020] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"115.32179ms","start":"2026-06-13T06:17:11.044361Z","end":"2026-06-13T06:17:11.159683Z","steps":["trace[84127020] 'process raft request' (duration: 115.130486ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:11.159961Z","caller":"traceutil/trace.go:171","msg":"trace[675934453] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"115.597597ms","start":"2026-06-13T06:17:11.044355Z","end":"2026-06-13T06:17:11.159953Z","steps":["trace[675934453] 'process raft request' (duration: 115.30033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:11.160193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.333626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-06-13T06:17:11.160189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.562194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-13T06:17:11.160255Z","caller":"traceutil/trace.go:171","msg":"trace[437760347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1365; }","duration":"109.658646ms","start":"2026-06-13T06:17:11.050579Z","end":"2026-06-13T06:17:11.160237Z","steps":["trace[437760347] 'agreement among raft nodes before linearized reading' (duration: 109.40298ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:11.160221Z","caller":"traceutil/trace.go:171","msg":"trace[1526258465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1365; }","duration":"111.386057ms","start":"2026-06-13T06:17:11.048827Z","end":"2026-06-13T06:17:11.160213Z","steps":["trace[1526258465] 'agreement among raft nodes before linearized reading' (duration: 111.256894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.264928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.604844ms","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-06-13T06:17:13.265027Z","caller":"traceutil/trace.go:171","msg":"trace[1032559547] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1369; }","duration":"690.715857ms","start":"2026-06-13T06:17:12.574297Z","end":"2026-06-13T06:17:13.265012Z","steps":["trace[1032559547] 'range keys from in-memory index tree' (duration: 690.591244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.26512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:11.700283Z","time spent":"1.564830413s","remote":"127.0.0.1:33184","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-13T06:17:13.265148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.077103264s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:17:13.265232Z","caller":"traceutil/trace.go:171","msg":"trace[409044075] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1369; }","duration":"1.077234018s","start":"2026-06-13T06:17:12.18798Z","end":"2026-06-13T06:17:13.265214Z","steps":["trace[409044075] 'count revisions from in-memory index tree' (duration: 1.076952881s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.265274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:12.187958Z","time spent":"1.077305159s","remote":"127.0.0.1:36222","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-06-13T06:17:13.322857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.579322ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-13T06:17:13.323128Z","caller":"traceutil/trace.go:171","msg":"trace[1565733194] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1429; }","duration":"1.008228513s","start":"2026-06-13T06:17:12.314857Z","end":"2026-06-13T06:17:13.323085Z","steps":["trace[1565733194] 'read index received' (duration: 214.368954ms)","trace[1565733194] 'applied index is now lower than readState.Index' (duration: 793.856999ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:13.32323Z","caller":"traceutil/trace.go:171","msg":"trace[1055006743] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"544.947945ms","start":"2026-06-13T06:17:12.778258Z","end":"2026-06-13T06:17:13.323206Z","steps":["trace[1055006743] 'process raft request' (duration: 544.757581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.323387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:12.778226Z","time spent":"545.065298ms","remote":"127.0.0.1:36202","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-06-13T06:17:13.323433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008569121s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-13T06:17:13.323473Z","caller":"traceutil/trace.go:171","msg":"trace[1618337033] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1370; }","duration":"1.008658514s","start":"2026-06-13T06:17:12.314802Z","end":"2026-06-13T06:17:13.32346Z","steps":["trace[1618337033] 'agreement among raft nodes before linearized reading' (duration: 1.008470639s)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.323511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:12.314775Z","time spent":"1.008728825s","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-13T06:17:13.323653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.067407ms","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-06-13T06:17:13.323687Z","caller":"traceutil/trace.go:171","msg":"trace[95528046] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1370; }","duration":"667.163209ms","start":"2026-06-13T06:17:12.656515Z","end":"2026-06-13T06:17:13.323678Z","steps":["trace[95528046] 'agreement among raft nodes before linearized reading' (duration: 667.087587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.323714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:12.656483Z","time spent":"667.22352ms","remote":"127.0.0.1:36090","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":"warn","ts":"2026-06-13T06:17:13.32382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.078318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-13T06:17:13.323944Z","caller":"traceutil/trace.go:171","msg":"trace[537996852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1370; }","duration":"121.159679ms","start":"2026-06-13T06:17:13.202701Z","end":"2026-06-13T06:17:13.323861Z","steps":["trace[537996852] 'agreement among raft nodes before linearized reading' (duration: 120.939574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.323983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.51557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-13T06:17:13.324032Z","caller":"traceutil/trace.go:171","msg":"trace[1154597490] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1370; }","duration":"138.613813ms","start":"2026-06-13T06:17:13.185406Z","end":"2026-06-13T06:17:13.32402Z","steps":["trace[1154597490] 'agreement among raft nodes before linearized reading' (duration: 138.487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.324252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.277698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-13T06:17:13.324295Z","caller":"traceutil/trace.go:171","msg":"trace[166264032] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1370; }","duration":"120.34383ms","start":"2026-06-13T06:17:13.20394Z","end":"2026-06-13T06:17:13.324284Z","steps":["trace[166264032] 'agreement among raft nodes before linearized reading' (duration: 120.236127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.324295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.071778ms","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-06-13T06:17:13.324337Z","caller":"traceutil/trace.go:171","msg":"trace[2110339229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1370; }","duration":"450.112649ms","start":"2026-06-13T06:17:12.874211Z","end":"2026-06-13T06:17:13.324324Z","steps":["trace[2110339229] 'agreement among raft nodes before linearized reading' (duration: 449.962035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.324377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:17:12.874144Z","time spent":"450.225221ms","remote":"127.0.0.1:36202","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-06-13T06:17:13.324592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.841645ms","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-06-13T06:17:13.324643Z","caller":"traceutil/trace.go:171","msg":"trace[735185309] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1370; }","duration":"159.917167ms","start":"2026-06-13T06:17:13.164713Z","end":"2026-06-13T06:17:13.32463Z","steps":["trace[735185309] 'agreement among raft nodes before linearized reading' (duration: 159.803375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:17:13.3246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.901113ms","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-06-13T06:17:13.32479Z","caller":"traceutil/trace.go:171","msg":"trace[851114902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1370; }","duration":"159.111878ms","start":"2026-06-13T06:17:13.165666Z","end":"2026-06-13T06:17:13.324778Z","steps":["trace[851114902] 'agreement among raft nodes before linearized reading' (duration: 158.863292ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:25.434946Z","caller":"traceutil/trace.go:171","msg":"trace[1085576954] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"137.560177ms","start":"2026-06-13T06:17:25.297346Z","end":"2026-06-13T06:17:25.434906Z","steps":["trace[1085576954] 'process raft request' (duration: 137.312581ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:25.479186Z","caller":"traceutil/trace.go:171","msg":"trace[76073741] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"109.839641ms","start":"2026-06-13T06:17:25.369314Z","end":"2026-06-13T06:17:25.479153Z","steps":["trace[76073741] 'process raft request' (duration: 109.524924ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:59.900065Z","caller":"traceutil/trace.go:171","msg":"trace[1953910832] transaction","detail":"{read_only:false; response_revision:1594; number_of_response:1; }","duration":"108.418408ms","start":"2026-06-13T06:17:59.79162Z","end":"2026-06-13T06:17:59.900039Z","steps":["trace[1953910832] 'process raft request' (duration: 32.398027ms)","trace[1953910832] 'compare' (duration: 75.814056ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:17:59.900548Z","caller":"traceutil/trace.go:171","msg":"trace[864999253] transaction","detail":"{read_only:false; response_revision:1595; number_of_response:1; }","duration":"108.382848ms","start":"2026-06-13T06:17:59.792148Z","end":"2026-06-13T06:17:59.900531Z","steps":["trace[864999253] 'process raft request' (duration: 108.247855ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:59.900884Z","caller":"traceutil/trace.go:171","msg":"trace[1834705923] transaction","detail":"{read_only:false; response_revision:1597; number_of_response:1; }","duration":"108.164113ms","start":"2026-06-13T06:17:59.792705Z","end":"2026-06-13T06:17:59.900869Z","steps":["trace[1834705923] 'process raft request' (duration: 108.093741ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:17:59.90113Z","caller":"traceutil/trace.go:171","msg":"trace[1572858781] transaction","detail":"{read_only:false; response_revision:1596; number_of_response:1; }","duration":"108.450099ms","start":"2026-06-13T06:17:59.792648Z","end":"2026-06-13T06:17:59.901098Z","steps":["trace[1572858781] 'process raft request' (duration: 107.840245ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:01.086711Z","caller":"traceutil/trace.go:171","msg":"trace[553346107] transaction","detail":"{read_only:false; response_revision:1598; number_of_response:1; }","duration":"161.621299ms","start":"2026-06-13T06:18:00.925062Z","end":"2026-06-13T06:18:01.086684Z","steps":["trace[553346107] 'process raft request' (duration: 161.285301ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:02.017612Z","caller":"traceutil/trace.go:171","msg":"trace[1257574818] transaction","detail":"{read_only:false; response_revision:1604; number_of_response:1; }","duration":"108.88999ms","start":"2026-06-13T06:18:01.908679Z","end":"2026-06-13T06:18:02.017569Z","steps":["trace[1257574818] 'process raft request' (duration: 108.633024ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:02.018241Z","caller":"traceutil/trace.go:171","msg":"trace[651888545] transaction","detail":"{read_only:false; response_revision:1605; number_of_response:1; }","duration":"107.887266ms","start":"2026-06-13T06:18:01.910311Z","end":"2026-06-13T06:18:02.018198Z","steps":["trace[651888545] 'process raft request' (duration: 107.20371ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:02.018297Z","caller":"traceutil/trace.go:171","msg":"trace[107994554] transaction","detail":"{read_only:false; response_revision:1606; number_of_response:1; }","duration":"107.647921ms","start":"2026-06-13T06:18:01.910624Z","end":"2026-06-13T06:18:02.018272Z","steps":["trace[107994554] 'process raft request' (duration: 107.365134ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:06.216435Z","caller":"traceutil/trace.go:171","msg":"trace[2019042267] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"135.366727ms","start":"2026-06-13T06:18:06.08104Z","end":"2026-06-13T06:18:06.216407Z","steps":["trace[2019042267] 'process raft request' (duration: 127.288385ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:06.216477Z","caller":"traceutil/trace.go:171","msg":"trace[251390115] linearizableReadLoop","detail":"{readStateIndex:1693; appliedIndex:1690; }","duration":"125.262017ms","start":"2026-06-13T06:18:06.091186Z","end":"2026-06-13T06:18:06.216448Z","steps":["trace[251390115] 'read index received' (duration: 26.58737ms)","trace[251390115] 'applied index is now lower than readState.Index' (duration: 98.673137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:18:06.216793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.521524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-13T06:18:06.216766Z","caller":"traceutil/trace.go:171","msg":"trace[253846145] transaction","detail":"{read_only:false; response_revision:1621; number_of_response:1; }","duration":"135.226523ms","start":"2026-06-13T06:18:06.081472Z","end":"2026-06-13T06:18:06.216698Z","steps":["trace[253846145] 'process raft request' (duration: 134.846414ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:06.216882Z","caller":"traceutil/trace.go:171","msg":"trace[2113023056] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1622; }","duration":"125.706438ms","start":"2026-06-13T06:18:06.091155Z","end":"2026-06-13T06:18:06.216862Z","steps":["trace[2113023056] 'agreement among raft nodes before linearized reading' (duration: 125.386291ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:06.216788Z","caller":"traceutil/trace.go:171","msg":"trace[1019639390] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"134.684001ms","start":"2026-06-13T06:18:06.082061Z","end":"2026-06-13T06:18:06.216745Z","steps":["trace[1019639390] 'process raft request' (duration: 134.325192ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:18:06.833249Z","caller":"traceutil/trace.go:171","msg":"trace[939643764] transaction","detail":"{read_only:false; response_revision:1626; number_of_response:1; }","duration":"115.288681ms","start":"2026-06-13T06:18:06.717935Z","end":"2026-06-13T06:18:06.833224Z","steps":["trace[939643764] 'process raft request' (duration: 113.086109ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:19:02.82723Z","caller":"traceutil/trace.go:171","msg":"trace[280969932] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"281.851383ms","start":"2026-06-13T06:19:02.545349Z","end":"2026-06-13T06:19:02.827201Z","steps":["trace[280969932] 'process raft request' (duration: 281.639018ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:19:02.827436Z","caller":"traceutil/trace.go:171","msg":"trace[2052391058] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"281.404034ms","start":"2026-06-13T06:19:02.54602Z","end":"2026-06-13T06:19:02.827424Z","steps":["trace[2052391058] 'process raft request' (duration: 281.139887ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:21:09.032199Z","caller":"traceutil/trace.go:171","msg":"trace[1583077439] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"140.861273ms","start":"2026-06-13T06:21:08.891311Z","end":"2026-06-13T06:21:09.032173Z","steps":["trace[1583077439] 'process raft request' (duration: 140.583096ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:21:09.562595Z","caller":"traceutil/trace.go:171","msg":"trace[111294553] transaction","detail":"{read_only:false; response_revision:2484; number_of_response:1; }","duration":"526.255862ms","start":"2026-06-13T06:21:09.03617Z","end":"2026-06-13T06:21:09.562426Z","steps":["trace[111294553] 'process raft request' (duration: 517.962626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:21:09.562732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:21:09.036153Z","time spent":"526.507388ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T06:21:09.58193Z","caller":"traceutil/trace.go:171","msg":"trace[728647987] linearizableReadLoop","detail":"{readStateIndex:2594; appliedIndex:2592; }","duration":"195.805693ms","start":"2026-06-13T06:21:09.386107Z","end":"2026-06-13T06:21:09.581913Z","steps":["trace[728647987] 'read index received' (duration: 168.035626ms)","trace[728647987] 'applied index is now lower than readState.Index' (duration: 27.769097ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T06:21:09.582006Z","caller":"traceutil/trace.go:171","msg":"trace[1347491326] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"544.292089ms","start":"2026-06-13T06:21:09.037695Z","end":"2026-06-13T06:21:09.581987Z","steps":["trace[1347491326] 'process raft request' (duration: 544.085474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:21:09.582113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:21:09.037668Z","time spent":"544.393801ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T06:21:09.582166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.055229ms","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-06-13T06:21:09.582227Z","caller":"traceutil/trace.go:171","msg":"trace[112238059] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2485; }","duration":"196.139611ms","start":"2026-06-13T06:21:09.386052Z","end":"2026-06-13T06:21:09.582192Z","steps":["trace[112238059] 'agreement among raft nodes before linearized reading' (duration: 195.986177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:21:09.582281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.949788ms","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-06-13T06:21:09.582318Z","caller":"traceutil/trace.go:171","msg":"trace[1496101048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2485; }","duration":"150.00699ms","start":"2026-06-13T06:21:09.432301Z","end":"2026-06-13T06:21:09.582308Z","steps":["trace[1496101048] 'agreement among raft nodes before linearized reading' (duration: 149.910747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:21:09.58259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.436463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-06-13T06:21:09.582628Z","caller":"traceutil/trace.go:171","msg":"trace[304786277] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2485; }","duration":"110.491584ms","start":"2026-06-13T06:21:09.472124Z","end":"2026-06-13T06:21:09.582615Z","steps":["trace[304786277] 'agreement among raft nodes before linearized reading' (duration: 110.417752ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:21:11.439778Z","caller":"traceutil/trace.go:171","msg":"trace[359722793] linearizableReadLoop","detail":"{readStateIndex:2606; appliedIndex:2605; }","duration":"193.708303ms","start":"2026-06-13T06:21:11.246046Z","end":"2026-06-13T06:21:11.439754Z","steps":["trace[359722793] 'read index received' (duration: 193.629851ms)","trace[359722793] 'applied index is now lower than readState.Index' (duration: 77.452µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T06:21:11.439892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.833637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T06:21:11.439919Z","caller":"traceutil/trace.go:171","msg":"trace[598678957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2497; }","duration":"193.921459ms","start":"2026-06-13T06:21:11.245988Z","end":"2026-06-13T06:21:11.439909Z","steps":["trace[598678957] 'agreement among raft nodes before linearized reading' (duration: 193.856127ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T06:21:11.440149Z","caller":"traceutil/trace.go:171","msg":"trace[2072819181] transaction","detail":"{read_only:false; response_revision:2497; number_of_response:1; }","duration":"732.358138ms","start":"2026-06-13T06:21:10.707729Z","end":"2026-06-13T06:21:11.440087Z","steps":["trace[2072819181] 'process raft request' (duration: 731.882347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T06:21:11.440314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T06:21:10.707704Z","time spent":"732.530932ms","remote":"127.0.0.1:36202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"}