{"level":"warn","ts":"2026-05-08T10:21:46.433611Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:21:46.433749Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143: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.19.213.143:2380","--initial-cluster=instance=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-08T10:21:46.433886Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:21:46.433959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-05-08T10:21:46.434067Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T10:21:46.435022Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-05-08T10:21:46.435338Z","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.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.143:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-08T10:21:46.439997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.318599ms"} {"level":"info","ts":"2026-05-08T10:21:46.447388Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"} {"level":"info","ts":"2026-05-08T10:21:46.447497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T10:21:46.447521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 0"} {"level":"info","ts":"2026-05-08T10:21:46.447537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T10:21:46.44755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 1"} {"level":"info","ts":"2026-05-08T10:21:46.447599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"warn","ts":"2026-05-08T10:21:46.459102Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T10:21:46.462937Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T10:21:46.470824Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-08T10:21:46.474759Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T10:21:46.475176Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T10:21:46.475412Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:21:46.475522Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:21:46.475542Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:21:46.477313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"info","ts":"2026-05-08T10:21:46.477876Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-05-08T10:21:46.483117Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-05-08T10:21:46.483159Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-05-08T10:21:46.48319Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T10:21:46.483799Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T10:21:46.483869Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T10:21:47.448102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T10:21:47.448257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T10:21:47.448307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"} {"level":"info","ts":"2026-05-08T10:21:47.448388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became candidate at term 2"} {"level":"info","ts":"2026-05-08T10:21:47.448433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-05-08T10:21:47.448473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became leader at term 2"} {"level":"info","ts":"2026-05-08T10:21:47.448533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-05-08T10:21:47.449456Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.143:2379]}","request-path":"/0/members/e5bed6df0e44a0b1/attributes","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T10:21:47.449468Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:21:47.4497Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:21:47.449802Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T10:21:47.44984Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T10:21:47.449684Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:21:47.450319Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:21:47.450423Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:21:47.450461Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:21:47.45289Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"info","ts":"2026-05-08T10:21:47.453436Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-08T10:21:50.423004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.562394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:50.423201Z","caller":"traceutil/trace.go:171","msg":"trace[1456514803] range","detail":"{range_begin:/registry/rolebindings/kube-public/system:controller:bootstrap-signer; range_end:; response_count:0; response_revision:231; }","duration":"117.81466ms","start":"2026-05-08T10:21:50.305363Z","end":"2026-05-08T10:21:50.423178Z","steps":["trace[1456514803] 'range keys from in-memory index tree' (duration: 117.444062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:10.74331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.977656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:22:10.743438Z","caller":"traceutil/trace.go:171","msg":"trace[1921987882] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"210.101741ms","start":"2026-05-08T10:22:10.533319Z","end":"2026-05-08T10:22:10.743421Z","steps":["trace[1921987882] 'compare' (duration: 204.809342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:12.274111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.911255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:22:12.274177Z","caller":"traceutil/trace.go:171","msg":"trace[459977798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:460; }","duration":"503.026017ms","start":"2026-05-08T10:22:11.771136Z","end":"2026-05-08T10:22:12.274162Z","steps":["trace[459977798] 'range keys from in-memory index tree' (duration: 502.772621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:12.274181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.386985131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-08T10:22:12.274207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:11.771117Z","time spent":"503.085258ms","remote":"127.0.0.1:35478","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-05-08T10:22:12.274226Z","caller":"traceutil/trace.go:171","msg":"trace[196271367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:460; }","duration":"1.387051482s","start":"2026-05-08T10:22:10.887156Z","end":"2026-05-08T10:22:12.274207Z","steps":["trace[196271367] 'range keys from in-memory index tree' (duration: 1.38693765s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:12.274258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:10.887142Z","time spent":"1.387108974s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T10:22:12.274122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338427455s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T10:22:12.274345Z","caller":"traceutil/trace.go:171","msg":"trace[540604920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:460; }","duration":"1.338697891s","start":"2026-05-08T10:22:10.935638Z","end":"2026-05-08T10:22:12.274336Z","steps":["trace[540604920] 'range keys from in-memory index tree' (duration: 1.338295842s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:12.274369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:10.935616Z","time spent":"1.338746722s","remote":"127.0.0.1:35478","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-05-08T10:22:12.274471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029271514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:12.274489Z","caller":"traceutil/trace.go:171","msg":"trace[2091209103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:460; }","duration":"1.029321555s","start":"2026-05-08T10:22:11.245162Z","end":"2026-05-08T10:22:12.274484Z","steps":["trace[2091209103] 'range keys from in-memory index tree' (duration: 1.029201163s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:12.274508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:11.245143Z","time spent":"1.029360446s","remote":"127.0.0.1:35138","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-05-08T10:22:12.780107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396664,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:13.280627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396664,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:13.637518Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.359540498s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:22:13.637945Z","caller":"traceutil/trace.go:171","msg":"trace[474003812] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"1.360021659s","start":"2026-05-08T10:22:12.277899Z","end":"2026-05-08T10:22:13.637921Z","steps":["trace[474003812] 'process raft request' (duration: 1.359893777s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.638091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.277878Z","time spent":"1.360116421s","remote":"127.0.0.1:35478","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-05-08T10:22:13.654605Z","caller":"traceutil/trace.go:171","msg":"trace[1218572107] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:475; }","duration":"1.374543873s","start":"2026-05-08T10:22:12.280031Z","end":"2026-05-08T10:22:13.654575Z","steps":["trace[1218572107] 'read index received' (duration: 1.357757318s)","trace[1218572107] 'applied index is now lower than readState.Index' (duration: 16.784975ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:13.655144Z","caller":"traceutil/trace.go:171","msg":"trace[1144371747] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"1.37669711s","start":"2026-05-08T10:22:12.278433Z","end":"2026-05-08T10:22:13.65513Z","steps":["trace[1144371747] 'process raft request' (duration: 1.375840461s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.655281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.27841Z","time spent":"1.376781292s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:13.655554Z","caller":"traceutil/trace.go:171","msg":"trace[1678243859] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"1.375549755s","start":"2026-05-08T10:22:12.279991Z","end":"2026-05-08T10:22:13.65554Z","steps":["trace[1678243859] 'process raft request' (duration: 1.374452191s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.655638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.279981Z","time spent":"1.375612016s","remote":"127.0.0.1:35478","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-05-08T10:22:13.655827Z","caller":"traceutil/trace.go:171","msg":"trace[384307126] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"976.583357ms","start":"2026-05-08T10:22:12.679228Z","end":"2026-05-08T10:22:13.655811Z","steps":["trace[384307126] 'process raft request' (duration: 975.288899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.655918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.679205Z","time spent":"976.667999ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:13.656121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.376087937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:13.656164Z","caller":"traceutil/trace.go:171","msg":"trace[973388230] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:464; }","duration":"1.376145278s","start":"2026-05-08T10:22:12.280006Z","end":"2026-05-08T10:22:13.656152Z","steps":["trace[973388230] 'agreement among raft nodes before linearized reading' (duration: 1.376079427s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.656193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.279998Z","time spent":"1.376189859s","remote":"127.0.0.1:35150","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-05-08T10:22:13.656353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.192019257s","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-05-08T10:22:13.65639Z","caller":"traceutil/trace.go:171","msg":"trace[1451366294] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:464; }","duration":"1.192087018s","start":"2026-05-08T10:22:12.464293Z","end":"2026-05-08T10:22:13.65638Z","steps":["trace[1451366294] 'agreement among raft nodes before linearized reading' (duration: 1.192028687s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:13.656426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:12.464276Z","time spent":"1.192141589s","remote":"127.0.0.1:35478","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-05-08T10:22:16.078326Z","caller":"traceutil/trace.go:171","msg":"trace[1489082555] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"102.89769ms","start":"2026-05-08T10:22:15.9754Z","end":"2026-05-08T10:22:16.078297Z","steps":["trace[1489082555] 'process raft request' (duration: 54.160796ms)","trace[1489082555] 'compare' (duration: 48.584551ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:16.085241Z","caller":"traceutil/trace.go:171","msg":"trace[1068507351] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:513; }","duration":"105.082957ms","start":"2026-05-08T10:22:15.980132Z","end":"2026-05-08T10:22:16.085215Z","steps":["trace[1068507351] 'read index received' (duration: 49.43732ms)","trace[1068507351] 'applied index is now lower than readState.Index' (duration: 55.642037ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:16.08555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.318273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-05-08T10:22:16.085621Z","caller":"traceutil/trace.go:171","msg":"trace[2132789166] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:501; }","duration":"105.495298ms","start":"2026-05-08T10:22:15.980106Z","end":"2026-05-08T10:22:16.085602Z","steps":["trace[2132789166] 'agreement among raft nodes before linearized reading' (duration: 105.21028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:18.271455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.419607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:22:18.271787Z","caller":"traceutil/trace.go:171","msg":"trace[1271764571] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:535; }","duration":"670.401819ms","start":"2026-05-08T10:22:17.601373Z","end":"2026-05-08T10:22:18.271775Z","steps":["trace[1271764571] 'read index received' (duration: 1.3794ms)","trace[1271764571] 'applied index is now lower than readState.Index' (duration: 669.021569ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:18.271836Z","caller":"traceutil/trace.go:171","msg":"trace[1031865656] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"671.932244ms","start":"2026-05-08T10:22:17.599898Z","end":"2026-05-08T10:22:18.27183Z","steps":["trace[1031865656] 'process raft request' (duration: 354.073207ms)","trace[1031865656] 'compare' (duration: 317.036429ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:18.271866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.599882Z","time spent":"671.968144ms","remote":"127.0.0.1:35236","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-05-08T10:22:18.271873Z","caller":"traceutil/trace.go:171","msg":"trace[2085471524] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"670.382309ms","start":"2026-05-08T10:22:17.601463Z","end":"2026-05-08T10:22:18.271846Z","steps":["trace[2085471524] 'process raft request' (duration: 670.206115ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:18.271939Z","caller":"traceutil/trace.go:171","msg":"trace[190650513] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"670.389099ms","start":"2026-05-08T10:22:17.601544Z","end":"2026-05-08T10:22:18.271933Z","steps":["trace[190650513] 'process raft request' (duration: 670.183294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:18.271975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.60154Z","time spent":"670.411729ms","remote":"127.0.0.1:35236","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-05-08T10:22:18.272003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.601456Z","time spent":"670.473871ms","remote":"127.0.0.1:35236","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-05-08T10:22:18.272156Z","caller":"traceutil/trace.go:171","msg":"trace[1861940296] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"672.073437ms","start":"2026-05-08T10:22:17.599993Z","end":"2026-05-08T10:22:18.272066Z","steps":["trace[1861940296] 'process raft request' (duration: 671.550985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:18.272248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.849279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10078"} {"level":"warn","ts":"2026-05-08T10:22:18.272285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.599989Z","time spent":"672.23742ms","remote":"127.0.0.1:35236","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-05-08T10:22:18.272323Z","caller":"traceutil/trace.go:171","msg":"trace[1491876438] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:522; }","duration":"670.957621ms","start":"2026-05-08T10:22:17.601346Z","end":"2026-05-08T10:22:18.272303Z","steps":["trace[1491876438] 'agreement among raft nodes before linearized reading' (duration: 670.680335ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:18.272367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.601333Z","time spent":"671.024573ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":10101,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-08T10:22:18.772598Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396775,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:19.273254Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396775,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:19.774409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396775,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:20.077042Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.88635292s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:22:20.077463Z","caller":"traceutil/trace.go:171","msg":"trace[130544587] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"2.471320315s","start":"2026-05-08T10:22:17.606126Z","end":"2026-05-08T10:22:20.077446Z","steps":["trace[130544587] 'process raft request' (duration: 2.471209572s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.077624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.606118Z","time spent":"2.471416977s","remote":"127.0.0.1:35236","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-05-08T10:22:20.077458Z","caller":"traceutil/trace.go:171","msg":"trace[54055770] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"2.472568432s","start":"2026-05-08T10:22:17.604855Z","end":"2026-05-08T10:22:20.077424Z","steps":["trace[54055770] 'process raft request' (duration: 2.472353346s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.078478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.604845Z","time spent":"2.472971901s","remote":"127.0.0.1:35738","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-05-08T10:22:20.078624Z","caller":"traceutil/trace.go:171","msg":"trace[592284049] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"2.468981162s","start":"2026-05-08T10:22:17.609611Z","end":"2026-05-08T10:22:20.078592Z","steps":["trace[592284049] 'process raft request' (duration: 2.468051111s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.078766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.609604Z","time spent":"2.469116614s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:22:20.078962Z","caller":"traceutil/trace.go:171","msg":"trace[174273258] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"2.470665969s","start":"2026-05-08T10:22:17.608269Z","end":"2026-05-08T10:22:20.078935Z","steps":["trace[174273258] 'process raft request' (duration: 2.469131426s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.079055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.608262Z","time spent":"2.47073277s","remote":"127.0.0.1:35236","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-05-08T10:22:20.079163Z","caller":"traceutil/trace.go:171","msg":"trace[1644117554] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"2.360194455s","start":"2026-05-08T10:22:17.71895Z","end":"2026-05-08T10:22:20.079144Z","steps":["trace[1644117554] 'process raft request' (duration: 2.358903537s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.079349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.718919Z","time spent":"2.360370608s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:22:20.146001Z","caller":"traceutil/trace.go:171","msg":"trace[1727929065] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"1.852628369s","start":"2026-05-08T10:22:18.293335Z","end":"2026-05-08T10:22:20.145963Z","steps":["trace[1727929065] 'process raft request' (duration: 1.852321332s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.146137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.492082581s","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-05-08T10:22:20.146175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:18.293316Z","time spent":"1.852779792s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:20.146203Z","caller":"traceutil/trace.go:171","msg":"trace[364175465] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:531; }","duration":"2.492193623s","start":"2026-05-08T10:22:17.653995Z","end":"2026-05-08T10:22:20.146188Z","steps":["trace[364175465] 'agreement among raft nodes before linearized reading' (duration: 2.49206976s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.146247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.653973Z","time spent":"2.492261815s","remote":"127.0.0.1:35478","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-05-08T10:22:20.146028Z","caller":"traceutil/trace.go:171","msg":"trace[1556053317] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:539; }","duration":"1.874165537s","start":"2026-05-08T10:22:18.271809Z","end":"2026-05-08T10:22:20.145975Z","steps":["trace[1556053317] 'read index received' (duration: 1.805451175s)","trace[1556053317] 'applied index is now lower than readState.Index' (duration: 68.713262ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:20.14638Z","caller":"traceutil/trace.go:171","msg":"trace[163624034] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"1.851367331s","start":"2026-05-08T10:22:18.294997Z","end":"2026-05-08T10:22:20.146365Z","steps":["trace[163624034] 'process raft request' (duration: 1.850825059s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.146472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:18.294971Z","time spent":"1.851453523s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:20.146543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.469353625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T10:22:20.146487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.451635822s","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-05-08T10:22:20.146527Z","caller":"traceutil/trace.go:171","msg":"trace[1115030889] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"729.117276ms","start":"2026-05-08T10:22:19.417367Z","end":"2026-05-08T10:22:20.146484Z","steps":["trace[1115030889] 'process raft request' (duration: 728.543664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.146655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.470763957s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T10:22:20.146693Z","caller":"traceutil/trace.go:171","msg":"trace[613170375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"2.470830809s","start":"2026-05-08T10:22:17.675851Z","end":"2026-05-08T10:22:20.146682Z","steps":["trace[613170375] 'agreement among raft nodes before linearized reading' (duration: 2.470769697s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.146743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.675836Z","time spent":"2.47089511s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T10:22:20.146886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:19.417347Z","time spent":"729.332771ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:20.146598Z","caller":"traceutil/trace.go:171","msg":"trace[605124400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:531; }","duration":"2.469416246s","start":"2026-05-08T10:22:17.677167Z","end":"2026-05-08T10:22:20.146583Z","steps":["trace[605124400] 'agreement among raft nodes before linearized reading' (duration: 2.469346275s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.147078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.67716Z","time spent":"2.469799525s","remote":"127.0.0.1:35478","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-05-08T10:22:20.1465Z","caller":"traceutil/trace.go:171","msg":"trace[356684931] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"1.865806862s","start":"2026-05-08T10:22:18.280654Z","end":"2026-05-08T10:22:20.146461Z","steps":["trace[356684931] 'process raft request' (duration: 1.864837281s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.147602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:18.280632Z","time spent":"1.866884806s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:20.146607Z","caller":"traceutil/trace.go:171","msg":"trace[406375892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:531; }","duration":"2.451809446s","start":"2026-05-08T10:22:17.694779Z","end":"2026-05-08T10:22:20.146589Z","steps":["trace[406375892] 'agreement among raft nodes before linearized reading' (duration: 2.451657322s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.147701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:17.69476Z","time spent":"2.45292397s","remote":"127.0.0.1:35478","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-05-08T10:22:20.342361Z","caller":"traceutil/trace.go:171","msg":"trace[1140861529] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:548; }","duration":"196.002453ms","start":"2026-05-08T10:22:20.146336Z","end":"2026-05-08T10:22:20.342339Z","steps":["trace[1140861529] 'read index received' (duration: 192.560307ms)","trace[1140861529] 'applied index is now lower than readState.Index' (duration: 3.441276ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:20.342368Z","caller":"traceutil/trace.go:171","msg":"trace[665164252] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"212.412137ms","start":"2026-05-08T10:22:20.129923Z","end":"2026-05-08T10:22:20.342335Z","steps":["trace[665164252] 'process raft request' (duration: 208.960501ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.342429Z","caller":"traceutil/trace.go:171","msg":"trace[105885870] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"207.312433ms","start":"2026-05-08T10:22:20.13508Z","end":"2026-05-08T10:22:20.342393Z","steps":["trace[105885870] 'process raft request' (duration: 207.207201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.342683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097812768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:20.342737Z","caller":"traceutil/trace.go:171","msg":"trace[1091695553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:533; }","duration":"1.098022433s","start":"2026-05-08T10:22:19.244701Z","end":"2026-05-08T10:22:20.342723Z","steps":["trace[1091695553] 'agreement among raft nodes before linearized reading' (duration: 1.097747347s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.342887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:19.244682Z","time spent":"1.098191367s","remote":"127.0.0.1:35150","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-05-08T10:22:20.35554Z","caller":"traceutil/trace.go:171","msg":"trace[14319831] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"203.392617ms","start":"2026-05-08T10:22:20.152133Z","end":"2026-05-08T10:22:20.355525Z","steps":["trace[14319831] 'process raft request' (duration: 202.921616ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.355775Z","caller":"traceutil/trace.go:171","msg":"trace[125784508] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"197.397835ms","start":"2026-05-08T10:22:20.158356Z","end":"2026-05-08T10:22:20.355754Z","steps":["trace[125784508] 'process raft request' (duration: 196.895984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:20.355961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.461527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:20.355987Z","caller":"traceutil/trace.go:171","msg":"trace[53739700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:540; }","duration":"105.531689ms","start":"2026-05-08T10:22:20.25045Z","end":"2026-05-08T10:22:20.355982Z","steps":["trace[53739700] 'agreement among raft nodes before linearized reading' (duration: 105.483588ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.356059Z","caller":"traceutil/trace.go:171","msg":"trace[1614594162] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"182.556094ms","start":"2026-05-08T10:22:20.173498Z","end":"2026-05-08T10:22:20.356055Z","steps":["trace[1614594162] 'process raft request' (duration: 181.801468ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.356176Z","caller":"traceutil/trace.go:171","msg":"trace[1135139651] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"203.939579ms","start":"2026-05-08T10:22:20.152227Z","end":"2026-05-08T10:22:20.356166Z","steps":["trace[1135139651] 'process raft request' (duration: 202.927807ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.356323Z","caller":"traceutil/trace.go:171","msg":"trace[880734725] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"203.807186ms","start":"2026-05-08T10:22:20.152506Z","end":"2026-05-08T10:22:20.356313Z","steps":["trace[880734725] 'process raft request' (duration: 202.665831ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.356377Z","caller":"traceutil/trace.go:171","msg":"trace[234425415] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"202.329253ms","start":"2026-05-08T10:22:20.154043Z","end":"2026-05-08T10:22:20.356372Z","steps":["trace[234425415] 'process raft request' (duration: 201.170578ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.356386Z","caller":"traceutil/trace.go:171","msg":"trace[735339902] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"203.741515ms","start":"2026-05-08T10:22:20.152627Z","end":"2026-05-08T10:22:20.356368Z","steps":["trace[735339902] 'process raft request' (duration: 202.563079ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.653222Z","caller":"traceutil/trace.go:171","msg":"trace[1111003087] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"281.917946ms","start":"2026-05-08T10:22:20.371276Z","end":"2026-05-08T10:22:20.653194Z","steps":["trace[1111003087] 'process raft request' (duration: 244.817185ms)","trace[1111003087] 'compare' (duration: 36.954548ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:20.660288Z","caller":"traceutil/trace.go:171","msg":"trace[1398276499] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:558; }","duration":"154.621217ms","start":"2026-05-08T10:22:20.505649Z","end":"2026-05-08T10:22:20.66027Z","steps":["trace[1398276499] 'read index received' (duration: 110.507589ms)","trace[1398276499] 'applied index is now lower than readState.Index' (duration: 44.112508ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:20.660398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.749199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T10:22:20.660533Z","caller":"traceutil/trace.go:171","msg":"trace[201494661] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:544; }","duration":"154.823911ms","start":"2026-05-08T10:22:20.505589Z","end":"2026-05-08T10:22:20.660413Z","steps":["trace[201494661] 'agreement among raft nodes before linearized reading' (duration: 154.749009ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.660618Z","caller":"traceutil/trace.go:171","msg":"trace[261115034] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"244.113189ms","start":"2026-05-08T10:22:20.416479Z","end":"2026-05-08T10:22:20.660592Z","steps":["trace[261115034] 'process raft request' (duration: 243.669329ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:20.660658Z","caller":"traceutil/trace.go:171","msg":"trace[283717026] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"287.177024ms","start":"2026-05-08T10:22:20.373454Z","end":"2026-05-08T10:22:20.660631Z","steps":["trace[283717026] 'process raft request' (duration: 286.593001ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:21.004232Z","caller":"traceutil/trace.go:171","msg":"trace[1056846508] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"210.711398ms","start":"2026-05-08T10:22:20.793493Z","end":"2026-05-08T10:22:21.004204Z","steps":["trace[1056846508] 'process raft request' (duration: 192.24562ms)","trace[1056846508] 'compare' (duration: 18.238323ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:21.004366Z","caller":"traceutil/trace.go:171","msg":"trace[1005643943] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"201.857192ms","start":"2026-05-08T10:22:20.802484Z","end":"2026-05-08T10:22:21.004342Z","steps":["trace[1005643943] 'process raft request' (duration: 201.665208ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:21.123796Z","caller":"traceutil/trace.go:171","msg":"trace[1077333589] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"279.844688ms","start":"2026-05-08T10:22:20.843926Z","end":"2026-05-08T10:22:21.123771Z","steps":["trace[1077333589] 'process raft request' (duration: 279.277866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:21.662097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.70953ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:22:21.662305Z","caller":"traceutil/trace.go:171","msg":"trace[2088799357] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"633.159746ms","start":"2026-05-08T10:22:21.029119Z","end":"2026-05-08T10:22:21.662279Z","steps":["trace[2088799357] 'process raft request' (duration: 633.081084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:21.662409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.029095Z","time spent":"633.274899ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:22:21.663094Z","caller":"traceutil/trace.go:171","msg":"trace[23690267] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"635.235782ms","start":"2026-05-08T10:22:21.027838Z","end":"2026-05-08T10:22:21.663074Z","steps":["trace[23690267] 'process raft request' (duration: 205.475108ms)","trace[23690267] 'compare' (duration: 428.579038ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:21.663372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.027804Z","time spent":"635.520959ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:21.725343Z","caller":"traceutil/trace.go:171","msg":"trace[1657263528] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"593.897077ms","start":"2026-05-08T10:22:21.13139Z","end":"2026-05-08T10:22:21.725287Z","steps":["trace[1657263528] 'process raft request' (duration: 593.691972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:21.725567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.131374Z","time spent":"594.077271ms","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:24.15561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.724335Z","time spent":"1.431269283s","remote":"127.0.0.1:58522","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-08T10:22:24.156511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.620555421s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:22:24.156618Z","caller":"traceutil/trace.go:171","msg":"trace[869496929] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"2.451241909s","start":"2026-05-08T10:22:21.705357Z","end":"2026-05-08T10:22:24.156599Z","steps":["trace[869496929] 'process raft request' (duration: 830.510554ms)","trace[869496929] 'compare' (duration: 1.61962288s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:24.156677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.705339Z","time spent":"2.45131056s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65190,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:24.157224Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.38228126s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:22:24.158314Z","caller":"traceutil/trace.go:171","msg":"trace[31903212] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:576; }","duration":"1.911805691s","start":"2026-05-08T10:22:22.246498Z","end":"2026-05-08T10:22:24.158303Z","steps":["trace[31903212] 'read index received' (duration: 290.058744ms)","trace[31903212] 'applied index is now lower than readState.Index' (duration: 1.621746317s)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:24.158741Z","caller":"traceutil/trace.go:171","msg":"trace[843815644] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"2.413421041s","start":"2026-05-08T10:22:21.745312Z","end":"2026-05-08T10:22:24.158733Z","steps":["trace[843815644] 'process raft request' (duration: 2.412071872s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.15881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.745287Z","time spent":"2.413475262s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:24.158915Z","caller":"traceutil/trace.go:171","msg":"trace[925743502] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"2.166942075s","start":"2026-05-08T10:22:21.991967Z","end":"2026-05-08T10:22:24.158909Z","steps":["trace[925743502] 'process raft request' (duration: 2.166033954s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.158949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:21.991935Z","time spent":"2.166999047s","remote":"127.0.0.1:35236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:22:24.159034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912537418s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:24.159057Z","caller":"traceutil/trace.go:171","msg":"trace[1272860771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"1.912590869s","start":"2026-05-08T10:22:22.24646Z","end":"2026-05-08T10:22:24.159051Z","steps":["trace[1272860771] 'agreement among raft nodes before linearized reading' (duration: 1.912555068s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.159075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.24644Z","time spent":"1.912630379s","remote":"127.0.0.1:35150","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-05-08T10:22:24.210474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849532993s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T10:22:24.210494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.848675994s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-08T10:22:24.210496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849622624s","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-05-08T10:22:24.210543Z","caller":"traceutil/trace.go:171","msg":"trace[1375031007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:562; }","duration":"1.849651015s","start":"2026-05-08T10:22:22.360876Z","end":"2026-05-08T10:22:24.210527Z","steps":["trace[1375031007] 'agreement among raft nodes before linearized reading' (duration: 1.849461971s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:24.21055Z","caller":"traceutil/trace.go:171","msg":"trace[414372489] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"1.848760086s","start":"2026-05-08T10:22:22.361775Z","end":"2026-05-08T10:22:24.210535Z","steps":["trace[414372489] 'agreement among raft nodes before linearized reading' (duration: 1.848554501s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:24.210559Z","caller":"traceutil/trace.go:171","msg":"trace[1070082850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:562; }","duration":"1.849693606s","start":"2026-05-08T10:22:22.36085Z","end":"2026-05-08T10:22:24.210544Z","steps":["trace[1070082850] 'agreement among raft nodes before linearized reading' (duration: 1.849498901s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.21056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849973031s","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-05-08T10:22:24.210603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.360793Z","time spent":"1.849802958s","remote":"127.0.0.1:35478","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-05-08T10:22:24.210636Z","caller":"traceutil/trace.go:171","msg":"trace[1543134735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:562; }","duration":"1.850098054s","start":"2026-05-08T10:22:22.360518Z","end":"2026-05-08T10:22:24.210616Z","steps":["trace[1543134735] 'agreement among raft nodes before linearized reading' (duration: 1.84988203s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.210577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.361768Z","time spent":"1.848803826s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T10:22:24.210675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.360498Z","time spent":"1.850170536s","remote":"127.0.0.1:35478","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-05-08T10:22:24.210679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:22.360856Z","time spent":"1.849812598s","remote":"127.0.0.1:35478","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-05-08T10:22:24.210718Z","caller":"traceutil/trace.go:171","msg":"trace[859693813] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"523.22711ms","start":"2026-05-08T10:22:23.687482Z","end":"2026-05-08T10:22:24.210709Z","steps":["trace[859693813] 'process raft request' (duration: 522.681448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:24.210841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:23.687459Z","time spent":"523.279941ms","remote":"127.0.0.1:35478","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-05-08T10:22:24.318083Z","caller":"traceutil/trace.go:171","msg":"trace[560043645] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"102.749888ms","start":"2026-05-08T10:22:24.215311Z","end":"2026-05-08T10:22:24.318061Z","steps":["trace[560043645] 'process raft request' (duration: 102.693817ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:24.318114Z","caller":"traceutil/trace.go:171","msg":"trace[516289803] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"102.853721ms","start":"2026-05-08T10:22:24.215235Z","end":"2026-05-08T10:22:24.318089Z","steps":["trace[516289803] 'process raft request' (duration: 51.62594ms)","trace[516289803] 'compare' (duration: 51.010366ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:24.318325Z","caller":"traceutil/trace.go:171","msg":"trace[773493791] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"102.961673ms","start":"2026-05-08T10:22:24.215348Z","end":"2026-05-08T10:22:24.31831Z","steps":["trace[773493791] 'process raft request' (duration: 102.697347ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:24.318682Z","caller":"traceutil/trace.go:171","msg":"trace[941390649] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"103.29001ms","start":"2026-05-08T10:22:24.215379Z","end":"2026-05-08T10:22:24.318669Z","steps":["trace[941390649] 'process raft request' (duration: 102.892881ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:24.502957Z","caller":"traceutil/trace.go:171","msg":"trace[1547381330] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"203.126844ms","start":"2026-05-08T10:22:24.29981Z","end":"2026-05-08T10:22:24.502936Z","steps":["trace[1547381330] 'process raft request' (duration: 149.153603ms)","trace[1547381330] 'compare' (duration: 53.860139ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:24.704214Z","caller":"traceutil/trace.go:171","msg":"trace[316436060] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"110.087371ms","start":"2026-05-08T10:22:24.594106Z","end":"2026-05-08T10:22:24.704194Z","steps":["trace[316436060] 'process raft request' (duration: 107.719638ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:29.048389Z","caller":"traceutil/trace.go:171","msg":"trace[1189855805] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"698.00368ms","start":"2026-05-08T10:22:28.350359Z","end":"2026-05-08T10:22:29.048363Z","steps":["trace[1189855805] 'process raft request' (duration: 697.836686ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:29.048538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:28.350351Z","time spent":"698.115592ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:29.173919Z","caller":"traceutil/trace.go:171","msg":"trace[720163776] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:612; }","duration":"195.556171ms","start":"2026-05-08T10:22:28.978341Z","end":"2026-05-08T10:22:29.173897Z","steps":["trace[720163776] 'read index received' (duration: 69.869067ms)","trace[720163776] 'applied index is now lower than readState.Index' (duration: 125.686104ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:29.173983Z","caller":"traceutil/trace.go:171","msg":"trace[455942601] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"822.749373ms","start":"2026-05-08T10:22:28.351202Z","end":"2026-05-08T10:22:29.173952Z","steps":["trace[455942601] 'process raft request' (duration: 817.695782ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:29.174067Z","caller":"traceutil/trace.go:171","msg":"trace[654198208] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"822.477898ms","start":"2026-05-08T10:22:28.351581Z","end":"2026-05-08T10:22:29.174059Z","steps":["trace[654198208] 'process raft request' (duration: 822.281273ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:29.173993Z","caller":"traceutil/trace.go:171","msg":"trace[1626802890] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"822.54973ms","start":"2026-05-08T10:22:28.351419Z","end":"2026-05-08T10:22:29.173969Z","steps":["trace[1626802890] 'process raft request' (duration: 822.399637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:29.174833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:28.351572Z","time spent":"823.151942ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:29.175128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:28.35141Z","time spent":"823.619753ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:29.174271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:28.351151Z","time spent":"822.958758ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:29.174639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.237076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:29.175385Z","caller":"traceutil/trace.go:171","msg":"trace[1996156978] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:597; }","duration":"197.072884ms","start":"2026-05-08T10:22:28.978289Z","end":"2026-05-08T10:22:29.175361Z","steps":["trace[1996156978] 'agreement among raft nodes before linearized reading' (duration: 196.210865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.613864Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310396995,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:30.853027Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.243455471s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:22:30.853882Z","caller":"traceutil/trace.go:171","msg":"trace[299802623] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.249852841s","start":"2026-05-08T10:22:29.60398Z","end":"2026-05-08T10:22:30.853832Z","steps":["trace[299802623] 'process raft request' (duration: 1.249573525s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.853997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:29.603942Z","time spent":"1.249977914s","remote":"127.0.0.1:35298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:22:30.915066Z","caller":"traceutil/trace.go:171","msg":"trace[2087220579] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"802.260019ms","start":"2026-05-08T10:22:30.112778Z","end":"2026-05-08T10:22:30.915038Z","steps":["trace[2087220579] 'read index received' (duration: 740.520092ms)","trace[2087220579] 'applied index is now lower than readState.Index' (duration: 61.738967ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:30.915377Z","caller":"traceutil/trace.go:171","msg":"trace[130014821] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"385.721696ms","start":"2026-05-08T10:22:30.529614Z","end":"2026-05-08T10:22:30.915335Z","steps":["trace[130014821] 'process raft request' (duration: 385.291257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.915438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.730949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:30.915519Z","caller":"traceutil/trace.go:171","msg":"trace[109594573] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:605; }","duration":"670.837651ms","start":"2026-05-08T10:22:30.244647Z","end":"2026-05-08T10:22:30.915484Z","steps":["trace[109594573] 'agreement among raft nodes before linearized reading' (duration: 670.723959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.915542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.529589Z","time spent":"385.874219ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:30.915632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.755489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qb76f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-08T10:22:30.915724Z","caller":"traceutil/trace.go:171","msg":"trace[165530996] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qb76f; range_end:; response_count:1; response_revision:605; }","duration":"802.947193ms","start":"2026-05-08T10:22:30.112762Z","end":"2026-05-08T10:22:30.915709Z","steps":["trace[165530996] 'agreement among raft nodes before linearized reading' (duration: 802.556145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.915561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.24463Z","time spent":"670.923233ms","remote":"127.0.0.1:35138","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-05-08T10:22:30.915676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.165764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-05-08T10:22:30.91585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.112696Z","time spent":"803.093498ms","remote":"127.0.0.1:35400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-qb76f\" "} {"level":"info","ts":"2026-05-08T10:22:30.915902Z","caller":"traceutil/trace.go:171","msg":"trace[1986598770] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:605; }","duration":"410.408019ms","start":"2026-05-08T10:22:30.505476Z","end":"2026-05-08T10:22:30.915884Z","steps":["trace[1986598770] 'agreement among raft nodes before linearized reading' (duration: 410.104442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:30.916011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.505458Z","time spent":"410.538183ms","remote":"127.0.0.1:35208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.143\" "} {"level":"warn","ts":"2026-05-08T10:22:33.183699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.228666462s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-08T10:22:33.183877Z","caller":"traceutil/trace.go:171","msg":"trace[1904801435] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"2.264665892s","start":"2026-05-08T10:22:30.919191Z","end":"2026-05-08T10:22:33.183857Z","steps":["trace[1904801435] 'read index received' (duration: 35.931949ms)","trace[1904801435] 'applied index is now lower than readState.Index' (duration: 2.228731783s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:33.183957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.917216Z","time spent":"2.266737348s","remote":"127.0.0.1:35208","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-08T10:22:33.184175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.26498217s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:22:33.18421Z","caller":"traceutil/trace.go:171","msg":"trace[2132841164] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:605; }","duration":"2.265055691s","start":"2026-05-08T10:22:30.919142Z","end":"2026-05-08T10:22:33.184198Z","steps":["trace[2132841164] 'agreement among raft nodes before linearized reading' (duration: 2.2649881s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:33.184241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.91913Z","time spent":"2.265103842s","remote":"127.0.0.1:35424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-08T10:22:33.243755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000928668s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-08T10:22:33.243961Z","caller":"traceutil/trace.go:171","msg":"trace[190418211] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001337198s","start":"2026-05-08T10:22:31.242547Z","end":"2026-05-08T10:22:33.243884Z","steps":["trace[190418211] 'agreement among raft nodes before linearized reading' (duration: 2.000952009s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:33.244065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:31.242537Z","time spent":"2.001507522s","remote":"127.0.0.1:35150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/08 10:22:33 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-08T10:22:33.684854Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310397003,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:34.185753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310397003,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:22:34.462583Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.506956608s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-08T10:22:34.675849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.969726ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:22:34.675978Z","caller":"traceutil/trace.go:171","msg":"trace[335527327] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"3.747173952s","start":"2026-05-08T10:22:30.928784Z","end":"2026-05-08T10:22:34.675958Z","steps":["trace[335527327] 'process raft request' (duration: 3.533964971s)","trace[335527327] 'compare' (duration: 212.368292ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:34.676099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:30.928763Z","time spent":"3.747295985s","remote":"127.0.0.1:35400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:34.766137Z","caller":"traceutil/trace.go:171","msg":"trace[1600914681] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.580775812s","start":"2026-05-08T10:22:33.185323Z","end":"2026-05-08T10:22:34.766098Z","steps":["trace[1600914681] 'process raft request' (duration: 1.580461025s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:34.766324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:33.185302Z","time spent":"1.580925625s","remote":"127.0.0.1:35208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:34.767884Z","caller":"traceutil/trace.go:171","msg":"trace[761711725] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.174280592s","start":"2026-05-08T10:22:33.593583Z","end":"2026-05-08T10:22:34.767863Z","steps":["trace[761711725] 'process raft request' (duration: 1.1728512s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:34.769474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:33.593554Z","time spent":"1.174402924s","remote":"127.0.0.1:35298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:34.769525Z","caller":"traceutil/trace.go:171","msg":"trace[256608243] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:625; }","duration":"1.585535047s","start":"2026-05-08T10:22:33.183908Z","end":"2026-05-08T10:22:34.769443Z","steps":["trace[256608243] 'read index received' (duration: 1.27891905s)","trace[256608243] 'applied index is now lower than readState.Index' (duration: 306.609487ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:34.773536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.592797616s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T10:22:34.773628Z","caller":"traceutil/trace.go:171","msg":"trace[119924125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"3.592913529s","start":"2026-05-08T10:22:31.180687Z","end":"2026-05-08T10:22:34.773601Z","steps":["trace[119924125] 'agreement among raft nodes before linearized reading' (duration: 3.589551045s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:34.773717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:31.180666Z","time spent":"3.593003621s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T10:22:34.775343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.595634948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:22:34.775397Z","caller":"traceutil/trace.go:171","msg":"trace[342786373] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:609; }","duration":"3.59570926s","start":"2026-05-08T10:22:31.179672Z","end":"2026-05-08T10:22:34.775381Z","steps":["trace[342786373] 'agreement among raft nodes before linearized reading' (duration: 3.592559521s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:34.775402Z","caller":"traceutil/trace.go:171","msg":"trace[1807133875] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"319.444718ms","start":"2026-05-08T10:22:34.454366Z","end":"2026-05-08T10:22:34.773811Z","steps":["trace[1807133875] 'process raft request' (duration: 313.440566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:34.775528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:34.454343Z","time spent":"321.122765ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:34.77543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:31.179665Z","time spent":"3.595756921s","remote":"127.0.0.1:35478","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-05-08T10:22:34.775343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.721551643s","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-05-08T10:22:34.775747Z","caller":"traceutil/trace.go:171","msg":"trace[592043218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"3.721964331s","start":"2026-05-08T10:22:31.053772Z","end":"2026-05-08T10:22:34.775737Z","steps":["trace[592043218] 'agreement among raft nodes before linearized reading' (duration: 3.716559683s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:34.775774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:31.053713Z","time spent":"3.722052433s","remote":"127.0.0.1:35478","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-05-08T10:22:34.839915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.49405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qb76f\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-05-08T10:22:34.839999Z","caller":"traceutil/trace.go:171","msg":"trace[1425886557] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qb76f; range_end:; response_count:1; response_revision:609; }","duration":"157.615693ms","start":"2026-05-08T10:22:34.682364Z","end":"2026-05-08T10:22:34.83998Z","steps":["trace[1425886557] 'agreement among raft nodes before linearized reading' (duration: 91.356412ms)","trace[1425886557] 'range keys from in-memory index tree' (duration: 64.603555ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:34.840052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.660644532s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T10:22:34.840245Z","caller":"traceutil/trace.go:171","msg":"trace[1847567972] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"3.660896487s","start":"2026-05-08T10:22:31.179322Z","end":"2026-05-08T10:22:34.840218Z","steps":["trace[1847567972] 'agreement among raft nodes before linearized reading' (duration: 3.59434763s)","trace[1847567972] 'range keys from in-memory index tree' (duration: 64.37188ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:34.84029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.596580278s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:22:34.840296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:31.179288Z","time spent":"3.660996119s","remote":"127.0.0.1:35478","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-05-08T10:22:34.840323Z","caller":"traceutil/trace.go:171","msg":"trace[983724663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"1.59666415s","start":"2026-05-08T10:22:33.243648Z","end":"2026-05-08T10:22:34.840312Z","steps":["trace[983724663] 'agreement among raft nodes before linearized reading' (duration: 1.530069182s)","trace[983724663] 'range keys from in-memory index tree' (duration: 65.033744ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:34.840353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:33.243611Z","time spent":"1.596734112s","remote":"127.0.0.1:35138","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-05-08T10:22:35.388789Z","caller":"traceutil/trace.go:171","msg":"trace[1168597792] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"144.281248ms","start":"2026-05-08T10:22:35.244485Z","end":"2026-05-08T10:22:35.388766Z","steps":["trace[1168597792] 'process raft request' (duration: 142.413718ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:36.930536Z","caller":"traceutil/trace.go:171","msg":"trace[1142271605] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"563.040626ms","start":"2026-05-08T10:22:36.367451Z","end":"2026-05-08T10:22:36.930492Z","steps":["trace[1142271605] 'process raft request' (duration: 555.44701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:36.930841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:36.367398Z","time spent":"563.245431ms","remote":"127.0.0.1:35298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:47.283075Z","caller":"traceutil/trace.go:171","msg":"trace[898287557] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"103.57766ms","start":"2026-05-08T10:22:47.17945Z","end":"2026-05-08T10:22:47.283028Z","steps":["trace[898287557] 'process raft request' (duration: 103.277383ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:50.483704Z","caller":"traceutil/trace.go:171","msg":"trace[399610491] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"114.637425ms","start":"2026-05-08T10:22:50.369036Z","end":"2026-05-08T10:22:50.483673Z","steps":["trace[399610491] 'process raft request' (duration: 114.524073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.625549Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.581023941s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:22:52.626045Z","caller":"traceutil/trace.go:171","msg":"trace[1557668265] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"1.581568203s","start":"2026-05-08T10:22:51.044454Z","end":"2026-05-08T10:22:52.626022Z","steps":["trace[1557668265] 'read index received' (duration: 38.901µs)","trace[1557668265] 'applied index is now lower than readState.Index' (duration: 1.581528282s)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:22:52.626327Z","caller":"traceutil/trace.go:171","msg":"trace[1683641541] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"1.58188076s","start":"2026-05-08T10:22:51.044437Z","end":"2026-05-08T10:22:52.626318Z","steps":["trace[1683641541] 'process raft request' (duration: 1.581333728s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.626485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.044419Z","time spent":"1.581940941s","remote":"127.0.0.1:35478","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-05-08T10:22:52.626652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.582165167s","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-05-08T10:22:52.626745Z","caller":"traceutil/trace.go:171","msg":"trace[1309992246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"1.582308879s","start":"2026-05-08T10:22:51.044417Z","end":"2026-05-08T10:22:52.626726Z","steps":["trace[1309992246] 'agreement among raft nodes before linearized reading' (duration: 1.582035764s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.626825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.044382Z","time spent":"1.582433242s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T10:22:52.733317Z","caller":"traceutil/trace.go:171","msg":"trace[982461901] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"1.686005175s","start":"2026-05-08T10:22:51.047289Z","end":"2026-05-08T10:22:52.733294Z","steps":["trace[982461901] 'process raft request' (duration: 1.685820001s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:22:52.73344Z","caller":"traceutil/trace.go:171","msg":"trace[2010997941] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:810; }","duration":"107.319145ms","start":"2026-05-08T10:22:52.626092Z","end":"2026-05-08T10:22:52.733411Z","steps":["trace[2010997941] 'read index received' (duration: 106.978988ms)","trace[2010997941] 'applied index is now lower than readState.Index' (duration: 338.587µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:22:52.733481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.047273Z","time spent":"1.686116688s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:22:52.733518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026499736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:22:52.733608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.683913581s","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-05-08T10:22:52.733639Z","caller":"traceutil/trace.go:171","msg":"trace[528811344] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.683983162s","start":"2026-05-08T10:22:51.049649Z","end":"2026-05-08T10:22:52.733632Z","steps":["trace[528811344] 'agreement among raft nodes before linearized reading' (duration: 1.683846099s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.733663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.049637Z","time spent":"1.684020652s","remote":"127.0.0.1:35478","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":"info","ts":"2026-05-08T10:22:52.733668Z","caller":"traceutil/trace.go:171","msg":"trace[966445005] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"1.642522234s","start":"2026-05-08T10:22:51.091138Z","end":"2026-05-08T10:22:52.733661Z","steps":["trace[966445005] 'process raft request' (duration: 1.642115776s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.733783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.439849612s","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-05-08T10:22:52.733805Z","caller":"traceutil/trace.go:171","msg":"trace[1147107134] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:786; }","duration":"1.439914013s","start":"2026-05-08T10:22:51.293886Z","end":"2026-05-08T10:22:52.7338Z","steps":["trace[1147107134] 'agreement among raft nodes before linearized reading' (duration: 1.439856222s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.733822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.293856Z","time spent":"1.439961823s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T10:22:52.733895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.479352677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:22:52.733918Z","caller":"traceutil/trace.go:171","msg":"trace[1482186942] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:786; }","duration":"1.479415849s","start":"2026-05-08T10:22:51.254498Z","end":"2026-05-08T10:22:52.733913Z","steps":["trace[1482186942] 'agreement among raft nodes before linearized reading' (duration: 1.479377258s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.733937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.254479Z","time spent":"1.47945169s","remote":"127.0.0.1:35582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-05-08T10:22:52.733575Z","caller":"traceutil/trace.go:171","msg":"trace[705670198] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:786; }","duration":"1.026569717s","start":"2026-05-08T10:22:51.706992Z","end":"2026-05-08T10:22:52.733562Z","steps":["trace[705670198] 'agreement among raft nodes before linearized reading' (duration: 1.026460775s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.734014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.706941Z","time spent":"1.027062097s","remote":"127.0.0.1:35430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:22:52.734182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.509696545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pxr88\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-08T10:22:52.734274Z","caller":"traceutil/trace.go:171","msg":"trace[1397115253] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pxr88; range_end:; response_count:1; response_revision:786; }","duration":"1.509828848s","start":"2026-05-08T10:22:51.224418Z","end":"2026-05-08T10:22:52.734247Z","steps":["trace[1397115253] 'agreement among raft nodes before linearized reading' (duration: 1.509570802s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.734354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.224395Z","time spent":"1.509943751s","remote":"127.0.0.1:35400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pxr88\" "} {"level":"warn","ts":"2026-05-08T10:22:52.734506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.885729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:22:52.733885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:51.091116Z","time spent":"1.642605405s","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:22:52.734641Z","caller":"traceutil/trace.go:171","msg":"trace[2137127777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"490.313529ms","start":"2026-05-08T10:22:52.244307Z","end":"2026-05-08T10:22:52.73462Z","steps":["trace[2137127777] 'agreement among raft nodes before linearized reading' (duration: 489.882869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:22:52.735126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:22:52.244288Z","time spent":"490.82709ms","remote":"127.0.0.1:35150","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-05-08T10:22:52.735567Z","caller":"traceutil/trace.go:171","msg":"trace[296314761] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"103.135302ms","start":"2026-05-08T10:22:52.632413Z","end":"2026-05-08T10:22:52.735548Z","steps":["trace[296314761] 'process raft request' (duration: 103.02847ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:00.387174Z","caller":"traceutil/trace.go:171","msg":"trace[1334023165] linearizableReadLoop","detail":"{readStateIndex:890; appliedIndex:889; }","duration":"140.207524ms","start":"2026-05-08T10:23:00.246948Z","end":"2026-05-08T10:23:00.387155Z","steps":["trace[1334023165] 'read index received' (duration: 140.096051ms)","trace[1334023165] 'applied index is now lower than readState.Index' (duration: 110.753µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:00.387203Z","caller":"traceutil/trace.go:171","msg":"trace[100735419] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"180.660977ms","start":"2026-05-08T10:23:00.206529Z","end":"2026-05-08T10:23:00.38719Z","steps":["trace[100735419] 'process raft request' (duration: 180.513894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:00.387284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.326237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:23:00.387307Z","caller":"traceutil/trace.go:171","msg":"trace[651652571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:863; }","duration":"140.388398ms","start":"2026-05-08T10:23:00.246912Z","end":"2026-05-08T10:23:00.3873Z","steps":["trace[651652571] 'agreement among raft nodes before linearized reading' (duration: 140.318446ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:00.465074Z","caller":"traceutil/trace.go:171","msg":"trace[689391313] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"135.126325ms","start":"2026-05-08T10:23:00.329929Z","end":"2026-05-08T10:23:00.465055Z","steps":["trace[689391313] 'process raft request' (duration: 135.031143ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:01.689033Z","caller":"traceutil/trace.go:171","msg":"trace[937713670] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"175.263468ms","start":"2026-05-08T10:23:01.51375Z","end":"2026-05-08T10:23:01.689014Z","steps":["trace[937713670] 'process raft request' (duration: 175.159366ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:02.549127Z","caller":"traceutil/trace.go:171","msg":"trace[24276581] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:901; }","duration":"167.326965ms","start":"2026-05-08T10:23:02.381776Z","end":"2026-05-08T10:23:02.549103Z","steps":["trace[24276581] 'read index received' (duration: 166.629069ms)","trace[24276581] 'applied index is now lower than readState.Index' (duration: 696.676µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:02.549407Z","caller":"traceutil/trace.go:171","msg":"trace[571899131] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"280.72897ms","start":"2026-05-08T10:23:02.268441Z","end":"2026-05-08T10:23:02.54917Z","steps":["trace[571899131] 'process raft request' (duration: 279.928602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:02.550268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.402748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:23:02.550328Z","caller":"traceutil/trace.go:171","msg":"trace[1271578391] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:874; }","duration":"168.613123ms","start":"2026-05-08T10:23:02.381698Z","end":"2026-05-08T10:23:02.550311Z","steps":["trace[1271578391] 'agreement among raft nodes before linearized reading' (duration: 167.591971ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:03.76622Z","caller":"traceutil/trace.go:171","msg":"trace[1104874124] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"219.542318ms","start":"2026-05-08T10:23:03.546645Z","end":"2026-05-08T10:23:03.766188Z","steps":["trace[1104874124] 'process raft request' (duration: 219.300443ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:03.766333Z","caller":"traceutil/trace.go:171","msg":"trace[379173671] transaction","detail":"{read_only:false; response_revision:901; number_of_response:1; }","duration":"221.403388ms","start":"2026-05-08T10:23:03.544895Z","end":"2026-05-08T10:23:03.766298Z","steps":["trace[379173671] 'process raft request' (duration: 220.139041ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:03.766234Z","caller":"traceutil/trace.go:171","msg":"trace[943706280] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"218.988976ms","start":"2026-05-08T10:23:03.547219Z","end":"2026-05-08T10:23:03.766208Z","steps":["trace[943706280] 'process raft request' (duration: 218.823392ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:03.76686Z","caller":"traceutil/trace.go:171","msg":"trace[1758947796] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"219.1759ms","start":"2026-05-08T10:23:03.547662Z","end":"2026-05-08T10:23:03.766838Z","steps":["trace[1758947796] 'process raft request' (duration: 218.438474ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:03.767006Z","caller":"traceutil/trace.go:171","msg":"trace[772474137] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:927; }","duration":"220.816236ms","start":"2026-05-08T10:23:03.546137Z","end":"2026-05-08T10:23:03.766954Z","steps":["trace[772474137] 'read index received' (duration: 50.965498ms)","trace[772474137] 'applied index is now lower than readState.Index' (duration: 169.849578ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:03.767119Z","caller":"traceutil/trace.go:171","msg":"trace[844577631] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"219.138459ms","start":"2026-05-08T10:23:03.547967Z","end":"2026-05-08T10:23:03.767105Z","steps":["trace[844577631] 'process raft request' (duration: 218.175158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:03.767514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.353038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-kwwh9\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-05-08T10:23:03.767571Z","caller":"traceutil/trace.go:171","msg":"trace[1826901396] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-kwwh9; range_end:; response_count:1; response_revision:905; }","duration":"221.44168ms","start":"2026-05-08T10:23:03.546112Z","end":"2026-05-08T10:23:03.767554Z","steps":["trace[1826901396] 'agreement among raft nodes before linearized reading' (duration: 221.211444ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.082327Z","caller":"traceutil/trace.go:171","msg":"trace[1904702747] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"138.286728ms","start":"2026-05-08T10:23:03.944018Z","end":"2026-05-08T10:23:04.082305Z","steps":["trace[1904702747] 'process raft request' (duration: 132.791829ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.082645Z","caller":"traceutil/trace.go:171","msg":"trace[195795739] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"134.754011ms","start":"2026-05-08T10:23:03.947869Z","end":"2026-05-08T10:23:04.082623Z","steps":["trace[195795739] 'process raft request' (duration: 134.047466ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.32472Z","caller":"traceutil/trace.go:171","msg":"trace[777646005] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"138.417629ms","start":"2026-05-08T10:23:04.186267Z","end":"2026-05-08T10:23:04.324684Z","steps":["trace[777646005] 'process raft request' (duration: 61.637877ms)","trace[777646005] 'compare' (duration: 76.546657ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:04.662755Z","caller":"traceutil/trace.go:171","msg":"trace[1010744028] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"234.342185ms","start":"2026-05-08T10:23:04.428387Z","end":"2026-05-08T10:23:04.662729Z","steps":["trace[1010744028] 'process raft request' (duration: 234.011518ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.970535Z","caller":"traceutil/trace.go:171","msg":"trace[210361566] linearizableReadLoop","detail":"{readStateIndex:947; appliedIndex:946; }","duration":"302.829928ms","start":"2026-05-08T10:23:04.667678Z","end":"2026-05-08T10:23:04.970508Z","steps":["trace[210361566] 'read index received' (duration: 288.096192ms)","trace[210361566] 'applied index is now lower than readState.Index' (duration: 14.732656ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:04.970684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.983402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:23:04.970731Z","caller":"traceutil/trace.go:171","msg":"trace[368099373] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:919; }","duration":"303.091374ms","start":"2026-05-08T10:23:04.667627Z","end":"2026-05-08T10:23:04.970719Z","steps":["trace[368099373] 'agreement among raft nodes before linearized reading' (duration: 303.003912ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.97068Z","caller":"traceutil/trace.go:171","msg":"trace[254990504] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"537.563052ms","start":"2026-05-08T10:23:04.433046Z","end":"2026-05-08T10:23:04.970609Z","steps":["trace[254990504] 'process raft request' (duration: 522.713792ms)","trace[254990504] 'compare' (duration: 14.625825ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:04.970766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:04.667607Z","time spent":"303.150546ms","remote":"127.0.0.1:35346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" "} {"level":"warn","ts":"2026-05-08T10:23:04.971005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:04.433036Z","time spent":"537.737625ms","remote":"127.0.0.1:35298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12740,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:23:04.994705Z","caller":"traceutil/trace.go:171","msg":"trace[841373278] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"326.786445ms","start":"2026-05-08T10:23:04.667887Z","end":"2026-05-08T10:23:04.994674Z","steps":["trace[841373278] 'process raft request' (duration: 326.551719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:04.994867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:04.667871Z","time spent":"326.905647ms","remote":"127.0.0.1:35270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:23:04.99503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.416037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T10:23:04.99514Z","caller":"traceutil/trace.go:171","msg":"trace[1618621606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:921; }","duration":"234.565299ms","start":"2026-05-08T10:23:04.760556Z","end":"2026-05-08T10:23:04.995122Z","steps":["trace[1618621606] 'agreement among raft nodes before linearized reading' (duration: 234.13477ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:04.995232Z","caller":"traceutil/trace.go:171","msg":"trace[1745337384] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"326.014709ms","start":"2026-05-08T10:23:04.669165Z","end":"2026-05-08T10:23:04.99518Z","steps":["trace[1745337384] 'process raft request' (duration: 325.422536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:04.995402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:23:04.669158Z","time spent":"326.143061ms","remote":"127.0.0.1:35662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3371,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:23:04.99559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.522554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:23:04.9958Z","caller":"traceutil/trace.go:171","msg":"trace[658030383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:921; }","duration":"113.757419ms","start":"2026-05-08T10:23:04.881916Z","end":"2026-05-08T10:23:04.995673Z","steps":["trace[658030383] 'agreement among raft nodes before linearized reading' (duration: 113.184267ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.125103Z","caller":"traceutil/trace.go:171","msg":"trace[1850422764] linearizableReadLoop","detail":"{readStateIndex:950; appliedIndex:949; }","duration":"125.086891ms","start":"2026-05-08T10:23:04.999988Z","end":"2026-05-08T10:23:05.125075Z","steps":["trace[1850422764] 'read index received' (duration: 124.602051ms)","trace[1850422764] 'applied index is now lower than readState.Index' (duration: 483.53µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:05.1252Z","caller":"traceutil/trace.go:171","msg":"trace[1211104889] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"152.271617ms","start":"2026-05-08T10:23:04.972902Z","end":"2026-05-08T10:23:05.125174Z","steps":["trace[1211104889] 'process raft request' (duration: 151.640503ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:05.125417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.397989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3386"} {"level":"info","ts":"2026-05-08T10:23:05.125466Z","caller":"traceutil/trace.go:171","msg":"trace[1515456664] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:922; }","duration":"125.4852ms","start":"2026-05-08T10:23:04.999967Z","end":"2026-05-08T10:23:05.125452Z","steps":["trace[1515456664] 'agreement among raft nodes before linearized reading' (duration: 125.237735ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.128479Z","caller":"traceutil/trace.go:171","msg":"trace[957801158] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"128.30047ms","start":"2026-05-08T10:23:05.000158Z","end":"2026-05-08T10:23:05.128459Z","steps":["trace[957801158] 'process raft request' (duration: 128.244659ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.128498Z","caller":"traceutil/trace.go:171","msg":"trace[1562787241] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"128.413592ms","start":"2026-05-08T10:23:05.000064Z","end":"2026-05-08T10:23:05.128477Z","steps":["trace[1562787241] 'process raft request' (duration: 128.201248ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.128597Z","caller":"traceutil/trace.go:171","msg":"trace[291451760] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"128.371501ms","start":"2026-05-08T10:23:05.000135Z","end":"2026-05-08T10:23:05.128507Z","steps":["trace[291451760] 'process raft request' (duration: 128.238918ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.128741Z","caller":"traceutil/trace.go:171","msg":"trace[2112602788] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"127.545684ms","start":"2026-05-08T10:23:05.001185Z","end":"2026-05-08T10:23:05.128731Z","steps":["trace[2112602788] 'process raft request' (duration: 127.248958ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.128815Z","caller":"traceutil/trace.go:171","msg":"trace[1981309081] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"127.576274ms","start":"2026-05-08T10:23:05.001233Z","end":"2026-05-08T10:23:05.128809Z","steps":["trace[1981309081] 'process raft request' (duration: 127.426941ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.253959Z","caller":"traceutil/trace.go:171","msg":"trace[1228152746] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"121.124226ms","start":"2026-05-08T10:23:05.132812Z","end":"2026-05-08T10:23:05.253936Z","steps":["trace[1228152746] 'process raft request' (duration: 121.045664ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.253956Z","caller":"traceutil/trace.go:171","msg":"trace[887705165] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"123.284542ms","start":"2026-05-08T10:23:05.13062Z","end":"2026-05-08T10:23:05.253904Z","steps":["trace[887705165] 'process raft request' (duration: 123.055607ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.254112Z","caller":"traceutil/trace.go:171","msg":"trace[933012505] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"121.300489ms","start":"2026-05-08T10:23:05.13278Z","end":"2026-05-08T10:23:05.25408Z","steps":["trace[933012505] 'process raft request' (duration: 121.022363ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:05.388314Z","caller":"traceutil/trace.go:171","msg":"trace[793825456] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"127.590794ms","start":"2026-05-08T10:23:05.260692Z","end":"2026-05-08T10:23:05.388283Z","steps":["trace[793825456] 'process raft request' (duration: 96.021165ms)","trace[793825456] 'compare' (duration: 31.375025ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:05.426366Z","caller":"traceutil/trace.go:171","msg":"trace[249879480] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"164.423978ms","start":"2026-05-08T10:23:05.261917Z","end":"2026-05-08T10:23:05.426341Z","steps":["trace[249879480] 'process raft request' (duration: 164.183993ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:06.889296Z","caller":"traceutil/trace.go:171","msg":"trace[502212349] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"202.045175ms","start":"2026-05-08T10:23:06.687234Z","end":"2026-05-08T10:23:06.889279Z","steps":["trace[502212349] 'process raft request' (duration: 201.933973ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:07.085469Z","caller":"traceutil/trace.go:171","msg":"trace[926211308] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"190.381674ms","start":"2026-05-08T10:23:06.895057Z","end":"2026-05-08T10:23:07.085439Z","steps":["trace[926211308] 'process raft request' (duration: 94.064173ms)","trace[926211308] 'compare' (duration: 96.081086ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:07.165347Z","caller":"traceutil/trace.go:171","msg":"trace[749931587] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"269.768639ms","start":"2026-05-08T10:23:06.895557Z","end":"2026-05-08T10:23:07.165325Z","steps":["trace[749931587] 'process raft request' (duration: 269.571125ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:07.16566Z","caller":"traceutil/trace.go:171","msg":"trace[947449778] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"269.609108ms","start":"2026-05-08T10:23:06.89602Z","end":"2026-05-08T10:23:07.165629Z","steps":["trace[947449778] 'process raft request' (duration: 269.232339ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:09.428277Z","caller":"traceutil/trace.go:171","msg":"trace[833184233] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"132.395034ms","start":"2026-05-08T10:23:09.295861Z","end":"2026-05-08T10:23:09.428256Z","steps":["trace[833184233] 'process raft request' (duration: 132.362083ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:09.428375Z","caller":"traceutil/trace.go:171","msg":"trace[1428141642] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"133.834394ms","start":"2026-05-08T10:23:09.2945Z","end":"2026-05-08T10:23:09.428334Z","steps":["trace[1428141642] 'process raft request' (duration: 133.689531ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:09.428399Z","caller":"traceutil/trace.go:171","msg":"trace[1702846227] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"133.878145ms","start":"2026-05-08T10:23:09.294408Z","end":"2026-05-08T10:23:09.428286Z","steps":["trace[1702846227] 'process raft request' (duration: 130.138095ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:11.550834Z","caller":"traceutil/trace.go:171","msg":"trace[343811707] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:999; }","duration":"119.378683ms","start":"2026-05-08T10:23:11.431434Z","end":"2026-05-08T10:23:11.550813Z","steps":["trace[343811707] 'read index received' (duration: 10.21432ms)","trace[343811707] 'applied index is now lower than readState.Index' (duration: 109.163283ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:11.550946Z","caller":"traceutil/trace.go:171","msg":"trace[514930624] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"122.173582ms","start":"2026-05-08T10:23:11.428757Z","end":"2026-05-08T10:23:11.550931Z","steps":["trace[514930624] 'process raft request' (duration: 121.856095ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:11.551223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.771501ms","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-05-08T10:23:11.551305Z","caller":"traceutil/trace.go:171","msg":"trace[1049669217] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:970; }","duration":"119.892383ms","start":"2026-05-08T10:23:11.431395Z","end":"2026-05-08T10:23:11.551288Z","steps":["trace[1049669217] 'agreement among raft nodes before linearized reading' (duration: 119.663448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:11.551403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.424234ms","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-05-08T10:23:11.551477Z","caller":"traceutil/trace.go:171","msg":"trace[713939451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"119.521055ms","start":"2026-05-08T10:23:11.43194Z","end":"2026-05-08T10:23:11.551461Z","steps":["trace[713939451] 'agreement among raft nodes before linearized reading' (duration: 119.305971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:23:11.55158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.638268ms","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-05-08T10:23:11.551696Z","caller":"traceutil/trace.go:171","msg":"trace[2111708733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:970; }","duration":"119.923074ms","start":"2026-05-08T10:23:11.431755Z","end":"2026-05-08T10:23:11.551678Z","steps":["trace[2111708733] 'agreement among raft nodes before linearized reading' (duration: 119.316981ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:11.659352Z","caller":"traceutil/trace.go:171","msg":"trace[918834928] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"103.526762ms","start":"2026-05-08T10:23:11.555806Z","end":"2026-05-08T10:23:11.659332Z","steps":["trace[918834928] 'process raft request' (duration: 101.498488ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:11.659633Z","caller":"traceutil/trace.go:171","msg":"trace[1239909293] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"103.756467ms","start":"2026-05-08T10:23:11.555847Z","end":"2026-05-08T10:23:11.659604Z","steps":["trace[1239909293] 'process raft request' (duration: 103.44595ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:11.660863Z","caller":"traceutil/trace.go:171","msg":"trace[2022002230] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"103.272976ms","start":"2026-05-08T10:23:11.557551Z","end":"2026-05-08T10:23:11.660824Z","steps":["trace[2022002230] 'process raft request' (duration: 101.954458ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:13.785031Z","caller":"traceutil/trace.go:171","msg":"trace[192929394] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"118.256626ms","start":"2026-05-08T10:23:13.666752Z","end":"2026-05-08T10:23:13.785008Z","steps":["trace[192929394] 'process raft request' (duration: 118.210185ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:13.785069Z","caller":"traceutil/trace.go:171","msg":"trace[2022662568] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"120.391311ms","start":"2026-05-08T10:23:13.664624Z","end":"2026-05-08T10:23:13.785015Z","steps":["trace[2022662568] 'process raft request' (duration: 83.996311ms)","trace[2022662568] 'compare' (duration: 36.206136ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:13.785062Z","caller":"traceutil/trace.go:171","msg":"trace[674219118] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"120.369921ms","start":"2026-05-08T10:23:13.664671Z","end":"2026-05-08T10:23:13.785041Z","steps":["trace[674219118] 'read index received' (duration: 83.919789ms)","trace[674219118] 'applied index is now lower than readState.Index' (duration: 36.447162ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:13.785283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.591126ms","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-05-08T10:23:13.785348Z","caller":"traceutil/trace.go:171","msg":"trace[1186768894] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:981; }","duration":"120.682389ms","start":"2026-05-08T10:23:13.664656Z","end":"2026-05-08T10:23:13.785338Z","steps":["trace[1186768894] 'agreement among raft nodes before linearized reading' (duration: 120.444233ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:13.974271Z","caller":"traceutil/trace.go:171","msg":"trace[2067453663] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"184.947376ms","start":"2026-05-08T10:23:13.789285Z","end":"2026-05-08T10:23:13.974233Z","steps":["trace[2067453663] 'process raft request' (duration: 162.597697ms)","trace[2067453663] 'compare' (duration: 22.150855ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:24.102127Z","caller":"traceutil/trace.go:171","msg":"trace[1747521205] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"154.093762ms","start":"2026-05-08T10:23:23.948009Z","end":"2026-05-08T10:23:24.102103Z","steps":["trace[1747521205] 'process raft request' (duration: 153.377737ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:26.16407Z","caller":"traceutil/trace.go:171","msg":"trace[1013094048] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1023; }","duration":"108.424023ms","start":"2026-05-08T10:23:26.055603Z","end":"2026-05-08T10:23:26.164027Z","steps":["trace[1013094048] 'process raft request' (duration: 97.383208ms)","trace[1013094048] 'compare' (duration: 10.896552ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:30.415698Z","caller":"traceutil/trace.go:171","msg":"trace[18699925] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"137.513041ms","start":"2026-05-08T10:23:30.278157Z","end":"2026-05-08T10:23:30.41567Z","steps":["trace[18699925] 'process raft request' (duration: 72.566037ms)","trace[18699925] 'compare' (duration: 64.826862ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:34.068903Z","caller":"traceutil/trace.go:171","msg":"trace[742325399] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"140.783628ms","start":"2026-05-08T10:23:33.928097Z","end":"2026-05-08T10:23:34.068881Z","steps":["trace[742325399] 'process raft request' (duration: 131.212714ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:35.844456Z","caller":"traceutil/trace.go:171","msg":"trace[1221613599] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"124.07033ms","start":"2026-05-08T10:23:35.720359Z","end":"2026-05-08T10:23:35.844429Z","steps":["trace[1221613599] 'process raft request' (duration: 123.900816ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:35.899101Z","caller":"traceutil/trace.go:171","msg":"trace[497989079] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"118.794968ms","start":"2026-05-08T10:23:35.780289Z","end":"2026-05-08T10:23:35.899084Z","steps":["trace[497989079] 'process raft request' (duration: 118.719826ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:36.229313Z","caller":"traceutil/trace.go:171","msg":"trace[1040786673] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1092; }","duration":"155.068269ms","start":"2026-05-08T10:23:36.074219Z","end":"2026-05-08T10:23:36.229287Z","steps":["trace[1040786673] 'read index received' (duration: 49.918712ms)","trace[1040786673] 'applied index is now lower than readState.Index' (duration: 105.148567ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:36.229395Z","caller":"traceutil/trace.go:171","msg":"trace[717824717] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"155.636341ms","start":"2026-05-08T10:23:36.073723Z","end":"2026-05-08T10:23:36.229359Z","steps":["trace[717824717] 'process raft request' (duration: 128.76129ms)","trace[717824717] 'compare' (duration: 26.668847ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:23:36.229503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.260773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:23:36.229549Z","caller":"traceutil/trace.go:171","msg":"trace[1736751664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1057; }","duration":"155.319464ms","start":"2026-05-08T10:23:36.074213Z","end":"2026-05-08T10:23:36.229532Z","steps":["trace[1736751664] 'agreement among raft nodes before linearized reading' (duration: 155.168221ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:36.582527Z","caller":"traceutil/trace.go:171","msg":"trace[1548021541] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"276.094024ms","start":"2026-05-08T10:23:36.306371Z","end":"2026-05-08T10:23:36.582465Z","steps":["trace[1548021541] 'process raft request' (duration: 275.90206ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:44.417605Z","caller":"traceutil/trace.go:171","msg":"trace[1373045398] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"104.505268ms","start":"2026-05-08T10:23:44.313058Z","end":"2026-05-08T10:23:44.417563Z","steps":["trace[1373045398] 'process raft request' (duration: 104.272073ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:52.19051Z","caller":"traceutil/trace.go:171","msg":"trace[385183565] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"109.299076ms","start":"2026-05-08T10:23:52.081189Z","end":"2026-05-08T10:23:52.190489Z","steps":["trace[385183565] 'process raft request' (duration: 108.982929ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:00.543709Z","caller":"traceutil/trace.go:171","msg":"trace[204886440] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"116.446564ms","start":"2026-05-08T10:24:00.427242Z","end":"2026-05-08T10:24:00.543688Z","steps":["trace[204886440] 'process raft request' (duration: 116.332731ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:02.378881Z","caller":"traceutil/trace.go:171","msg":"trace[1187953997] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"133.454793ms","start":"2026-05-08T10:24:02.245409Z","end":"2026-05-08T10:24:02.378864Z","steps":["trace[1187953997] 'read index received' (duration: 133.32892ms)","trace[1187953997] 'applied index is now lower than readState.Index' (duration: 125.323µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:24:02.378978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.568885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:24:02.378996Z","caller":"traceutil/trace.go:171","msg":"trace[826326754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1140; }","duration":"133.646217ms","start":"2026-05-08T10:24:02.245345Z","end":"2026-05-08T10:24:02.378991Z","steps":["trace[826326754] 'agreement among raft nodes before linearized reading' (duration: 133.584336ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:02.378956Z","caller":"traceutil/trace.go:171","msg":"trace[557027064] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"135.601328ms","start":"2026-05-08T10:24:02.243327Z","end":"2026-05-08T10:24:02.378929Z","steps":["trace[557027064] 'process raft request' (duration: 135.409274ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:04.997304Z","caller":"traceutil/trace.go:171","msg":"trace[151803566] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"137.517387ms","start":"2026-05-08T10:24:04.85976Z","end":"2026-05-08T10:24:04.997277Z","steps":["trace[151803566] 'process raft request' (duration: 136.923354ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:06.966834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.107345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:24:06.96694Z","caller":"traceutil/trace.go:171","msg":"trace[921294867] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"255.576802ms","start":"2026-05-08T10:24:06.711345Z","end":"2026-05-08T10:24:06.966922Z","steps":["trace[921294867] 'process raft request' (duration: 50.276373ms)","trace[921294867] 'compare' (duration: 205.004453ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:24:07.119465Z","caller":"traceutil/trace.go:171","msg":"trace[1344325664] linearizableReadLoop","detail":"{readStateIndex:1200; appliedIndex:1199; }","duration":"118.146566ms","start":"2026-05-08T10:24:07.001294Z","end":"2026-05-08T10:24:07.119441Z","steps":["trace[1344325664] 'read index received' (duration: 65.648937ms)","trace[1344325664] 'applied index is now lower than readState.Index' (duration: 52.496499ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:24:07.119747Z","caller":"traceutil/trace.go:171","msg":"trace[208270731] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"405.191882ms","start":"2026-05-08T10:24:06.71454Z","end":"2026-05-08T10:24:07.119732Z","steps":["trace[208270731] 'process raft request' (duration: 352.492209ms)","trace[208270731] 'compare' (duration: 52.124081ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:24:07.119855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:06.714527Z","time spent":"405.258833ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:24:07.120321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.021834ms","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-05-08T10:24:07.120367Z","caller":"traceutil/trace.go:171","msg":"trace[257947761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1157; }","duration":"119.103566ms","start":"2026-05-08T10:24:07.001253Z","end":"2026-05-08T10:24:07.120356Z","steps":["trace[257947761] 'agreement among raft nodes before linearized reading' (duration: 118.960213ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:07.33626Z","caller":"traceutil/trace.go:171","msg":"trace[1470657935] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"211.045459ms","start":"2026-05-08T10:24:07.125194Z","end":"2026-05-08T10:24:07.336239Z","steps":["trace[1470657935] 'process raft request' (duration: 122.315684ms)","trace[1470657935] 'compare' (duration: 88.643054ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:24:19.512282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.964575ms","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-05-08T10:24:19.512347Z","caller":"traceutil/trace.go:171","msg":"trace[1832218690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1197; }","duration":"116.063118ms","start":"2026-05-08T10:24:19.396269Z","end":"2026-05-08T10:24:19.512332Z","steps":["trace[1832218690] 'range keys from in-memory index tree' (duration: 115.838602ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:28.882914Z","caller":"traceutil/trace.go:171","msg":"trace[1288076211] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"109.007823ms","start":"2026-05-08T10:24:28.773882Z","end":"2026-05-08T10:24:28.88289Z","steps":["trace[1288076211] 'process raft request' (duration: 108.823639ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:39.242412Z","caller":"traceutil/trace.go:171","msg":"trace[1599037899] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"243.919367ms","start":"2026-05-08T10:24:38.99847Z","end":"2026-05-08T10:24:39.242389Z","steps":["trace[1599037899] 'read index received' (duration: 243.685602ms)","trace[1599037899] 'applied index is now lower than readState.Index' (duration: 232.875µs)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:24:39.242626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.10762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-08T10:24:39.24271Z","caller":"traceutil/trace.go:171","msg":"trace[1513549640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1291; }","duration":"244.223042ms","start":"2026-05-08T10:24:38.998433Z","end":"2026-05-08T10:24:39.242656Z","steps":["trace[1513549640] 'agreement among raft nodes before linearized reading' (duration: 244.046549ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:39.242464Z","caller":"traceutil/trace.go:171","msg":"trace[251455572] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"301.609553ms","start":"2026-05-08T10:24:38.940826Z","end":"2026-05-08T10:24:39.242435Z","steps":["trace[251455572] 'process raft request' (duration: 301.414899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:39.243134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:38.940799Z","time spent":"302.255086ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:24:39.841744Z","caller":"traceutil/trace.go:171","msg":"trace[1089562666] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"136.797818ms","start":"2026-05-08T10:24:39.704921Z","end":"2026-05-08T10:24:39.841719Z","steps":["trace[1089562666] 'process raft request' (duration: 136.656255ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:39.845859Z","caller":"traceutil/trace.go:171","msg":"trace[1821376285] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"140.608034ms","start":"2026-05-08T10:24:39.705221Z","end":"2026-05-08T10:24:39.845829Z","steps":["trace[1821376285] 'process raft request' (duration: 140.37264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:47.803718Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579209870310398622,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T10:24:47.986221Z","caller":"traceutil/trace.go:171","msg":"trace[385822642] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"686.391167ms","start":"2026-05-08T10:24:47.299805Z","end":"2026-05-08T10:24:47.986196Z","steps":["trace[385822642] 'process raft request' (duration: 686.191163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:47.986593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:47.299785Z","time spent":"686.512679ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:24:48.014394Z","caller":"traceutil/trace.go:171","msg":"trace[2073547005] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"683.508209ms","start":"2026-05-08T10:24:47.330858Z","end":"2026-05-08T10:24:48.014366Z","steps":["trace[2073547005] 'process raft request' (duration: 683.226613ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.014458Z","caller":"traceutil/trace.go:171","msg":"trace[240016350] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1374; }","duration":"710.750441ms","start":"2026-05-08T10:24:47.303475Z","end":"2026-05-08T10:24:48.014226Z","steps":["trace[240016350] 'read index received' (duration: 682.613461ms)","trace[240016350] 'applied index is now lower than readState.Index' (duration: 28.1358ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:24:48.014564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:47.330848Z","time spent":"683.613862ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:24:48.014688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.19127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T10:24:48.014817Z","caller":"traceutil/trace.go:171","msg":"trace[660477670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1324; }","duration":"711.328724ms","start":"2026-05-08T10:24:47.303432Z","end":"2026-05-08T10:24:48.014761Z","steps":["trace[660477670] 'agreement among raft nodes before linearized reading' (duration: 711.069218ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:48.01483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.220662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-08T10:24:48.014882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:47.303415Z","time spent":"711.455156ms","remote":"127.0.0.1:35478","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-05-08T10:24:48.014876Z","caller":"traceutil/trace.go:171","msg":"trace[1704233145] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1324; }","duration":"707.351845ms","start":"2026-05-08T10:24:47.307511Z","end":"2026-05-08T10:24:48.014863Z","steps":["trace[1704233145] 'agreement among raft nodes before linearized reading' (duration: 707.121069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:48.014944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:47.307498Z","time spent":"707.433877ms","remote":"127.0.0.1:35478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T10:24:48.014953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.046281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T10:24:48.015037Z","caller":"traceutil/trace.go:171","msg":"trace[498685015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1324; }","duration":"134.176804ms","start":"2026-05-08T10:24:47.880839Z","end":"2026-05-08T10:24:48.015016Z","steps":["trace[498685015] 'agreement among raft nodes before linearized reading' (duration: 133.936519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:48.015154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.117813ms","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-05-08T10:24:48.0152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.292951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:24:48.015223Z","caller":"traceutil/trace.go:171","msg":"trace[1626685245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1324; }","duration":"132.227925ms","start":"2026-05-08T10:24:47.882979Z","end":"2026-05-08T10:24:48.015207Z","steps":["trace[1626685245] 'agreement among raft nodes before linearized reading' (duration: 132.068752ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.015232Z","caller":"traceutil/trace.go:171","msg":"trace[257174133] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1324; }","duration":"472.363813ms","start":"2026-05-08T10:24:47.542857Z","end":"2026-05-08T10:24:48.01522Z","steps":["trace[257174133] 'agreement among raft nodes before linearized reading' (duration: 472.306161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:48.015265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:24:47.542834Z","time spent":"472.421793ms","remote":"127.0.0.1:48432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T10:24:48.015378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.276745ms","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-05-08T10:24:48.015427Z","caller":"traceutil/trace.go:171","msg":"trace[1771421974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1324; }","duration":"137.388307ms","start":"2026-05-08T10:24:47.878027Z","end":"2026-05-08T10:24:48.015415Z","steps":["trace[1771421974] 'agreement among raft nodes before linearized reading' (duration: 137.077231ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.18223Z","caller":"traceutil/trace.go:171","msg":"trace[890658164] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"162.855906ms","start":"2026-05-08T10:24:48.01934Z","end":"2026-05-08T10:24:48.182196Z","steps":["trace[890658164] 'process raft request' (duration: 89.648407ms)","trace[890658164] 'compare' (duration: 72.944014ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:24:48.182528Z","caller":"traceutil/trace.go:171","msg":"trace[254744761] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"162.599661ms","start":"2026-05-08T10:24:48.019874Z","end":"2026-05-08T10:24:48.182474Z","steps":["trace[254744761] 'process raft request' (duration: 162.267804ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.182599Z","caller":"traceutil/trace.go:171","msg":"trace[2094269932] linearizableReadLoop","detail":"{readStateIndex:1381; appliedIndex:1376; }","duration":"140.865228ms","start":"2026-05-08T10:24:48.04171Z","end":"2026-05-08T10:24:48.182576Z","steps":["trace[2094269932] 'read index received' (duration: 67.358863ms)","trace[2094269932] 'applied index is now lower than readState.Index' (duration: 73.504875ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:24:48.182637Z","caller":"traceutil/trace.go:171","msg":"trace[761102275] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"162.643471ms","start":"2026-05-08T10:24:48.019924Z","end":"2026-05-08T10:24:48.182568Z","steps":["trace[761102275] 'process raft request' (duration: 162.443438ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.182709Z","caller":"traceutil/trace.go:171","msg":"trace[145901076] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"162.5322ms","start":"2026-05-08T10:24:48.020128Z","end":"2026-05-08T10:24:48.18266Z","steps":["trace[145901076] 'process raft request' (duration: 162.313406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:48.18276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.022531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:24:48.182879Z","caller":"traceutil/trace.go:171","msg":"trace[929266857] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1329; }","duration":"141.194005ms","start":"2026-05-08T10:24:48.041669Z","end":"2026-05-08T10:24:48.182863Z","steps":["trace[929266857] 'agreement among raft nodes before linearized reading' (duration: 140.99318ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:48.182781Z","caller":"traceutil/trace.go:171","msg":"trace[2080799446] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"162.5295ms","start":"2026-05-08T10:24:48.020223Z","end":"2026-05-08T10:24:48.182752Z","steps":["trace[2080799446] 'process raft request' (duration: 162.264645ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:06.217606Z","caller":"traceutil/trace.go:171","msg":"trace[292211651] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"103.76399ms","start":"2026-05-08T10:25:06.113817Z","end":"2026-05-08T10:25:06.217581Z","steps":["trace[292211651] 'process raft request' (duration: 103.198519ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:06.355648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.425453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:25:06.355758Z","caller":"traceutil/trace.go:171","msg":"trace[446350772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1388; }","duration":"111.576026ms","start":"2026-05-08T10:25:06.244158Z","end":"2026-05-08T10:25:06.355734Z","steps":["trace[446350772] 'range keys from in-memory index tree' (duration: 111.358472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:06.601474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.214169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:25:06.601571Z","caller":"traceutil/trace.go:171","msg":"trace[154171040] linearizableReadLoop","detail":"{readStateIndex:1448; appliedIndex:1447; }","duration":"167.734641ms","start":"2026-05-08T10:25:06.43382Z","end":"2026-05-08T10:25:06.601554Z","steps":["trace[154171040] 'read index received' (duration: 22.341938ms)","trace[154171040] 'applied index is now lower than readState.Index' (duration: 145.391593ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:06.601677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.249041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-node-lease/\" range_end:\"/registry/deployments/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:25:06.601706Z","caller":"traceutil/trace.go:171","msg":"trace[977790766] range","detail":"{range_begin:/registry/deployments/kube-node-lease/; range_end:/registry/deployments/kube-node-lease0; response_count:0; response_revision:1391; }","duration":"148.303642ms","start":"2026-05-08T10:25:06.453391Z","end":"2026-05-08T10:25:06.601695Z","steps":["trace[977790766] 'agreement among raft nodes before linearized reading' (duration: 148.252851ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:06.601679Z","caller":"traceutil/trace.go:171","msg":"trace[1909748119] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"190.390676ms","start":"2026-05-08T10:25:06.411243Z","end":"2026-05-08T10:25:06.601634Z","steps":["trace[1909748119] 'process raft request' (duration: 44.932292ms)","trace[1909748119] 'compare' (duration: 145.105517ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:06.601718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.877763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/\" range_end:\"/registry/configmaps/kube-public0\" limit:500 ","response":"range_response_count:2 size:3917"} {"level":"info","ts":"2026-05-08T10:25:06.60177Z","caller":"traceutil/trace.go:171","msg":"trace[1342860229] range","detail":"{range_begin:/registry/configmaps/kube-public/; range_end:/registry/configmaps/kube-public0; response_count:2; response_revision:1391; }","duration":"167.971666ms","start":"2026-05-08T10:25:06.433785Z","end":"2026-05-08T10:25:06.601757Z","steps":["trace[1342860229] 'agreement among raft nodes before linearized reading' (duration: 167.845693ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:06.601773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.167138ms","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-05-08T10:25:06.6018Z","caller":"traceutil/trace.go:171","msg":"trace[792792888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1391; }","duration":"117.212648ms","start":"2026-05-08T10:25:06.484581Z","end":"2026-05-08T10:25:06.601794Z","steps":["trace[792792888] 'agreement among raft nodes before linearized reading' (duration: 117.112376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:06.601828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.426654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T10:25:06.601893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.177449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:833"} {"level":"info","ts":"2026-05-08T10:25:06.601902Z","caller":"traceutil/trace.go:171","msg":"trace[1373157198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1391; }","duration":"127.521536ms","start":"2026-05-08T10:25:06.474362Z","end":"2026-05-08T10:25:06.601884Z","steps":["trace[1373157198] 'agreement among raft nodes before linearized reading' (duration: 127.333582ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:06.601951Z","caller":"traceutil/trace.go:171","msg":"trace[409113665] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1391; }","duration":"137.269901ms","start":"2026-05-08T10:25:06.464665Z","end":"2026-05-08T10:25:06.601935Z","steps":["trace[409113665] 'agreement among raft nodes before linearized reading' (duration: 137.086357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:06.601967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.784532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 ","response":"range_response_count:15 size:12285"} {"level":"info","ts":"2026-05-08T10:25:06.602026Z","caller":"traceutil/trace.go:171","msg":"trace[25614012] range","detail":"{range_begin:/registry/events/envoy-gateway-system/; range_end:/registry/events/envoy-gateway-system0; response_count:15; response_revision:1391; }","duration":"121.852653ms","start":"2026-05-08T10:25:06.480155Z","end":"2026-05-08T10:25:06.602007Z","steps":["trace[25614012] 'agreement among raft nodes before linearized reading' (duration: 121.619097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:15.020308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.068458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-08T10:25:15.020418Z","caller":"traceutil/trace.go:171","msg":"trace[1141182254] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1419; }","duration":"177.215281ms","start":"2026-05-08T10:25:14.843177Z","end":"2026-05-08T10:25:15.020392Z","steps":["trace[1141182254] 'range keys from in-memory index tree' (duration: 176.959696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:15.020415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.7866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-08T10:25:15.020555Z","caller":"traceutil/trace.go:171","msg":"trace[1008186146] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:1419; }","duration":"151.001974ms","start":"2026-05-08T10:25:14.869533Z","end":"2026-05-08T10:25:15.020535Z","steps":["trace[1008186146] 'range keys from in-memory index tree' (duration: 150.674638ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:15.993265Z","caller":"traceutil/trace.go:171","msg":"trace[369141289] linearizableReadLoop","detail":"{readStateIndex:1479; appliedIndex:1477; }","duration":"100.960849ms","start":"2026-05-08T10:25:15.892282Z","end":"2026-05-08T10:25:15.993243Z","steps":["trace[369141289] 'read index received' (duration: 43.229968ms)","trace[369141289] 'applied index is now lower than readState.Index' (duration: 57.729731ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:25:15.993343Z","caller":"traceutil/trace.go:171","msg":"trace[102639820] transaction","detail":"{read_only:false; response_revision:1420; number_of_response:1; }","duration":"113.730495ms","start":"2026-05-08T10:25:15.879585Z","end":"2026-05-08T10:25:15.993316Z","steps":["trace[102639820] 'process raft request' (duration: 113.544511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:15.993447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.144722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-08T10:25:15.993491Z","caller":"traceutil/trace.go:171","msg":"trace[1679004030] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:1420; }","duration":"101.226244ms","start":"2026-05-08T10:25:15.892252Z","end":"2026-05-08T10:25:15.993478Z","steps":["trace[1679004030] 'agreement among raft nodes before linearized reading' (duration: 101.121512ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:16.589569Z","caller":"traceutil/trace.go:171","msg":"trace[757680346] linearizableReadLoop","detail":"{readStateIndex:1481; appliedIndex:1480; }","duration":"106.598272ms","start":"2026-05-08T10:25:16.482943Z","end":"2026-05-08T10:25:16.589541Z","steps":["trace[757680346] 'read index received' (duration: 106.322687ms)","trace[757680346] 'applied index is now lower than readState.Index' (duration: 274.165µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:25:16.589606Z","caller":"traceutil/trace.go:171","msg":"trace[585109453] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"115.867649ms","start":"2026-05-08T10:25:16.473717Z","end":"2026-05-08T10:25:16.589584Z","steps":["trace[585109453] 'process raft request' (duration: 115.631604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:16.590328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.286416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63116"} {"level":"info","ts":"2026-05-08T10:25:16.590411Z","caller":"traceutil/trace.go:171","msg":"trace[2004386441] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:1422; }","duration":"107.400528ms","start":"2026-05-08T10:25:16.482989Z","end":"2026-05-08T10:25:16.590389Z","steps":["trace[2004386441] 'agreement among raft nodes before linearized reading' (duration: 106.750635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:16.59095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.99976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:85 size:63116"} {"level":"info","ts":"2026-05-08T10:25:16.591021Z","caller":"traceutil/trace.go:171","msg":"trace[2027784645] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:85; response_revision:1422; }","duration":"108.105142ms","start":"2026-05-08T10:25:16.482899Z","end":"2026-05-08T10:25:16.591004Z","steps":["trace[2027784645] 'agreement among raft nodes before linearized reading' (duration: 106.785626ms)"],"step_count":1}