{"level":"warn","ts":"2026-05-05T10:12:33.954303Z","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-05T10:12:33.954397Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-05T10:12:33.95446Z","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-05T10:12:33.954469Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-05T10:12:33.954487Z","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-05T10:12:33.955246Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-05-05T10:12:33.95532Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-05T10:12:33.979305Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"23.777798ms"} {"level":"info","ts":"2026-05-05T10:12:34.002633Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-05-05T10:12:34.00272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T10:12:34.002742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-05-05T10:12:34.002755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T10:12:34.002771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-05-05T10:12:34.002808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-05-05T10:12:34.028286Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T10:12:34.031919Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T10:12:34.034874Z","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-05T10:12:34.045364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T10:12:34.045673Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T10:12:34.048039Z","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-05T10:12:34.049358Z","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-05T10:12:34.049387Z","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-05T10:12:34.049864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-05-05T10:12:34.050059Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-05-05T10:12:34.051878Z","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-05T10:12:34.051989Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-05T10:12:34.052044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-05-05T10:12:34.052185Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T10:12:34.052228Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T10:12:34.404094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T10:12:34.404219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T10:12:34.404304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-05-05T10:12:34.404338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-05-05T10:12:34.404356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-05T10:12:34.40438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-05-05T10:12:34.404401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-05-05T10:12:34.406073Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:12:34.407094Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:12:34.407097Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T10:12:34.407167Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:12:34.407282Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:12:34.407722Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:12:34.407785Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:12:34.408493Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T10:12:34.408577Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T10:12:34.411901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-05-05T10:12:34.412049Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T10:12:40.368527Z","caller":"traceutil/trace.go:171","msg":"trace[449293837] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"117.206018ms","start":"2026-05-05T10:12:40.251294Z","end":"2026-05-05T10:12:40.3685Z","steps":["trace[449293837] 'process raft request' (duration: 117.072017ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:40.368635Z","caller":"traceutil/trace.go:171","msg":"trace[1210984613] transaction","detail":"{read_only:false; number_of_response:0; response_revision:267; }","duration":"131.671998ms","start":"2026-05-05T10:12:40.23693Z","end":"2026-05-05T10:12:40.368602Z","steps":["trace[1210984613] 'process raft request' (duration: 131.364946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:40.368598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.143964ms","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-05T10:12:40.368942Z","caller":"traceutil/trace.go:171","msg":"trace[1210923491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:268; }","duration":"131.511526ms","start":"2026-05-05T10:12:40.237409Z","end":"2026-05-05T10:12:40.368921Z","steps":["trace[1210923491] 'agreement among raft nodes before linearized reading' (duration: 131.080003ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:40.559789Z","caller":"traceutil/trace.go:171","msg":"trace[1884288913] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:278; }","duration":"191.265739ms","start":"2026-05-05T10:12:40.368457Z","end":"2026-05-05T10:12:40.559722Z","steps":["trace[1884288913] 'read index received' (duration: 166.933215ms)","trace[1884288913] 'applied index is now lower than readState.Index' (duration: 24.331324ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:40.559811Z","caller":"traceutil/trace.go:171","msg":"trace[1667777768] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"225.151206ms","start":"2026-05-05T10:12:40.334629Z","end":"2026-05-05T10:12:40.559781Z","steps":["trace[1667777768] 'process raft request' (duration: 200.64798ms)","trace[1667777768] 'compare' (duration: 24.288544ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:12:40.560002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.578766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-05-05T10:12:40.560052Z","caller":"traceutil/trace.go:171","msg":"trace[1336891881] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:269; }","duration":"243.678517ms","start":"2026-05-05T10:12:40.316362Z","end":"2026-05-05T10:12:40.56004Z","steps":["trace[1336891881] 'agreement among raft nodes before linearized reading' (duration: 243.528445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:40.593557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.693445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-05-05T10:12:40.593635Z","caller":"traceutil/trace.go:171","msg":"trace[1520388399] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:270; }","duration":"223.822206ms","start":"2026-05-05T10:12:40.369794Z","end":"2026-05-05T10:12:40.593616Z","steps":["trace[1520388399] 'agreement among raft nodes before linearized reading' (duration: 223.665385ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:40.593909Z","caller":"traceutil/trace.go:171","msg":"trace[434189655] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"217.995062ms","start":"2026-05-05T10:12:40.375902Z","end":"2026-05-05T10:12:40.593897Z","steps":["trace[434189655] 'process raft request' (duration: 217.328827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:40.594066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.984225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-05T10:12:40.594096Z","caller":"traceutil/trace.go:171","msg":"trace[478077999] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:270; }","duration":"217.036615ms","start":"2026-05-05T10:12:40.377052Z","end":"2026-05-05T10:12:40.594089Z","steps":["trace[478077999] 'agreement among raft nodes before linearized reading' (duration: 216.979494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:41.021441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.349549ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:12:41.021532Z","caller":"traceutil/trace.go:171","msg":"trace[1823925801] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"242.453886ms","start":"2026-05-05T10:12:40.779066Z","end":"2026-05-05T10:12:41.02152Z","steps":["trace[1823925801] 'process raft request' (duration: 46.739565ms)","trace[1823925801] 'compare' (duration: 195.226248ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:41.028349Z","caller":"traceutil/trace.go:171","msg":"trace[344599488] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:285; }","duration":"117.645919ms","start":"2026-05-05T10:12:40.910668Z","end":"2026-05-05T10:12:41.028313Z","steps":["trace[344599488] 'read index received' (duration: 117.491708ms)","trace[344599488] 'applied index is now lower than readState.Index' (duration: 153.231µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:12:41.028511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.84459ms","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-05T10:12:41.028402Z","caller":"traceutil/trace.go:171","msg":"trace[2092878842] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"240.980283ms","start":"2026-05-05T10:12:40.787389Z","end":"2026-05-05T10:12:41.028369Z","steps":["trace[2092878842] 'process raft request' (duration: 240.792082ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:41.028544Z","caller":"traceutil/trace.go:171","msg":"trace[540568645] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:276; }","duration":"117.916012ms","start":"2026-05-05T10:12:40.91062Z","end":"2026-05-05T10:12:41.028536Z","steps":["trace[540568645] 'agreement among raft nodes before linearized reading' (duration: 117.839811ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:44.56355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.771122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:12:44.5639Z","caller":"traceutil/trace.go:171","msg":"trace[1242092848] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"265.272889ms","start":"2026-05-05T10:12:44.298565Z","end":"2026-05-05T10:12:44.563838Z","steps":["trace[1242092848] 'process raft request' (duration: 147.128304ms)","trace[1242092848] 'compare' (duration: 117.604291ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:44.563945Z","caller":"traceutil/trace.go:171","msg":"trace[529259726] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"263.878219ms","start":"2026-05-05T10:12:44.300028Z","end":"2026-05-05T10:12:44.563906Z","steps":["trace[529259726] 'process raft request' (duration: 263.757879ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:44.563948Z","caller":"traceutil/trace.go:171","msg":"trace[1910161071] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"265.064067ms","start":"2026-05-05T10:12:44.298813Z","end":"2026-05-05T10:12:44.563877Z","steps":["trace[1910161071] 'process raft request' (duration: 264.923606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:44.564154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.907414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:2278"} {"level":"info","ts":"2026-05-05T10:12:44.564298Z","caller":"traceutil/trace.go:171","msg":"trace[406600674] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:336; }","duration":"219.083815ms","start":"2026-05-05T10:12:44.345188Z","end":"2026-05-05T10:12:44.564272Z","steps":["trace[406600674] 'agreement among raft nodes before linearized reading' (duration: 218.774733ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:44.563931Z","caller":"traceutil/trace.go:171","msg":"trace[1561315779] linearizableReadLoop","detail":"{readStateIndex:346; appliedIndex:342; }","duration":"218.642822ms","start":"2026-05-05T10:12:44.345237Z","end":"2026-05-05T10:12:44.56388Z","steps":["trace[1561315779] 'read index received' (duration: 100.374037ms)","trace[1561315779] 'applied index is now lower than readState.Index' (duration: 118.267665ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:44.563948Z","caller":"traceutil/trace.go:171","msg":"trace[1704748460] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"256.770078ms","start":"2026-05-05T10:12:44.307157Z","end":"2026-05-05T10:12:44.563927Z","steps":["trace[1704748460] 'process raft request' (duration: 256.674397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:44.564745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.231096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-05-05T10:12:44.564791Z","caller":"traceutil/trace.go:171","msg":"trace[1845759196] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:336; }","duration":"219.318167ms","start":"2026-05-05T10:12:44.345459Z","end":"2026-05-05T10:12:44.564777Z","steps":["trace[1845759196] 'agreement among raft nodes before linearized reading' (duration: 219.210556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:44.565074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.9222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-05T10:12:44.565161Z","caller":"traceutil/trace.go:171","msg":"trace[201279794] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:336; }","duration":"123.00695ms","start":"2026-05-05T10:12:44.44212Z","end":"2026-05-05T10:12:44.565127Z","steps":["trace[201279794] 'agreement among raft nodes before linearized reading' (duration: 122.805589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:44.879686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.876795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:12:44.879845Z","caller":"traceutil/trace.go:171","msg":"trace[1803811958] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"258.208448ms","start":"2026-05-05T10:12:44.621624Z","end":"2026-05-05T10:12:44.879833Z","steps":["trace[1803811958] 'process raft request' (duration: 258.154038ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:44.879878Z","caller":"traceutil/trace.go:171","msg":"trace[1255129671] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"261.924505ms","start":"2026-05-05T10:12:44.61792Z","end":"2026-05-05T10:12:44.879845Z","steps":["trace[1255129671] 'process raft request' (duration: 46.711038ms)","trace[1255129671] 'compare' (duration: 214.778914ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:46.410697Z","caller":"traceutil/trace.go:171","msg":"trace[1756616443] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"155.121418ms","start":"2026-05-05T10:12:46.25555Z","end":"2026-05-05T10:12:46.410671Z","steps":["trace[1756616443] 'process raft request' (duration: 154.937587ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:12:47.358156Z","caller":"traceutil/trace.go:171","msg":"trace[416718969] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:367; }","duration":"268.41026ms","start":"2026-05-05T10:12:47.089712Z","end":"2026-05-05T10:12:47.358123Z","steps":["trace[416718969] 'read index received' (duration: 268.102788ms)","trace[416718969] 'applied index is now lower than readState.Index' (duration: 305.722µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:12:47.358288Z","caller":"traceutil/trace.go:171","msg":"trace[112946157] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"469.609998ms","start":"2026-05-05T10:12:46.888649Z","end":"2026-05-05T10:12:47.358259Z","steps":["trace[112946157] 'process raft request' (duration: 469.247045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:47.358335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.596951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T10:12:47.358375Z","caller":"traceutil/trace.go:171","msg":"trace[317874339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:357; }","duration":"268.721293ms","start":"2026-05-05T10:12:47.089641Z","end":"2026-05-05T10:12:47.358362Z","steps":["trace[317874339] 'agreement among raft nodes before linearized reading' (duration: 268.609472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:12:47.358447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:12:46.888632Z","time spent":"469.713979ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:12:47.507434Z","caller":"traceutil/trace.go:171","msg":"trace[1075143760] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"144.06691ms","start":"2026-05-05T10:12:47.363298Z","end":"2026-05-05T10:12:47.507365Z","steps":["trace[1075143760] 'process raft request' (duration: 125.405189ms)","trace[1075143760] 'compare' (duration: 18.480819ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:00.201624Z","caller":"traceutil/trace.go:171","msg":"trace[1497386159] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"557.518879ms","start":"2026-05-05T10:12:59.644082Z","end":"2026-05-05T10:13:00.201601Z","steps":["trace[1497386159] 'process raft request' (duration: 557.375729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:00.201986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:12:59.64405Z","time spent":"557.65034ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:00.271509Z","caller":"traceutil/trace.go:171","msg":"trace[1806393883] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:436; }","duration":"293.923463ms","start":"2026-05-05T10:12:59.977562Z","end":"2026-05-05T10:13:00.271485Z","steps":["trace[1806393883] 'read index received' (duration: 223.739356ms)","trace[1806393883] 'applied index is now lower than readState.Index' (duration: 70.182817ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:00.271603Z","caller":"traceutil/trace.go:171","msg":"trace[720553600] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"499.552613ms","start":"2026-05-05T10:12:59.771998Z","end":"2026-05-05T10:13:00.271551Z","steps":["trace[720553600] 'process raft request' (duration: 499.339422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:00.271659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.081923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:13:00.271715Z","caller":"traceutil/trace.go:171","msg":"trace[926014144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:424; }","duration":"294.195294ms","start":"2026-05-05T10:12:59.977506Z","end":"2026-05-05T10:13:00.271701Z","steps":["trace[926014144] 'agreement among raft nodes before linearized reading' (duration: 294.086273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:00.271811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:12:59.771973Z","time spent":"499.721364ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:00.404211Z","caller":"traceutil/trace.go:171","msg":"trace[1082789863] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"127.807175ms","start":"2026-05-05T10:13:00.276375Z","end":"2026-05-05T10:13:00.404182Z","steps":["trace[1082789863] 'process raft request' (duration: 42.131952ms)","trace[1082789863] 'compare' (duration: 85.425032ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:00.548304Z","caller":"traceutil/trace.go:171","msg":"trace[153193351] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"134.210906ms","start":"2026-05-05T10:13:00.414072Z","end":"2026-05-05T10:13:00.548283Z","steps":["trace[153193351] 'process raft request' (duration: 131.265308ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:06.117695Z","caller":"traceutil/trace.go:171","msg":"trace[466836495] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"574.397984ms","start":"2026-05-05T10:13:05.543273Z","end":"2026-05-05T10:13:06.117671Z","steps":["trace[466836495] 'process raft request' (duration: 574.249623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:06.117858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:05.543252Z","time spent":"574.523945ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:08.716802Z","caller":"traceutil/trace.go:171","msg":"trace[662346556] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:490; }","duration":"441.9369ms","start":"2026-05-05T10:13:08.274838Z","end":"2026-05-05T10:13:08.716775Z","steps":["trace[662346556] 'read index received' (duration: 441.658728ms)","trace[662346556] 'applied index is now lower than readState.Index' (duration: 276.662µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:08.717113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.946867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:13:08.717207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.353562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T10:13:08.717213Z","caller":"traceutil/trace.go:171","msg":"trace[629255471] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:475; }","duration":"290.108717ms","start":"2026-05-05T10:13:08.427077Z","end":"2026-05-05T10:13:08.717186Z","steps":["trace[629255471] 'agreement among raft nodes before linearized reading' (duration: 289.942596ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:08.717258Z","caller":"traceutil/trace.go:171","msg":"trace[1052616341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"442.448154ms","start":"2026-05-05T10:13:08.274795Z","end":"2026-05-05T10:13:08.717243Z","steps":["trace[1052616341] 'agreement among raft nodes before linearized reading' (duration: 442.174252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:08.717274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.243035ms","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-05T10:13:08.717301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:08.274775Z","time spent":"442.518814ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T10:13:08.717274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.032306ms","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-05T10:13:08.717345Z","caller":"traceutil/trace.go:171","msg":"trace[1734279326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"274.333945ms","start":"2026-05-05T10:13:08.442995Z","end":"2026-05-05T10:13:08.717329Z","steps":["trace[1734279326] 'agreement among raft nodes before linearized reading' (duration: 274.107344ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:08.717377Z","caller":"traceutil/trace.go:171","msg":"trace[1393956092] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"130.191536ms","start":"2026-05-05T10:13:08.587169Z","end":"2026-05-05T10:13:08.717361Z","steps":["trace[1393956092] 'agreement among raft nodes before linearized reading' (duration: 129.872614ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:08.716951Z","caller":"traceutil/trace.go:171","msg":"trace[1148902742] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"589.7458ms","start":"2026-05-05T10:13:08.127174Z","end":"2026-05-05T10:13:08.71692Z","steps":["trace[1148902742] 'process raft request' (duration: 589.434828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:08.717654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:08.127145Z","time spent":"590.429544ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:13:12.363591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.826693ms","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-05T10:13:12.363806Z","caller":"traceutil/trace.go:171","msg":"trace[1070179336] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:562; }","duration":"112.104924ms","start":"2026-05-05T10:13:12.251672Z","end":"2026-05-05T10:13:12.363777Z","steps":["trace[1070179336] 'range keys from in-memory index tree' (duration: 111.708502ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:12.962923Z","caller":"traceutil/trace.go:171","msg":"trace[982049026] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"141.410252ms","start":"2026-05-05T10:13:12.821482Z","end":"2026-05-05T10:13:12.962892Z","steps":["trace[982049026] 'process raft request' (duration: 138.355715ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:12.963095Z","caller":"traceutil/trace.go:171","msg":"trace[262530576] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"141.06576ms","start":"2026-05-05T10:13:12.821989Z","end":"2026-05-05T10:13:12.963055Z","steps":["trace[262530576] 'process raft request' (duration: 140.827929ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:12.963166Z","caller":"traceutil/trace.go:171","msg":"trace[811843742] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"117.838847ms","start":"2026-05-05T10:13:12.8453Z","end":"2026-05-05T10:13:12.963139Z","steps":["trace[811843742] 'process raft request' (duration: 117.709746ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:12.963182Z","caller":"traceutil/trace.go:171","msg":"trace[603327318] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:584; }","duration":"126.753168ms","start":"2026-05-05T10:13:12.836411Z","end":"2026-05-05T10:13:12.963164Z","steps":["trace[603327318] 'read index received' (duration: 1.189096ms)","trace[603327318] 'applied index is now lower than readState.Index' (duration: 125.562632ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:12.96343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.971989ms","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-05T10:13:12.9635Z","caller":"traceutil/trace.go:171","msg":"trace[1765668586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:567; }","duration":"127.130601ms","start":"2026-05-05T10:13:12.836353Z","end":"2026-05-05T10:13:12.963483Z","steps":["trace[1765668586] 'agreement among raft nodes before linearized reading' (duration: 126.862069ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:16.206555Z","caller":"traceutil/trace.go:171","msg":"trace[1165195108] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"230.562537ms","start":"2026-05-05T10:13:15.97596Z","end":"2026-05-05T10:13:16.206522Z","steps":["trace[1165195108] 'read index received' (duration: 229.787882ms)","trace[1165195108] 'applied index is now lower than readState.Index' (duration: 773.685µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:16.206697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.715927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:13:16.206727Z","caller":"traceutil/trace.go:171","msg":"trace[1855587599] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"230.805548ms","start":"2026-05-05T10:13:15.975909Z","end":"2026-05-05T10:13:16.206714Z","steps":["trace[1855587599] 'agreement among raft nodes before linearized reading' (duration: 230.728217ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:16.206715Z","caller":"traceutil/trace.go:171","msg":"trace[1028213479] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"768.644406ms","start":"2026-05-05T10:13:15.437968Z","end":"2026-05-05T10:13:16.206612Z","steps":["trace[1028213479] 'process raft request' (duration: 768.024543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:16.207171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:15.437918Z","time spent":"769.047078ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:16.37255Z","caller":"traceutil/trace.go:171","msg":"trace[1476826141] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"108.869221ms","start":"2026-05-05T10:13:16.263653Z","end":"2026-05-05T10:13:16.372522Z","steps":["trace[1476826141] 'process raft request' (duration: 50.717135ms)","trace[1476826141] 'compare' (duration: 58.024676ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:17.35082Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276102147931526944,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:13:17.533819Z","caller":"traceutil/trace.go:171","msg":"trace[441595516] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"749.435646ms","start":"2026-05-05T10:13:16.78435Z","end":"2026-05-05T10:13:17.533785Z","steps":["trace[441595516] 'process raft request' (duration: 748.726012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.534069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:16.784307Z","time spent":"749.598487ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:17.535561Z","caller":"traceutil/trace.go:171","msg":"trace[886433575] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"685.203605ms","start":"2026-05-05T10:13:16.850342Z","end":"2026-05-05T10:13:17.535546Z","steps":["trace[886433575] 'read index received' (duration: 682.5935ms)","trace[886433575] 'applied index is now lower than readState.Index' (duration: 2.609335ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:17.53564Z","caller":"traceutil/trace.go:171","msg":"trace[191735881] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"473.086675ms","start":"2026-05-05T10:13:17.062546Z","end":"2026-05-05T10:13:17.535633Z","steps":["trace[191735881] 'process raft request' (duration: 472.922474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.535695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:17.062513Z","time spent":"473.143255ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:13:17.53586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.382917ms","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-05T10:13:17.53589Z","caller":"traceutil/trace.go:171","msg":"trace[862931596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"516.455348ms","start":"2026-05-05T10:13:17.019426Z","end":"2026-05-05T10:13:17.535882Z","steps":["trace[862931596] 'agreement among raft nodes before linearized reading' (duration: 516.278217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.535912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:17.019388Z","time spent":"516.519248ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T10:13:17.536021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.686377ms","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-05T10:13:17.536012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.86351ms","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-05T10:13:17.536048Z","caller":"traceutil/trace.go:171","msg":"trace[430502564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:588; }","duration":"685.764899ms","start":"2026-05-05T10:13:16.850275Z","end":"2026-05-05T10:13:17.536039Z","steps":["trace[430502564] 'agreement among raft nodes before linearized reading' (duration: 685.688518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.536069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:16.850245Z","time spent":"685.819229ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T10:13:17.536056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.328329ms","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-05T10:13:17.536097Z","caller":"traceutil/trace.go:171","msg":"trace[1136313027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"525.937811ms","start":"2026-05-05T10:13:17.010109Z","end":"2026-05-05T10:13:17.536047Z","steps":["trace[1136313027] 'agreement among raft nodes before linearized reading' (duration: 525.79144ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:17.536145Z","caller":"traceutil/trace.go:171","msg":"trace[1260123915] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:588; }","duration":"527.425209ms","start":"2026-05-05T10:13:17.008695Z","end":"2026-05-05T10:13:17.536121Z","steps":["trace[1260123915] 'agreement among raft nodes before linearized reading' (duration: 527.210198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.536167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:17.010101Z","time spent":"526.030111ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:13:17.536199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:17.008681Z","time spent":"527.509489ms","remote":"127.0.0.1:57156","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":"warn","ts":"2026-05-05T10:13:17.535872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.885759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:13:17.536377Z","caller":"traceutil/trace.go:171","msg":"trace[203396315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"558.472702ms","start":"2026-05-05T10:13:16.977894Z","end":"2026-05-05T10:13:17.536367Z","steps":["trace[203396315] 'agreement among raft nodes before linearized reading' (duration: 557.812829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:17.536413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:16.977872Z","time spent":"558.534943ms","remote":"127.0.0.1:56910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T10:13:28.916388Z","caller":"traceutil/trace.go:171","msg":"trace[56172654] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"119.957242ms","start":"2026-05-05T10:13:28.796408Z","end":"2026-05-05T10:13:28.916365Z","steps":["trace[56172654] 'process raft request' (duration: 119.144912ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:35.201468Z","caller":"traceutil/trace.go:171","msg":"trace[927995550] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:782; }","duration":"284.306144ms","start":"2026-05-05T10:13:34.917129Z","end":"2026-05-05T10:13:35.201435Z","steps":["trace[927995550] 'read index received' (duration: 283.373081ms)","trace[927995550] 'applied index is now lower than readState.Index' (duration: 931.733µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:35.201603Z","caller":"traceutil/trace.go:171","msg":"trace[251437954] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"717.6344ms","start":"2026-05-05T10:13:34.483929Z","end":"2026-05-05T10:13:35.201563Z","steps":["trace[251437954] 'process raft request' (duration: 716.640824ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:35.201719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.558456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T10:13:35.201784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.436663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-05T10:13:35.201813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:13:34.483897Z","time spent":"717.794928ms","remote":"127.0.0.1:57132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:13:35.20183Z","caller":"traceutil/trace.go:171","msg":"trace[1127287773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:757; }","duration":"227.534186ms","start":"2026-05-05T10:13:34.974283Z","end":"2026-05-05T10:13:35.201817Z","steps":["trace[1127287773] 'agreement among raft nodes before linearized reading' (duration: 227.361138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:35.201862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.131274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:13:35.201888Z","caller":"traceutil/trace.go:171","msg":"trace[1907209646] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:757; }","duration":"284.685111ms","start":"2026-05-05T10:13:34.917069Z","end":"2026-05-05T10:13:35.201754Z","steps":["trace[1907209646] 'agreement among raft nodes before linearized reading' (duration: 284.556846ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:35.201941Z","caller":"traceutil/trace.go:171","msg":"trace[1108078291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"223.27071ms","start":"2026-05-05T10:13:34.978648Z","end":"2026-05-05T10:13:35.201919Z","steps":["trace[1108078291] 'agreement among raft nodes before linearized reading' (duration: 223.144714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:38.749179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.905753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:13:38.749339Z","caller":"traceutil/trace.go:171","msg":"trace[444840846] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"156.974538ms","start":"2026-05-05T10:13:38.592342Z","end":"2026-05-05T10:13:38.749317Z","steps":["trace[444840846] 'process raft request' (duration: 20.795443ms)","trace[444840846] 'compare' (duration: 135.751157ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:39.02014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.593468ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:13:39.020306Z","caller":"traceutil/trace.go:171","msg":"trace[410572350] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"262.681988ms","start":"2026-05-05T10:13:38.757594Z","end":"2026-05-05T10:13:39.020276Z","steps":["trace[410572350] 'process raft request' (duration: 114.856099ms)","trace[410572350] 'compare' (duration: 147.380939ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:39.187371Z","caller":"traceutil/trace.go:171","msg":"trace[518536101] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"110.878696ms","start":"2026-05-05T10:13:39.076459Z","end":"2026-05-05T10:13:39.187338Z","steps":["trace[518536101] 'process raft request' (duration: 94.688445ms)","trace[518536101] 'compare' (duration: 16.056826ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:39.444944Z","caller":"traceutil/trace.go:171","msg":"trace[1424746156] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"215.887739ms","start":"2026-05-05T10:13:39.229021Z","end":"2026-05-05T10:13:39.444909Z","steps":["trace[1424746156] 'process raft request' (duration: 142.207585ms)","trace[1424746156] 'compare' (duration: 73.315618ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:39.445371Z","caller":"traceutil/trace.go:171","msg":"trace[744178526] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"190.516559ms","start":"2026-05-05T10:13:39.254815Z","end":"2026-05-05T10:13:39.445331Z","steps":["trace[744178526] 'process raft request' (duration: 190.036318ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:39.446055Z","caller":"traceutil/trace.go:171","msg":"trace[1965560360] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"190.909695ms","start":"2026-05-05T10:13:39.255092Z","end":"2026-05-05T10:13:39.446002Z","steps":["trace[1965560360] 'process raft request' (duration: 190.058228ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:39.815739Z","caller":"traceutil/trace.go:171","msg":"trace[1152613715] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"250.121002ms","start":"2026-05-05T10:13:39.565582Z","end":"2026-05-05T10:13:39.815703Z","steps":["trace[1152613715] 'process raft request' (duration: 234.263104ms)","trace[1152613715] 'compare' (duration: 15.608127ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:39.815937Z","caller":"traceutil/trace.go:171","msg":"trace[79006309] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"248.984992ms","start":"2026-05-05T10:13:39.566779Z","end":"2026-05-05T10:13:39.815764Z","steps":["trace[79006309] 'process raft request' (duration: 248.804865ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:41.048678Z","caller":"traceutil/trace.go:171","msg":"trace[1563915722] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"224.47015ms","start":"2026-05-05T10:13:40.824177Z","end":"2026-05-05T10:13:41.048648Z","steps":["trace[1563915722] 'process raft request' (duration: 224.249801ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:41.174358Z","caller":"traceutil/trace.go:171","msg":"trace[1918770251] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"114.967244ms","start":"2026-05-05T10:13:41.059362Z","end":"2026-05-05T10:13:41.174329Z","steps":["trace[1918770251] 'process raft request' (duration: 114.818448ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:41.991018Z","caller":"traceutil/trace.go:171","msg":"trace[979996636] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"112.160295ms","start":"2026-05-05T10:13:41.878821Z","end":"2026-05-05T10:13:41.990981Z","steps":["trace[979996636] 'process raft request' (duration: 111.908574ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.511077Z","caller":"traceutil/trace.go:171","msg":"trace[1887728856] transaction","detail":"{read_only:false; response_revision:829; number_of_response:1; }","duration":"101.491821ms","start":"2026-05-05T10:13:43.409547Z","end":"2026-05-05T10:13:43.511038Z","steps":["trace[1887728856] 'process raft request' (duration: 101.242341ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.695786Z","caller":"traceutil/trace.go:171","msg":"trace[748510219] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"179.234242ms","start":"2026-05-05T10:13:43.516524Z","end":"2026-05-05T10:13:43.695759Z","steps":["trace[748510219] 'process raft request' (duration: 179.049334ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.696195Z","caller":"traceutil/trace.go:171","msg":"trace[93491197] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:860; }","duration":"113.959127ms","start":"2026-05-05T10:13:43.582203Z","end":"2026-05-05T10:13:43.696162Z","steps":["trace[93491197] 'read index received' (duration: 113.5445ms)","trace[93491197] 'applied index is now lower than readState.Index' (duration: 413.477µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:43.69638Z","caller":"traceutil/trace.go:171","msg":"trace[471953167] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"180.138619ms","start":"2026-05-05T10:13:43.516203Z","end":"2026-05-05T10:13:43.696342Z","steps":["trace[471953167] 'process raft request' (duration: 179.510603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:43.696453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.217447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-ktqj2\" ","response":"range_response_count:1 size:3871"} {"level":"info","ts":"2026-05-05T10:13:43.696506Z","caller":"traceutil/trace.go:171","msg":"trace[1528667882] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-ktqj2; range_end:; response_count:1; response_revision:833; }","duration":"114.335122ms","start":"2026-05-05T10:13:43.582155Z","end":"2026-05-05T10:13:43.69649Z","steps":["trace[1528667882] 'agreement among raft nodes before linearized reading' (duration: 114.126894ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.696299Z","caller":"traceutil/trace.go:171","msg":"trace[878662268] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"170.843695ms","start":"2026-05-05T10:13:43.525446Z","end":"2026-05-05T10:13:43.696289Z","steps":["trace[878662268] 'process raft request' (duration: 170.582654ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.764076Z","caller":"traceutil/trace.go:171","msg":"trace[1289799309] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"180.495254ms","start":"2026-05-05T10:13:43.583554Z","end":"2026-05-05T10:13:43.764049Z","steps":["trace[1289799309] 'process raft request' (duration: 180.348758ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.878297Z","caller":"traceutil/trace.go:171","msg":"trace[735124910] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"173.033176ms","start":"2026-05-05T10:13:43.705228Z","end":"2026-05-05T10:13:43.878261Z","steps":["trace[735124910] 'process raft request' (duration: 170.499821ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:43.934957Z","caller":"traceutil/trace.go:171","msg":"trace[1409136691] linearizableReadLoop","detail":"{readStateIndex:865; appliedIndex:863; }","duration":"161.186756ms","start":"2026-05-05T10:13:43.77372Z","end":"2026-05-05T10:13:43.934907Z","steps":["trace[1409136691] 'read index received' (duration: 101.901178ms)","trace[1409136691] 'applied index is now lower than readState.Index' (duration: 59.284498ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:43.935001Z","caller":"traceutil/trace.go:171","msg":"trace[5134257] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"166.573869ms","start":"2026-05-05T10:13:43.768379Z","end":"2026-05-05T10:13:43.934953Z","steps":["trace[5134257] 'process raft request' (duration: 166.380081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:13:43.935239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.458508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-05-05T10:13:43.935328Z","caller":"traceutil/trace.go:171","msg":"trace[429302590] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:836; }","duration":"161.605094ms","start":"2026-05-05T10:13:43.773672Z","end":"2026-05-05T10:13:43.935277Z","steps":["trace[429302590] 'agreement among raft nodes before linearized reading' (duration: 161.414836ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:44.152082Z","caller":"traceutil/trace.go:171","msg":"trace[1502971142] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:865; }","duration":"174.126167ms","start":"2026-05-05T10:13:43.977919Z","end":"2026-05-05T10:13:44.152045Z","steps":["trace[1502971142] 'read index received' (duration: 173.917839ms)","trace[1502971142] 'applied index is now lower than readState.Index' (duration: 206.998µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:44.152342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.382378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:13:44.152453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.788031ms","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-05T10:13:44.152474Z","caller":"traceutil/trace.go:171","msg":"trace[70931386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:837; }","duration":"174.565435ms","start":"2026-05-05T10:13:43.977892Z","end":"2026-05-05T10:13:44.152457Z","steps":["trace[70931386] 'agreement among raft nodes before linearized reading' (duration: 174.326895ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:44.152504Z","caller":"traceutil/trace.go:171","msg":"trace[2079615052] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:837; }","duration":"156.912016ms","start":"2026-05-05T10:13:43.995576Z","end":"2026-05-05T10:13:44.152488Z","steps":["trace[2079615052] 'agreement among raft nodes before linearized reading' (duration: 156.667016ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:44.152212Z","caller":"traceutil/trace.go:171","msg":"trace[1118879063] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"202.182386ms","start":"2026-05-05T10:13:43.94996Z","end":"2026-05-05T10:13:44.152143Z","steps":["trace[1118879063] 'process raft request' (duration: 201.885294ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:13:54.377692Z","caller":"traceutil/trace.go:171","msg":"trace[1383513020] transaction","detail":"{read_only:false; response_revision:948; number_of_response:1; }","duration":"128.944049ms","start":"2026-05-05T10:13:54.248712Z","end":"2026-05-05T10:13:54.377656Z","steps":["trace[1383513020] 'process raft request' (duration: 97.361673ms)","trace[1383513020] 'compare' (duration: 31.349797ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:13:54.377846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.144144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:13:54.377673Z","caller":"traceutil/trace.go:171","msg":"trace[784753367] linearizableReadLoop","detail":"{readStateIndex:980; appliedIndex:979; }","duration":"123.949977ms","start":"2026-05-05T10:13:54.253666Z","end":"2026-05-05T10:13:54.377616Z","steps":["trace[784753367] 'read index received' (duration: 92.31256ms)","trace[784753367] 'applied index is now lower than readState.Index' (duration: 31.635457ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:13:54.377911Z","caller":"traceutil/trace.go:171","msg":"trace[515112761] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:948; }","duration":"124.273479ms","start":"2026-05-05T10:13:54.253622Z","end":"2026-05-05T10:13:54.377896Z","steps":["trace[515112761] 'agreement among raft nodes before linearized reading' (duration: 124.131973ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:02.019533Z","caller":"traceutil/trace.go:171","msg":"trace[1270262963] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"173.853731ms","start":"2026-05-05T10:14:01.845634Z","end":"2026-05-05T10:14:02.019488Z","steps":["trace[1270262963] 'process raft request' (duration: 87.579586ms)","trace[1270262963] 'compare' (duration: 86.066218ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:14:04.43451Z","caller":"traceutil/trace.go:171","msg":"trace[788218151] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"119.858957ms","start":"2026-05-05T10:14:04.314627Z","end":"2026-05-05T10:14:04.434486Z","steps":["trace[788218151] 'process raft request' (duration: 119.66879ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:04.454902Z","caller":"traceutil/trace.go:171","msg":"trace[1240213595] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"140.03124ms","start":"2026-05-05T10:14:04.314848Z","end":"2026-05-05T10:14:04.45488Z","steps":["trace[1240213595] 'process raft request' (duration: 139.785102ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:04.769907Z","caller":"traceutil/trace.go:171","msg":"trace[2123103057] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"213.445ms","start":"2026-05-05T10:14:04.556431Z","end":"2026-05-05T10:14:04.769876Z","steps":["trace[2123103057] 'process raft request' (duration: 146.603983ms)","trace[2123103057] 'compare' (duration: 66.652951ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:14:06.966256Z","caller":"traceutil/trace.go:171","msg":"trace[805028050] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"190.505413ms","start":"2026-05-05T10:14:06.775732Z","end":"2026-05-05T10:14:06.966237Z","steps":["trace[805028050] 'process raft request' (duration: 190.334377ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:08.156161Z","caller":"traceutil/trace.go:171","msg":"trace[2097773560] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"138.2011ms","start":"2026-05-05T10:14:08.017934Z","end":"2026-05-05T10:14:08.156135Z","steps":["trace[2097773560] 'process raft request' (duration: 137.982393ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.747819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.210015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:14:08.747949Z","caller":"traceutil/trace.go:171","msg":"trace[1611127494] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"584.77663ms","start":"2026-05-05T10:14:08.163157Z","end":"2026-05-05T10:14:08.747934Z","steps":["trace[1611127494] 'read index received' (duration: 480.423831ms)","trace[1611127494] 'applied index is now lower than readState.Index' (duration: 104.351549ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:14:08.748019Z","caller":"traceutil/trace.go:171","msg":"trace[1186825840] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"586.616738ms","start":"2026-05-05T10:14:08.161392Z","end":"2026-05-05T10:14:08.748008Z","steps":["trace[1186825840] 'process raft request' (duration: 482.138665ms)","trace[1186825840] 'compare' (duration: 104.088721ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:14:08.748091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:14:08.161356Z","time spent":"586.7047ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:14:08.748392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.231475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-05-05T10:14:08.748435Z","caller":"traceutil/trace.go:171","msg":"trace[1973912441] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:991; }","duration":"585.284707ms","start":"2026-05-05T10:14:08.163138Z","end":"2026-05-05T10:14:08.748422Z","steps":["trace[1973912441] 'agreement among raft nodes before linearized reading' (duration: 585.151402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.748468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:14:08.16313Z","time spent":"585.331398ms","remote":"127.0.0.1:57132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":2951,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-05-05T10:14:08.824327Z","caller":"traceutil/trace.go:171","msg":"trace[901516207] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"226.209972ms","start":"2026-05-05T10:14:08.598086Z","end":"2026-05-05T10:14:08.824296Z","steps":["trace[901516207] 'process raft request' (duration: 225.673055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.825241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.510145ms","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-05T10:14:08.825309Z","caller":"traceutil/trace.go:171","msg":"trace[1680738789] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:992; }","duration":"288.629809ms","start":"2026-05-05T10:14:08.536663Z","end":"2026-05-05T10:14:08.825293Z","steps":["trace[1680738789] 'agreement among raft nodes before linearized reading' (duration: 288.412902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.825545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.065013ms","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-05T10:14:08.825588Z","caller":"traceutil/trace.go:171","msg":"trace[1567403017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:992; }","duration":"280.129635ms","start":"2026-05-05T10:14:08.54545Z","end":"2026-05-05T10:14:08.82558Z","steps":["trace[1567403017] 'agreement among raft nodes before linearized reading' (duration: 280.036533ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.825711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.199525ms","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-05T10:14:08.82574Z","caller":"traceutil/trace.go:171","msg":"trace[2083639662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:992; }","duration":"288.241197ms","start":"2026-05-05T10:14:08.537489Z","end":"2026-05-05T10:14:08.82573Z","steps":["trace[2083639662] 'agreement among raft nodes before linearized reading' (duration: 288.167285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.82585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.544786ms","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-05T10:14:08.825876Z","caller":"traceutil/trace.go:171","msg":"trace[1096555740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:992; }","duration":"288.609088ms","start":"2026-05-05T10:14:08.53726Z","end":"2026-05-05T10:14:08.825869Z","steps":["trace[1096555740] 'agreement among raft nodes before linearized reading' (duration: 288.540366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.825987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.039512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T10:14:08.826016Z","caller":"traceutil/trace.go:171","msg":"trace[1434321077] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:992; }","duration":"385.117494ms","start":"2026-05-05T10:14:08.440891Z","end":"2026-05-05T10:14:08.826008Z","steps":["trace[1434321077] 'agreement among raft nodes before linearized reading' (duration: 385.065362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:08.826052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:14:08.440843Z","time spent":"385.200137ms","remote":"127.0.0.1:57360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-05T10:14:08.945532Z","caller":"traceutil/trace.go:171","msg":"trace[823760029] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"117.187737ms","start":"2026-05-05T10:14:08.8283Z","end":"2026-05-05T10:14:08.945488Z","steps":["trace[823760029] 'process raft request' (duration: 116.875267ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:09.016032Z","caller":"traceutil/trace.go:171","msg":"trace[1360035970] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"184.607765ms","start":"2026-05-05T10:14:08.831374Z","end":"2026-05-05T10:14:09.015981Z","steps":["trace[1360035970] 'process raft request' (duration: 184.130681ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:09.016315Z","caller":"traceutil/trace.go:171","msg":"trace[393011815] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"184.659896ms","start":"2026-05-05T10:14:08.831589Z","end":"2026-05-05T10:14:09.016249Z","steps":["trace[393011815] 'process raft request' (duration: 184.305546ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:09.01619Z","caller":"traceutil/trace.go:171","msg":"trace[784971852] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"182.382756ms","start":"2026-05-05T10:14:08.833781Z","end":"2026-05-05T10:14:09.016164Z","steps":["trace[784971852] 'process raft request' (duration: 182.282623ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:09.017695Z","caller":"traceutil/trace.go:171","msg":"trace[1514164865] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"184.310056ms","start":"2026-05-05T10:14:08.831242Z","end":"2026-05-05T10:14:09.015552Z","steps":["trace[1514164865] 'process raft request' (duration: 184.046028ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:53.477373Z","caller":"traceutil/trace.go:171","msg":"trace[66653210] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"109.411635ms","start":"2026-05-05T10:14:53.36793Z","end":"2026-05-05T10:14:53.477342Z","steps":["trace[66653210] 'process raft request' (duration: 109.195981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:59.964938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.328123ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:14:59.965087Z","caller":"traceutil/trace.go:171","msg":"trace[1636233795] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1164; }","duration":"161.502426ms","start":"2026-05-05T10:14:59.803566Z","end":"2026-05-05T10:14:59.965069Z","steps":["trace[1636233795] 'range keys from in-memory index tree' (duration: 161.281652ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:14:59.9653Z","caller":"traceutil/trace.go:171","msg":"trace[670769445] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"326.673054ms","start":"2026-05-05T10:14:59.638599Z","end":"2026-05-05T10:14:59.965272Z","steps":["trace[670769445] 'process raft request' (duration: 318.929085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:14:59.965437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:14:59.638578Z","time spent":"326.789616ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:14:59.996418Z","caller":"traceutil/trace.go:171","msg":"trace[2097626186] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"150.516025ms","start":"2026-05-05T10:14:59.845856Z","end":"2026-05-05T10:14:59.996372Z","steps":["trace[2097626186] 'process raft request' (duration: 150.30003ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:15:26.119402Z","caller":"traceutil/trace.go:171","msg":"trace[801264705] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1333; }","duration":"196.415971ms","start":"2026-05-05T10:15:25.922958Z","end":"2026-05-05T10:15:26.119374Z","steps":["trace[801264705] 'read index received' (duration: 196.324679ms)","trace[801264705] 'applied index is now lower than readState.Index' (duration: 89.822µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:15:26.119558Z","caller":"traceutil/trace.go:171","msg":"trace[834209527] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"234.832919ms","start":"2026-05-05T10:15:25.884713Z","end":"2026-05-05T10:15:26.119546Z","steps":["trace[834209527] 'process raft request' (duration: 234.492664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:15:26.119799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.823207ms","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-05T10:15:26.119846Z","caller":"traceutil/trace.go:171","msg":"trace[543596017] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"196.940269ms","start":"2026-05-05T10:15:25.922893Z","end":"2026-05-05T10:15:26.119833Z","steps":["trace[543596017] 'agreement among raft nodes before linearized reading' (duration: 196.794477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:15:26.12001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.058408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:15:26.120052Z","caller":"traceutil/trace.go:171","msg":"trace[1400179833] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1282; }","duration":"106.138008ms","start":"2026-05-05T10:15:26.013901Z","end":"2026-05-05T10:15:26.120039Z","steps":["trace[1400179833] 'agreement among raft nodes before linearized reading' (duration: 106.075367ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:15:26.120076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.622711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:15:26.120205Z","caller":"traceutil/trace.go:171","msg":"trace[1954090511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1282; }","duration":"143.871884ms","start":"2026-05-05T10:15:25.976303Z","end":"2026-05-05T10:15:26.120175Z","steps":["trace[1954090511] 'agreement among raft nodes before linearized reading' (duration: 143.6174ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:15:34.555975Z","caller":"traceutil/trace.go:171","msg":"trace[1928979218] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"387.87791ms","start":"2026-05-05T10:15:34.168067Z","end":"2026-05-05T10:15:34.555945Z","steps":["trace[1928979218] 'process raft request' (duration: 344.965375ms)","trace[1928979218] 'compare' (duration: 42.60013ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:15:34.556146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:34.168053Z","time spent":"388.003042ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:15:34.583031Z","caller":"traceutil/trace.go:171","msg":"trace[1701579338] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"338.723809ms","start":"2026-05-05T10:15:34.244276Z","end":"2026-05-05T10:15:34.583Z","steps":["trace[1701579338] 'process raft request' (duration: 338.422925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:15:34.583208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:15:34.244249Z","time spent":"338.860511ms","remote":"127.0.0.1:57156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"}