{"level":"warn","ts":"2026-06-11T06:51:05.596997Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:51:05.597081Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-11T06:51:05.597142Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T06:51:05.597153Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-11T06:51:05.597171Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T06:51:05.597795Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-11T06:51:05.597884Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-11T06:51:05.601697Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.627479ms"} {"level":"info","ts":"2026-06-11T06:51:05.607113Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-11T06:51:05.607247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-11T06:51:05.6074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-11T06:51:05.60749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-11T06:51:05.607568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-11T06:51:05.607673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-11T06:51:05.612799Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-11T06:51:05.614401Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-11T06:51:05.615933Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-11T06:51:05.619492Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-11T06:51:05.619611Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-11T06:51:05.619867Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:51:05.620082Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:51:05.620173Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-11T06:51:05.62195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-11T06:51:05.622167Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-11T06:51:05.624456Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-11T06:51:05.62462Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-11T06:51:05.62468Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-11T06:51:05.624911Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-11T06:51:05.624975Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-11T06:51:06.308345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-11T06:51:06.308392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-11T06:51:06.308423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-11T06:51:06.308437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-11T06:51:06.308445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-11T06:51:06.308455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-11T06:51:06.308465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-11T06:51:06.309523Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-11T06:51:06.309537Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:51:06.309572Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:51:06.309665Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T06:51:06.310559Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:51:06.310754Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:51:06.310796Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T06:51:06.312061Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-11T06:51:06.312628Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-11T06:51:06.312655Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-11T06:51:06.312771Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-11T06:51:32.598712Z","caller":"traceutil/trace.go:171","msg":"trace[170666342] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"146.12431ms","start":"2026-06-11T06:51:32.452557Z","end":"2026-06-11T06:51:32.598681Z","steps":["trace[170666342] 'process raft request' (duration: 145.931905ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:51:39.843448Z","caller":"traceutil/trace.go:171","msg":"trace[444396340] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"134.649669ms","start":"2026-06-11T06:51:39.708773Z","end":"2026-06-11T06:51:39.843423Z","steps":["trace[444396340] 'process raft request' (duration: 134.102346ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:51:42.767216Z","caller":"traceutil/trace.go:171","msg":"trace[1326193282] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"122.512841ms","start":"2026-06-11T06:51:42.644675Z","end":"2026-06-11T06:51:42.767188Z","steps":["trace[1326193282] 'process raft request' (duration: 122.339297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:48.843953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.415652ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:51:48.844397Z","caller":"traceutil/trace.go:171","msg":"trace[730816348] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"215.386487ms","start":"2026-06-11T06:51:48.628979Z","end":"2026-06-11T06:51:48.844365Z","steps":["trace[730816348] 'process raft request' (duration: 95.540961ms)","trace[730816348] 'compare' (duration: 118.147314ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:51:49.334189Z","caller":"traceutil/trace.go:171","msg":"trace[980552712] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"212.24538ms","start":"2026-06-11T06:51:49.121927Z","end":"2026-06-11T06:51:49.334172Z","steps":["trace[980552712] 'process raft request' (duration: 212.132527ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:51:49.382299Z","caller":"traceutil/trace.go:171","msg":"trace[677931397] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"219.304013ms","start":"2026-06-11T06:51:49.162964Z","end":"2026-06-11T06:51:49.382268Z","steps":["trace[677931397] 'process raft request' (duration: 219.110738ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:51:49.384152Z","caller":"traceutil/trace.go:171","msg":"trace[1094701028] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:608; }","duration":"183.26785ms","start":"2026-06-11T06:51:49.200834Z","end":"2026-06-11T06:51:49.384102Z","steps":["trace[1094701028] 'read index received' (duration: 133.298006ms)","trace[1094701028] 'applied index is now lower than readState.Index' (duration: 49.968954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:51:49.384359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.472195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T06:51:49.388434Z","caller":"traceutil/trace.go:171","msg":"trace[33891387] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:589; }","duration":"183.634219ms","start":"2026-06-11T06:51:49.20079Z","end":"2026-06-11T06:51:49.384424Z","steps":["trace[33891387] 'agreement among raft nodes before linearized reading' (duration: 183.423424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:50.387464Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408088636,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:51:50.62969Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.186881978s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-11T06:51:50.651284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.250830753s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-11T06:51:50.651841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:49.38959Z","time spent":"1.262246982s","remote":"127.0.0.1:44522","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-11T06:51:50.651985Z","caller":"traceutil/trace.go:171","msg":"trace[1191918034] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"1.209270035s","start":"2026-06-11T06:51:49.442682Z","end":"2026-06-11T06:51:50.651952Z","steps":["trace[1191918034] 'process raft request' (duration: 1.208736692s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:50.652246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:49.442657Z","time spent":"1.209451169s","remote":"127.0.0.1:45040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:51:50.653365Z","caller":"traceutil/trace.go:171","msg":"trace[1552199869] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:611; }","duration":"766.715192ms","start":"2026-06-11T06:51:49.886634Z","end":"2026-06-11T06:51:50.653349Z","steps":["trace[1552199869] 'read index received' (duration: 743.305751ms)","trace[1552199869] 'applied index is now lower than readState.Index' (duration: 23.408071ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:51:50.65349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.853385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:51:50.653515Z","caller":"traceutil/trace.go:171","msg":"trace[451719646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"766.921217ms","start":"2026-06-11T06:51:49.886586Z","end":"2026-06-11T06:51:50.653507Z","steps":["trace[451719646] 'agreement among raft nodes before linearized reading' (duration: 766.842115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:50.653537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:49.886566Z","time spent":"766.966059ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:51:50.653594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.688382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T06:51:50.653706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.370772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:51:50.6537Z","caller":"traceutil/trace.go:171","msg":"trace[1053397318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"715.832295ms","start":"2026-06-11T06:51:49.937841Z","end":"2026-06-11T06:51:50.653673Z","steps":["trace[1053397318] 'agreement among raft nodes before linearized reading' (duration: 715.686712ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:51:50.653733Z","caller":"traceutil/trace.go:171","msg":"trace[786897224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:590; }","duration":"559.425314ms","start":"2026-06-11T06:51:50.094302Z","end":"2026-06-11T06:51:50.653727Z","steps":["trace[786897224] 'agreement among raft nodes before linearized reading' (duration: 559.340721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:50.653752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:50.094281Z","time spent":"559.466875ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:51:50.653754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:49.937812Z","time spent":"715.930378ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:51:50.655896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.750514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:51:50.656717Z","caller":"traceutil/trace.go:171","msg":"trace[1226846559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"676.690896ms","start":"2026-06-11T06:51:49.980012Z","end":"2026-06-11T06:51:50.656703Z","steps":["trace[1226846559] 'agreement among raft nodes before linearized reading' (duration: 673.714034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:51:50.656759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:51:49.97998Z","time spent":"676.770128ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-11T06:51:52.441836Z","caller":"traceutil/trace.go:171","msg":"trace[1830958126] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"177.097106ms","start":"2026-06-11T06:51:52.264716Z","end":"2026-06-11T06:51:52.441813Z","steps":["trace[1830958126] 'process raft request' (duration: 176.933052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:05.496358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.438086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5sfhb\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-06-11T06:52:05.49644Z","caller":"traceutil/trace.go:171","msg":"trace[290752942] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-5sfhb; range_end:; response_count:1; response_revision:749; }","duration":"293.577049ms","start":"2026-06-11T06:52:05.202845Z","end":"2026-06-11T06:52:05.496422Z","steps":["trace[290752942] 'range keys from in-memory index tree' (duration: 293.21131ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:05.634522Z","caller":"traceutil/trace.go:171","msg":"trace[1898635485] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"130.535458ms","start":"2026-06-11T06:52:05.503961Z","end":"2026-06-11T06:52:05.634497Z","steps":["trace[1898635485] 'process raft request' (duration: 130.083927ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:40.261116Z","caller":"traceutil/trace.go:171","msg":"trace[1048488013] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"148.938187ms","start":"2026-06-11T06:52:40.112148Z","end":"2026-06-11T06:52:40.261086Z","steps":["trace[1048488013] 'process raft request' (duration: 148.746183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.420331Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408089418,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:52:41.502654Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.228502312s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:52:41.503309Z","caller":"traceutil/trace.go:171","msg":"trace[437951358] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"1.229198599s","start":"2026-06-11T06:52:40.274065Z","end":"2026-06-11T06:52:41.503263Z","steps":["trace[437951358] 'process raft request' (duration: 1.228972194s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.503772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:40.274045Z","time spent":"1.229378044s","remote":"127.0.0.1:44786","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-06-11T06:52:41.528567Z","caller":"traceutil/trace.go:171","msg":"trace[1427802846] linearizableReadLoop","detail":"{readStateIndex:1010; appliedIndex:1008; }","duration":"608.895981ms","start":"2026-06-11T06:52:40.919638Z","end":"2026-06-11T06:52:41.528534Z","steps":["trace[1427802846] 'read index received' (duration: 583.334706ms)","trace[1427802846] 'applied index is now lower than readState.Index' (duration: 25.560465ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:52:41.528657Z","caller":"traceutil/trace.go:171","msg":"trace[285957781] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"1.169430821s","start":"2026-06-11T06:52:40.35919Z","end":"2026-06-11T06:52:41.528621Z","steps":["trace[285957781] 'process raft request' (duration: 1.169183435s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.528804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.157897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-11T06:52:41.52884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:40.359159Z","time spent":"1.169575684s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:52:41.528873Z","caller":"traceutil/trace.go:171","msg":"trace[907946031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"609.25485ms","start":"2026-06-11T06:52:40.919599Z","end":"2026-06-11T06:52:41.528853Z","steps":["trace[907946031] 'agreement among raft nodes before linearized reading' (duration: 609.045175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.528896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.307359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-11T06:52:41.528916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:40.919581Z","time spent":"609.326991ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-11T06:52:41.528941Z","caller":"traceutil/trace.go:171","msg":"trace[924788659] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:973; }","duration":"396.39162ms","start":"2026-06-11T06:52:41.132538Z","end":"2026-06-11T06:52:41.528929Z","steps":["trace[924788659] 'agreement among raft nodes before linearized reading' (duration: 396.209436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.528979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:41.132519Z","time spent":"396.452832ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T06:52:41.528999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.455786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:52:41.529095Z","caller":"traceutil/trace.go:171","msg":"trace[864991564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:973; }","duration":"562.58395ms","start":"2026-06-11T06:52:40.966488Z","end":"2026-06-11T06:52:41.529072Z","steps":["trace[864991564] 'agreement among raft nodes before linearized reading' (duration: 562.307783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.529153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:40.966439Z","time spent":"562.702183ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:52:41.52918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.518395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:52:41.529211Z","caller":"traceutil/trace.go:171","msg":"trace[1118667652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:973; }","duration":"584.573717ms","start":"2026-06-11T06:52:40.944627Z","end":"2026-06-11T06:52:41.529201Z","steps":["trace[1118667652] 'agreement among raft nodes before linearized reading' (duration: 584.093715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:41.529247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:40.944609Z","time spent":"584.631858ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-11T06:52:41.740462Z","caller":"traceutil/trace.go:171","msg":"trace[903482871] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"206.624647ms","start":"2026-06-11T06:52:41.533806Z","end":"2026-06-11T06:52:41.740431Z","steps":["trace[903482871] 'process raft request' (duration: 176.148922ms)","trace[903482871] 'compare' (duration: 30.314341ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:52:41.740821Z","caller":"traceutil/trace.go:171","msg":"trace[2082980129] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"206.809531ms","start":"2026-06-11T06:52:41.534002Z","end":"2026-06-11T06:52:41.740811Z","steps":["trace[2082980129] 'process raft request' (duration: 206.386461ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:41.740854Z","caller":"traceutil/trace.go:171","msg":"trace[1100313292] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"206.342999ms","start":"2026-06-11T06:52:41.534485Z","end":"2026-06-11T06:52:41.740828Z","steps":["trace[1100313292] 'process raft request' (duration: 206.290868ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:41.740984Z","caller":"traceutil/trace.go:171","msg":"trace[274315322] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"206.844782ms","start":"2026-06-11T06:52:41.534082Z","end":"2026-06-11T06:52:41.740927Z","steps":["trace[274315322] 'process raft request' (duration: 206.577705ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:43.914602Z","caller":"traceutil/trace.go:171","msg":"trace[396546452] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"165.076421ms","start":"2026-06-11T06:52:43.749503Z","end":"2026-06-11T06:52:43.91458Z","steps":["trace[396546452] 'process raft request' (duration: 164.869306ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:43.914694Z","caller":"traceutil/trace.go:171","msg":"trace[1193263721] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"164.60354ms","start":"2026-06-11T06:52:43.750077Z","end":"2026-06-11T06:52:43.914681Z","steps":["trace[1193263721] 'process raft request' (duration: 164.441136ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:43.9146Z","caller":"traceutil/trace.go:171","msg":"trace[466940065] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"165.01623ms","start":"2026-06-11T06:52:43.749534Z","end":"2026-06-11T06:52:43.91455Z","steps":["trace[466940065] 'process raft request' (duration: 164.949398ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:44.384081Z","caller":"traceutil/trace.go:171","msg":"trace[1517464880] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"104.476002ms","start":"2026-06-11T06:52:44.27957Z","end":"2026-06-11T06:52:44.384046Z","steps":["trace[1517464880] 'read index received' (duration: 20.294816ms)","trace[1517464880] 'applied index is now lower than readState.Index' (duration: 84.179296ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:52:44.384278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.700467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T06:52:44.384343Z","caller":"traceutil/trace.go:171","msg":"trace[505074815] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:984; }","duration":"104.774999ms","start":"2026-06-11T06:52:44.279552Z","end":"2026-06-11T06:52:44.384327Z","steps":["trace[505074815] 'agreement among raft nodes before linearized reading' (duration: 104.591364ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:52:55.995143Z","caller":"traceutil/trace.go:171","msg":"trace[1400519902] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"195.073179ms","start":"2026-06-11T06:52:55.800048Z","end":"2026-06-11T06:52:55.995121Z","steps":["trace[1400519902] 'read index received' (duration: 194.894305ms)","trace[1400519902] 'applied index is now lower than readState.Index' (duration: 177.834µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:52:55.995175Z","caller":"traceutil/trace.go:171","msg":"trace[1644720222] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"347.558156ms","start":"2026-06-11T06:52:55.647602Z","end":"2026-06-11T06:52:55.99516Z","steps":["trace[1644720222] 'process raft request' (duration: 347.397362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:55.995252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.185372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:52:55.995285Z","caller":"traceutil/trace.go:171","msg":"trace[643356491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1019; }","duration":"195.261524ms","start":"2026-06-11T06:52:55.800014Z","end":"2026-06-11T06:52:55.995276Z","steps":["trace[643356491] 'agreement among raft nodes before linearized reading' (duration: 195.191182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:52:55.995336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:52:55.647573Z","time spent":"347.686949ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:52:55.995586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.03992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:52:55.995664Z","caller":"traceutil/trace.go:171","msg":"trace[1275304006] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1019; }","duration":"179.166724ms","start":"2026-06-11T06:52:55.816473Z","end":"2026-06-11T06:52:55.99564Z","steps":["trace[1275304006] 'agreement among raft nodes before linearized reading' (duration: 178.934608ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:06.263556Z","caller":"traceutil/trace.go:171","msg":"trace[432865359] linearizableReadLoop","detail":"{readStateIndex:1095; appliedIndex:1094; }","duration":"123.997937ms","start":"2026-06-11T06:53:06.139531Z","end":"2026-06-11T06:53:06.263529Z","steps":["trace[432865359] 'read index received' (duration: 123.750321ms)","trace[432865359] 'applied index is now lower than readState.Index' (duration: 245.995µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:06.263763Z","caller":"traceutil/trace.go:171","msg":"trace[840267439] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"145.728792ms","start":"2026-06-11T06:53:06.118004Z","end":"2026-06-11T06:53:06.263733Z","steps":["trace[840267439] 'process raft request' (duration: 145.382804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:06.263973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.422287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-11T06:53:06.264571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.891204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-11T06:53:06.26458Z","caller":"traceutil/trace.go:171","msg":"trace[813621303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1053; }","duration":"125.065962ms","start":"2026-06-11T06:53:06.139493Z","end":"2026-06-11T06:53:06.264559Z","steps":["trace[813621303] 'agreement among raft nodes before linearized reading' (duration: 124.360935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:06.264573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.012867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-11T06:53:06.264986Z","caller":"traceutil/trace.go:171","msg":"trace[1055356465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1053; }","duration":"124.546879ms","start":"2026-06-11T06:53:06.140419Z","end":"2026-06-11T06:53:06.264966Z","steps":["trace[1055356465] 'agreement among raft nodes before linearized reading' (duration: 123.975025ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:06.264651Z","caller":"traceutil/trace.go:171","msg":"trace[574199465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1053; }","duration":"124.023587ms","start":"2026-06-11T06:53:06.140606Z","end":"2026-06-11T06:53:06.26463Z","steps":["trace[574199465] 'agreement among raft nodes before linearized reading' (duration: 123.804382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:08.583998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.96076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:53:08.584354Z","caller":"traceutil/trace.go:171","msg":"trace[1801054587] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"223.931139ms","start":"2026-06-11T06:53:08.360376Z","end":"2026-06-11T06:53:08.584307Z","steps":["trace[1801054587] 'process raft request' (duration: 105.536378ms)","trace[1801054587] 'compare' (duration: 117.844377ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:08.584399Z","caller":"traceutil/trace.go:171","msg":"trace[726224359] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"223.56988ms","start":"2026-06-11T06:53:08.360783Z","end":"2026-06-11T06:53:08.584353Z","steps":["trace[726224359] 'process raft request' (duration: 223.358895ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:09.471732Z","caller":"traceutil/trace.go:171","msg":"trace[415982463] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"140.994389ms","start":"2026-06-11T06:53:09.3307Z","end":"2026-06-11T06:53:09.471695Z","steps":["trace[415982463] 'process raft request' (duration: 64.620227ms)","trace[415982463] 'compare' (duration: 76.218648ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:26.4678Z","caller":"traceutil/trace.go:171","msg":"trace[158078072] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"279.120507ms","start":"2026-06-11T06:53:26.188648Z","end":"2026-06-11T06:53:26.467769Z","steps":["trace[158078072] 'process raft request' (duration: 278.932192ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:26.804702Z","caller":"traceutil/trace.go:171","msg":"trace[2105635917] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1218; }","duration":"112.859636ms","start":"2026-06-11T06:53:26.691789Z","end":"2026-06-11T06:53:26.804649Z","steps":["trace[2105635917] 'read index received' (duration: 103.96561ms)","trace[2105635917] 'applied index is now lower than readState.Index' (duration: 8.892356ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:26.804861Z","caller":"traceutil/trace.go:171","msg":"trace[765974971] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"240.299705ms","start":"2026-06-11T06:53:26.564544Z","end":"2026-06-11T06:53:26.804844Z","steps":["trace[765974971] 'process raft request' (duration: 231.166274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:26.804995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.215853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:53:26.805079Z","caller":"traceutil/trace.go:171","msg":"trace[310229139] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1171; }","duration":"108.336646ms","start":"2026-06-11T06:53:26.696722Z","end":"2026-06-11T06:53:26.805059Z","steps":["trace[310229139] 'agreement among raft nodes before linearized reading' (duration: 108.147022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:26.805226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.44009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:53:26.805248Z","caller":"traceutil/trace.go:171","msg":"trace[1118727324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1171; }","duration":"113.508832ms","start":"2026-06-11T06:53:26.691733Z","end":"2026-06-11T06:53:26.805242Z","steps":["trace[1118727324] 'agreement among raft nodes before linearized reading' (duration: 113.450731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:27.438976Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408089904,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:53:27.939756Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408089904,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:53:28.32777Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.518337439s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-11T06:53:28.938815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000490956s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-11T06:53:28.938952Z","caller":"traceutil/trace.go:171","msg":"trace[1189241286] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000717583s","start":"2026-06-11T06:53:26.938206Z","end":"2026-06-11T06:53:28.938923Z","steps":["trace[1189241286] 'agreement among raft nodes before linearized reading' (duration: 2.000533898s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:28.939009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:26.938174Z","time spent":"2.000822565s","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:53:29.384948Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.057028284s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-11T06:53:30.374143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.248867472s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:30.374826Z","caller":"traceutil/trace.go:171","msg":"trace[1383390907] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1171; }","duration":"3.249562718s","start":"2026-06-11T06:53:27.125239Z","end":"2026-06-11T06:53:30.374801Z","steps":["trace[1383390907] 'range keys from in-memory index tree' (duration: 3.24884684s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.374846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.04683791s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:53:30.375118Z","caller":"traceutil/trace.go:171","msg":"trace[1795053693] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"3.564558085s","start":"2026-06-11T06:53:26.810542Z","end":"2026-06-11T06:53:30.3751Z","steps":["trace[1795053693] 'process raft request' (duration: 3.564391911s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:30.375102Z","caller":"traceutil/trace.go:171","msg":"trace[342280765] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"3.565714792s","start":"2026-06-11T06:53:26.809356Z","end":"2026-06-11T06:53:30.37507Z","steps":["trace[342280765] 'process raft request' (duration: 1.518581285s)","trace[342280765] 'compare' (duration: 2.045955048s)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:30.375218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:26.810533Z","time spent":"3.564634716s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:30.37525Z","caller":"traceutil/trace.go:171","msg":"trace[1217697803] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"3.564523563s","start":"2026-06-11T06:53:26.81067Z","end":"2026-06-11T06:53:30.375194Z","steps":["trace[1217697803] 'process raft request' (duration: 3.56438204s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.375477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:26.810637Z","time spent":"3.564717128s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:30.375502Z","caller":"traceutil/trace.go:171","msg":"trace[279625234] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"1.901075287s","start":"2026-06-11T06:53:28.474411Z","end":"2026-06-11T06:53:30.375486Z","steps":["trace[279625234] 'process raft request' (duration: 1.900877442s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.375582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:28.474387Z","time spent":"1.901153288s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:53:30.375289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:26.80933Z","time spent":"3.565863626s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:30.375679Z","caller":"traceutil/trace.go:171","msg":"trace[425170809] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1219; }","duration":"3.437384541s","start":"2026-06-11T06:53:26.938278Z","end":"2026-06-11T06:53:30.375663Z","steps":["trace[425170809] 'read index received' (duration: 1.38967055s)","trace[425170809] 'applied index is now lower than readState.Index' (duration: 2.047713011s)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:30.375791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.16470559s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:53:30.375822Z","caller":"traceutil/trace.go:171","msg":"trace[186790043] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1175; }","duration":"3.164778712s","start":"2026-06-11T06:53:27.211031Z","end":"2026-06-11T06:53:30.375809Z","steps":["trace[186790043] 'agreement among raft nodes before linearized reading' (duration: 3.164724681s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.375852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:27.211002Z","time spent":"3.164842084s","remote":"127.0.0.1:37474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:53:30.376245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.436517295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:30.376295Z","caller":"traceutil/trace.go:171","msg":"trace[938053631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1175; }","duration":"1.436597747s","start":"2026-06-11T06:53:28.939681Z","end":"2026-06-11T06:53:30.376278Z","steps":["trace[938053631] 'agreement among raft nodes before linearized reading' (duration: 1.436509705s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.37633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:28.939663Z","time spent":"1.436660819s","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:53:30.376687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.767581982s","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-06-11T06:53:30.376719Z","caller":"traceutil/trace.go:171","msg":"trace[941412673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1175; }","duration":"1.767696715s","start":"2026-06-11T06:53:28.609012Z","end":"2026-06-11T06:53:30.376708Z","steps":["trace[941412673] 'agreement among raft nodes before linearized reading' (duration: 1.767532061s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.376715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568071215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-11T06:53:30.376748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:28.608974Z","time spent":"1.767767157s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-11T06:53:30.376767Z","caller":"traceutil/trace.go:171","msg":"trace[1639459556] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1175; }","duration":"1.568160687s","start":"2026-06-11T06:53:28.808593Z","end":"2026-06-11T06:53:30.376754Z","steps":["trace[1639459556] 'agreement among raft nodes before linearized reading' (duration: 1.567511671s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.376803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:28.808566Z","time spent":"1.568229999s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:53:30.380835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174144964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T06:53:30.380888Z","caller":"traceutil/trace.go:171","msg":"trace[354865571] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1175; }","duration":"1.174201676s","start":"2026-06-11T06:53:29.206674Z","end":"2026-06-11T06:53:30.380876Z","steps":["trace[354865571] 'agreement among raft nodes before linearized reading' (duration: 1.169329908s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:30.38092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:29.206624Z","time spent":"1.174288849s","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"info","ts":"2026-06-11T06:53:46.684225Z","caller":"traceutil/trace.go:171","msg":"trace[1877924802] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"109.36152ms","start":"2026-06-11T06:53:46.574819Z","end":"2026-06-11T06:53:46.68418Z","steps":["trace[1877924802] 'process raft request' (duration: 68.89779ms)","trace[1877924802] 'compare' (duration: 40.210774ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:46.684453Z","caller":"traceutil/trace.go:171","msg":"trace[520569442] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"107.589848ms","start":"2026-06-11T06:53:46.576829Z","end":"2026-06-11T06:53:46.684418Z","steps":["trace[520569442] 'process raft request' (duration: 107.2724ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:46.684662Z","caller":"traceutil/trace.go:171","msg":"trace[609436361] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"107.583018ms","start":"2026-06-11T06:53:46.577072Z","end":"2026-06-11T06:53:46.684655Z","steps":["trace[609436361] 'process raft request' (duration: 107.206529ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:46.684661Z","caller":"traceutil/trace.go:171","msg":"trace[24386867] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1279; }","duration":"107.047525ms","start":"2026-06-11T06:53:46.577555Z","end":"2026-06-11T06:53:46.684602Z","steps":["trace[24386867] 'read index received' (duration: 66.179414ms)","trace[24386867] 'applied index is now lower than readState.Index' (duration: 40.866161ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:46.685048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.862281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:53:46.685091Z","caller":"traceutil/trace.go:171","msg":"trace[155986886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1230; }","duration":"106.938542ms","start":"2026-06-11T06:53:46.578143Z","end":"2026-06-11T06:53:46.685082Z","steps":["trace[155986886] 'agreement among raft nodes before linearized reading' (duration: 106.731157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:46.685136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.543777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:53:46.685191Z","caller":"traceutil/trace.go:171","msg":"trace[1939479184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1230; }","duration":"107.65889ms","start":"2026-06-11T06:53:46.57752Z","end":"2026-06-11T06:53:46.685179Z","steps":["trace[1939479184] 'agreement among raft nodes before linearized reading' (duration: 107.296671ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:46.845803Z","caller":"traceutil/trace.go:171","msg":"trace[1483699059] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"154.465955ms","start":"2026-06-11T06:53:46.691299Z","end":"2026-06-11T06:53:46.845765Z","steps":["trace[1483699059] 'process raft request' (duration: 110.5207ms)","trace[1483699059] 'compare' (duration: 43.75865ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:49.133433Z","caller":"traceutil/trace.go:171","msg":"trace[448772048] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1284; }","duration":"442.933848ms","start":"2026-06-11T06:53:48.690479Z","end":"2026-06-11T06:53:49.133413Z","steps":["trace[448772048] 'read index received' (duration: 442.732643ms)","trace[448772048] 'applied index is now lower than readState.Index' (duration: 200.625µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:49.133841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.328708ms","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-06-11T06:53:49.133926Z","caller":"traceutil/trace.go:171","msg":"trace[1314160540] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"443.471281ms","start":"2026-06-11T06:53:48.690432Z","end":"2026-06-11T06:53:49.133904Z","steps":["trace[1314160540] 'agreement among raft nodes before linearized reading' (duration: 443.171974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.133982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:48.690414Z","time spent":"443.556263ms","remote":"127.0.0.1:44786","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-06-11T06:53:49.134039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.516579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:53:49.13408Z","caller":"traceutil/trace.go:171","msg":"trace[732666528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"442.61114ms","start":"2026-06-11T06:53:48.69146Z","end":"2026-06-11T06:53:49.134071Z","steps":["trace[732666528] 'agreement among raft nodes before linearized reading' (duration: 442.432976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.134395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.861782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:53:49.134958Z","caller":"traceutil/trace.go:171","msg":"trace[843246436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1233; }","duration":"284.465547ms","start":"2026-06-11T06:53:48.850477Z","end":"2026-06-11T06:53:49.134942Z","steps":["trace[843246436] 'agreement among raft nodes before linearized reading' (duration: 283.832211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.134925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:48.691449Z","time spent":"443.4208ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T06:53:49.134534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.00692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:53:49.135189Z","caller":"traceutil/trace.go:171","msg":"trace[349890500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"443.674136ms","start":"2026-06-11T06:53:48.691499Z","end":"2026-06-11T06:53:49.135173Z","steps":["trace[349890500] 'agreement among raft nodes before linearized reading' (duration: 442.941378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.135229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:48.691494Z","time spent":"443.722337ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-11T06:53:49.134558Z","caller":"traceutil/trace.go:171","msg":"trace[2120319525] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"592.633458ms","start":"2026-06-11T06:53:48.541868Z","end":"2026-06-11T06:53:49.134501Z","steps":["trace[2120319525] 'process raft request' (duration: 591.416578ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.135356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:48.541844Z","time spent":"593.437777ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:53:49.135539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.9088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:53:49.135602Z","caller":"traceutil/trace.go:171","msg":"trace[389550966] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"375.003772ms","start":"2026-06-11T06:53:48.760578Z","end":"2026-06-11T06:53:49.135581Z","steps":["trace[389550966] 'agreement among raft nodes before linearized reading' (duration: 373.841814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:49.135635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:48.76056Z","time spent":"375.063803ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-11T06:53:49.708869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090063,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:53:50.10156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.519388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:53:50.1017Z","caller":"traceutil/trace.go:171","msg":"trace[120380609] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"961.608162ms","start":"2026-06-11T06:53:49.140067Z","end":"2026-06-11T06:53:50.101675Z","steps":["trace[120380609] 'process raft request' (duration: 723.866168ms)","trace[120380609] 'compare' (duration: 237.227952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:50.101764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.140028Z","time spent":"961.707894ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:50.684942Z","caller":"traceutil/trace.go:171","msg":"trace[520083313] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"1.544230358s","start":"2026-06-11T06:53:49.140637Z","end":"2026-06-11T06:53:50.684867Z","steps":["trace[520083313] 'process raft request' (duration: 1.465558091s)","trace[520083313] 'compare' (duration: 78.477713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:50.685115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.14061Z","time spent":"1.544413533s","remote":"127.0.0.1:44786","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-06-11T06:53:50.685194Z","caller":"traceutil/trace.go:171","msg":"trace[1114347518] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"1.543145202s","start":"2026-06-11T06:53:49.142017Z","end":"2026-06-11T06:53:50.685162Z","steps":["trace[1114347518] 'process raft request' (duration: 1.542810414s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:50.685369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.141991Z","time spent":"1.543280445s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:50.685853Z","caller":"traceutil/trace.go:171","msg":"trace[1958096911] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"1.543631014s","start":"2026-06-11T06:53:49.142203Z","end":"2026-06-11T06:53:50.685834Z","steps":["trace[1958096911] 'process raft request' (duration: 1.542840485s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:50.685962Z","caller":"traceutil/trace.go:171","msg":"trace[1719554032] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1285; }","duration":"1.477369038s","start":"2026-06-11T06:53:49.208561Z","end":"2026-06-11T06:53:50.68593Z","steps":["trace[1719554032] 'read index received' (duration: 655.372978ms)","trace[1719554032] 'applied index is now lower than readState.Index' (duration: 821.99123ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:50.686035Z","caller":"traceutil/trace.go:171","msg":"trace[2072545144] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"1.5430546s","start":"2026-06-11T06:53:49.142962Z","end":"2026-06-11T06:53:50.686017Z","steps":["trace[2072545144] 'process raft request' (duration: 1.542788534s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:50.686102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.142956Z","time spent":"1.543110241s","remote":"127.0.0.1:44786","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-06-11T06:53:50.686162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.748699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:50.686211Z","caller":"traceutil/trace.go:171","msg":"trace[2137232767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"747.833652ms","start":"2026-06-11T06:53:49.938365Z","end":"2026-06-11T06:53:50.686198Z","steps":["trace[2137232767] 'agreement among raft nodes before linearized reading' (duration: 747.75559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:50.686241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.938344Z","time spent":"747.890963ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:53:50.686279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477710586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T06:53:50.686324Z","caller":"traceutil/trace.go:171","msg":"trace[584778835] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1238; }","duration":"1.477824209s","start":"2026-06-11T06:53:49.208488Z","end":"2026-06-11T06:53:50.686312Z","steps":["trace[584778835] 'agreement among raft nodes before linearized reading' (duration: 1.477635555s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:50.686326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.059127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:53:50.686358Z","caller":"traceutil/trace.go:171","msg":"trace[136680628] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1238; }","duration":"677.134179ms","start":"2026-06-11T06:53:50.009215Z","end":"2026-06-11T06:53:50.68635Z","steps":["trace[136680628] 'agreement among raft nodes before linearized reading' (duration: 677.070358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:50.68636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.20846Z","time spent":"1.47789279s","remote":"127.0.0.1:44522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"warn","ts":"2026-06-11T06:53:50.686388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:50.009194Z","time spent":"677.1885ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:53:50.686788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:49.142198Z","time spent":"1.544518125s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:50.863387Z","caller":"traceutil/trace.go:171","msg":"trace[1931067776] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"113.608214ms","start":"2026-06-11T06:53:50.749749Z","end":"2026-06-11T06:53:50.863357Z","steps":["trace[1931067776] 'process raft request' (duration: 70.051498ms)","trace[1931067776] 'compare' (duration: 43.400882ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:50.961077Z","caller":"traceutil/trace.go:171","msg":"trace[135624709] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"124.348155ms","start":"2026-06-11T06:53:50.836688Z","end":"2026-06-11T06:53:50.961036Z","steps":["trace[135624709] 'process raft request' (duration: 124.172931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:52.96212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.362593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-11T06:53:52.962202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.940308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-11T06:53:52.962277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.919928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:53:52.962369Z","caller":"traceutil/trace.go:171","msg":"trace[2144586911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1242; }","duration":"271.040491ms","start":"2026-06-11T06:53:52.691307Z","end":"2026-06-11T06:53:52.962347Z","steps":["trace[2144586911] 'range keys from in-memory index tree' (duration: 270.755534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:52.962539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.350241ms","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-06-11T06:53:52.962675Z","caller":"traceutil/trace.go:171","msg":"trace[181801793] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1242; }","duration":"691.784161ms","start":"2026-06-11T06:53:52.270868Z","end":"2026-06-11T06:53:52.962652Z","steps":["trace[181801793] 'count revisions from in-memory index tree' (duration: 691.241378ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:52.962312Z","caller":"traceutil/trace.go:171","msg":"trace[1183491232] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1242; }","duration":"271.160164ms","start":"2026-06-11T06:53:52.691124Z","end":"2026-06-11T06:53:52.962288Z","steps":["trace[1183491232] 'range keys from in-memory index tree' (duration: 270.747644ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:52.962752Z","caller":"traceutil/trace.go:171","msg":"trace[1016532430] linearizableReadLoop","detail":"{readStateIndex:1296; appliedIndex:1295; }","duration":"146.350688ms","start":"2026-06-11T06:53:52.816364Z","end":"2026-06-11T06:53:52.962715Z","steps":["trace[1016532430] 'read index received' (duration: 126.665591ms)","trace[1016532430] 'applied index is now lower than readState.Index' (duration: 19.682917ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:52.96281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.270846Z","time spent":"691.874043ms","remote":"127.0.0.1:44868","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-06-11T06:53:52.962839Z","caller":"traceutil/trace.go:171","msg":"trace[255919307] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"262.74883ms","start":"2026-06-11T06:53:52.700075Z","end":"2026-06-11T06:53:52.962824Z","steps":["trace[255919307] 'process raft request' (duration: 243.012112ms)","trace[255919307] 'compare' (duration: 18.889138ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:52.962398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.874636ms","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-06-11T06:53:52.963056Z","caller":"traceutil/trace.go:171","msg":"trace[5773465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1242; }","duration":"273.569992ms","start":"2026-06-11T06:53:52.689475Z","end":"2026-06-11T06:53:52.963045Z","steps":["trace[5773465] 'range keys from in-memory index tree' (duration: 272.754673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:52.963121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.751158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5330"} {"level":"info","ts":"2026-06-11T06:53:52.962252Z","caller":"traceutil/trace.go:171","msg":"trace[984513764] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1242; }","duration":"477.584428ms","start":"2026-06-11T06:53:52.484645Z","end":"2026-06-11T06:53:52.96223Z","steps":["trace[984513764] 'count revisions from in-memory index tree' (duration: 477.193188ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:52.963179Z","caller":"traceutil/trace.go:171","msg":"trace[561107564] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1243; }","duration":"146.84661ms","start":"2026-06-11T06:53:52.816318Z","end":"2026-06-11T06:53:52.963165Z","steps":["trace[561107564] 'agreement among raft nodes before linearized reading' (duration: 146.604995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:52.9632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.484614Z","time spent":"478.566552ms","remote":"127.0.0.1:44844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:53:52.962509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.701514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:53:52.96339Z","caller":"traceutil/trace.go:171","msg":"trace[950145608] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1242; }","duration":"269.586655ms","start":"2026-06-11T06:53:52.69379Z","end":"2026-06-11T06:53:52.963377Z","steps":["trace[950145608] 'range keys from in-memory index tree' (duration: 268.615562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.040636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.845582ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:53:54.040772Z","caller":"traceutil/trace.go:171","msg":"trace[468706155] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1296; }","duration":"1.077958812s","start":"2026-06-11T06:53:52.962791Z","end":"2026-06-11T06:53:54.040749Z","steps":["trace[468706155] 'read index received' (duration: 486.859543ms)","trace[468706155] 'applied index is now lower than readState.Index' (duration: 591.097269ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:54.041214Z","caller":"traceutil/trace.go:171","msg":"trace[1262924148] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"1.082737107s","start":"2026-06-11T06:53:52.958412Z","end":"2026-06-11T06:53:54.041149Z","steps":["trace[1262924148] 'process raft request' (duration: 491.26192ms)","trace[1262924148] 'compare' (duration: 590.300859ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:54.041308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.95839Z","time spent":"1.08287652s","remote":"127.0.0.1:44786","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-06-11T06:53:54.041877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.10554327s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:54.041982Z","caller":"traceutil/trace.go:171","msg":"trace[1458364786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1244; }","duration":"1.105707464s","start":"2026-06-11T06:53:52.936247Z","end":"2026-06-11T06:53:54.041955Z","steps":["trace[1458364786] 'agreement among raft nodes before linearized reading' (duration: 1.104896204s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.042045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.93622Z","time spent":"1.105812407s","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-11T06:53:54.067774Z","caller":"traceutil/trace.go:171","msg":"trace[1213803108] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"900.644403ms","start":"2026-06-11T06:53:53.167098Z","end":"2026-06-11T06:53:54.067743Z","steps":["trace[1213803108] 'process raft request' (duration: 900.574412ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:54.06788Z","caller":"traceutil/trace.go:171","msg":"trace[1578733998] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"1.099090163s","start":"2026-06-11T06:53:52.968777Z","end":"2026-06-11T06:53:54.067868Z","steps":["trace[1578733998] 'process raft request' (duration: 1.098855808s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:54.067935Z","caller":"traceutil/trace.go:171","msg":"trace[570615211] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"1.099129535s","start":"2026-06-11T06:53:52.968752Z","end":"2026-06-11T06:53:54.067882Z","steps":["trace[570615211] 'process raft request' (duration: 1.098840708s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.068109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.968766Z","time spent":"1.099198557s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:54.068099Z","caller":"traceutil/trace.go:171","msg":"trace[148198402] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"1.099366551s","start":"2026-06-11T06:53:52.968687Z","end":"2026-06-11T06:53:54.068054Z","steps":["trace[148198402] 'process raft request' (duration: 1.098859848s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.068247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.968744Z","time spent":"1.099302719s","remote":"127.0.0.1:44786","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-06-11T06:53:54.067975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:53.167063Z","time spent":"900.807156ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:53:54.06831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.968657Z","time spent":"1.099543964s","remote":"127.0.0.1:44786","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-06-11T06:53:54.067758Z","caller":"traceutil/trace.go:171","msg":"trace[90931885] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"1.099069073s","start":"2026-06-11T06:53:52.968633Z","end":"2026-06-11T06:53:54.067702Z","steps":["trace[90931885] 'process raft request' (duration: 1.098783216s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.068477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:52.968605Z","time spent":"1.099834702s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:53:54.101637Z","caller":"traceutil/trace.go:171","msg":"trace[1843766144] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"477.994447ms","start":"2026-06-11T06:53:53.623615Z","end":"2026-06-11T06:53:54.10161Z","steps":["trace[1843766144] 'process raft request' (duration: 477.815943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.101857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:53.623579Z","time spent":"478.135251ms","remote":"127.0.0.1:44584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T06:53:54.101963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.76387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:54.10203Z","caller":"traceutil/trace.go:171","msg":"trace[882922210] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1250; }","duration":"663.865073ms","start":"2026-06-11T06:53:53.438149Z","end":"2026-06-11T06:53:54.102014Z","steps":["trace[882922210] 'agreement among raft nodes before linearized reading' (duration: 663.75278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.102073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:53.438127Z","time spent":"663.937364ms","remote":"127.0.0.1:44888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" "} {"level":"info","ts":"2026-06-11T06:53:54.318854Z","caller":"traceutil/trace.go:171","msg":"trace[1691847810] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"212.334607ms","start":"2026-06-11T06:53:54.106493Z","end":"2026-06-11T06:53:54.318827Z","steps":["trace[1691847810] 'process raft request' (duration: 212.191224ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:54.31888Z","caller":"traceutil/trace.go:171","msg":"trace[2134587827] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1304; }","duration":"208.273979ms","start":"2026-06-11T06:53:54.110563Z","end":"2026-06-11T06:53:54.318837Z","steps":["trace[2134587827] 'read index received' (duration: 208.232088ms)","trace[2134587827] 'applied index is now lower than readState.Index' (duration: 39.191µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:54.319141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.547906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:54.319252Z","caller":"traceutil/trace.go:171","msg":"trace[461461346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1251; }","duration":"208.745361ms","start":"2026-06-11T06:53:54.110481Z","end":"2026-06-11T06:53:54.319226Z","steps":["trace[461461346] 'agreement among raft nodes before linearized reading' (duration: 208.508485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.706908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.968181ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-11T06:53:54.707167Z","caller":"traceutil/trace.go:171","msg":"trace[2135850205] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1304; }","duration":"388.156832ms","start":"2026-06-11T06:53:54.318962Z","end":"2026-06-11T06:53:54.707119Z","steps":["trace[2135850205] 'read index received' (duration: 111.864263ms)","trace[2135850205] 'applied index is now lower than readState.Index' (duration: 276.288839ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:54.707322Z","caller":"traceutil/trace.go:171","msg":"trace[1908068824] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"139.909892ms","start":"2026-06-11T06:53:54.567228Z","end":"2026-06-11T06:53:54.707138Z","steps":["trace[1908068824] 'process raft request' (duration: 139.783989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.707555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.770425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:53:54.707604Z","caller":"traceutil/trace.go:171","msg":"trace[202827929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1252; }","duration":"548.878327ms","start":"2026-06-11T06:53:54.158711Z","end":"2026-06-11T06:53:54.70759Z","steps":["trace[202827929] 'agreement among raft nodes before linearized reading' (duration: 548.636371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:54.707647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:54.158696Z","time spent":"548.939199ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:53:56.15126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.424787ms","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-06-11T06:53:56.15137Z","caller":"traceutil/trace.go:171","msg":"trace[938464642] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1254; }","duration":"117.628541ms","start":"2026-06-11T06:53:56.033714Z","end":"2026-06-11T06:53:56.151342Z","steps":["trace[938464642] 'count revisions from in-memory index tree' (duration: 117.277613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:56.151738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.680666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:56.151833Z","caller":"traceutil/trace.go:171","msg":"trace[1936261142] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1254; }","duration":"358.82816ms","start":"2026-06-11T06:53:55.792981Z","end":"2026-06-11T06:53:56.151809Z","steps":["trace[1936261142] 'count revisions from in-memory index tree' (duration: 358.574154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:56.151879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:55.792959Z","time spent":"358.907981ms","remote":"127.0.0.1:35886","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:53:56.152098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.301997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:56.152179Z","caller":"traceutil/trace.go:171","msg":"trace[184553466] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"351.341017ms","start":"2026-06-11T06:53:55.800787Z","end":"2026-06-11T06:53:56.152128Z","steps":["trace[184553466] 'range keys from in-memory index tree' (duration: 351.225875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:56.152214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:55.800744Z","time spent":"351.46246ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:53:56.152518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.195783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:56.152609Z","caller":"traceutil/trace.go:171","msg":"trace[1292581824] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1254; }","duration":"160.546642ms","start":"2026-06-11T06:53:55.992043Z","end":"2026-06-11T06:53:56.152589Z","steps":["trace[1292581824] 'count revisions from in-memory index tree' (duration: 159.981839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:56.151885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.245728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:56.152758Z","caller":"traceutil/trace.go:171","msg":"trace[2135923991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"216.217291ms","start":"2026-06-11T06:53:55.936528Z","end":"2026-06-11T06:53:56.152745Z","steps":["trace[2135923991] 'range keys from in-memory index tree' (duration: 215.174186ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:56.188986Z","caller":"traceutil/trace.go:171","msg":"trace[311206994] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"112.966478ms","start":"2026-06-11T06:53:56.075987Z","end":"2026-06-11T06:53:56.188953Z","steps":["trace[311206994] 'process raft request' (duration: 112.793164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:56.369299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.989556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:53:56.369605Z","caller":"traceutil/trace.go:171","msg":"trace[1668862414] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"211.739954ms","start":"2026-06-11T06:53:56.157846Z","end":"2026-06-11T06:53:56.369586Z","steps":["trace[1668862414] 'process raft request' (duration: 211.698543ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:56.369749Z","caller":"traceutil/trace.go:171","msg":"trace[1628292654] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"212.075372ms","start":"2026-06-11T06:53:56.157638Z","end":"2026-06-11T06:53:56.369713Z","steps":["trace[1628292654] 'process raft request' (duration: 94.558473ms)","trace[1628292654] 'compare' (duration: 116.836592ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:56.369966Z","caller":"traceutil/trace.go:171","msg":"trace[73427627] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"212.193724ms","start":"2026-06-11T06:53:56.15774Z","end":"2026-06-11T06:53:56.369933Z","steps":["trace[73427627] 'process raft request' (duration: 211.680792ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:56.370007Z","caller":"traceutil/trace.go:171","msg":"trace[1890360612] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"212.108783ms","start":"2026-06-11T06:53:56.157844Z","end":"2026-06-11T06:53:56.369953Z","steps":["trace[1890360612] 'process raft request' (duration: 211.622391ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:58.875346Z","caller":"traceutil/trace.go:171","msg":"trace[1761720559] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"129.485449ms","start":"2026-06-11T06:53:58.745825Z","end":"2026-06-11T06:53:58.875311Z","steps":["trace[1761720559] 'read index received' (duration: 129.287525ms)","trace[1761720559] 'applied index is now lower than readState.Index' (duration: 196.514µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:58.875554Z","caller":"traceutil/trace.go:171","msg":"trace[2045649510] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"341.337245ms","start":"2026-06-11T06:53:58.534178Z","end":"2026-06-11T06:53:58.875515Z","steps":["trace[2045649510] 'process raft request' (duration: 340.926445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:58.87564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.787317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:53:58.875689Z","caller":"traceutil/trace.go:171","msg":"trace[174743432] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1285; }","duration":"129.92563ms","start":"2026-06-11T06:53:58.74575Z","end":"2026-06-11T06:53:58.875675Z","steps":["trace[174743432] 'agreement among raft nodes before linearized reading' (duration: 129.690275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:58.875808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:58.534149Z","time spent":"341.4979ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T06:53:59.25833Z","caller":"traceutil/trace.go:171","msg":"trace[603837600] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"377.665231ms","start":"2026-06-11T06:53:58.880619Z","end":"2026-06-11T06:53:59.258284Z","steps":["trace[603837600] 'process raft request' (duration: 358.098337ms)","trace[603837600] 'compare' (duration: 19.213985ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:53:59.25838Z","caller":"traceutil/trace.go:171","msg":"trace[1938749199] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"376.095772ms","start":"2026-06-11T06:53:58.882252Z","end":"2026-06-11T06:53:59.258348Z","steps":["trace[1938749199] 'process raft request' (duration: 376.025461ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:53:59.258467Z","caller":"traceutil/trace.go:171","msg":"trace[725780044] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"377.001345ms","start":"2026-06-11T06:53:58.881445Z","end":"2026-06-11T06:53:59.258446Z","steps":["trace[725780044] 'read index received' (duration: 357.268377ms)","trace[725780044] 'applied index is now lower than readState.Index' (duration: 19.731208ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:53:59.25854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:58.882237Z","time spent":"376.221326ms","remote":"127.0.0.1:44584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T06:53:59.258547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:58.880587Z","time spent":"377.848065ms","remote":"127.0.0.1:44786","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-06-11T06:53:59.258824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.364823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-11T06:53:59.258864Z","caller":"traceutil/trace.go:171","msg":"trace[807756808] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1287; }","duration":"377.455756ms","start":"2026-06-11T06:53:58.881397Z","end":"2026-06-11T06:53:59.258853Z","steps":["trace[807756808] 'agreement among raft nodes before linearized reading' (duration: 377.168739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:59.258895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:58.881375Z","time spent":"377.513097ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-11T06:53:59.25898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.44926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:53:59.25904Z","caller":"traceutil/trace.go:171","msg":"trace[95492220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1287; }","duration":"319.619004ms","start":"2026-06-11T06:53:58.939403Z","end":"2026-06-11T06:53:59.259022Z","steps":["trace[95492220] 'agreement among raft nodes before linearized reading' (duration: 319.45097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:53:59.259087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:53:58.939374Z","time spent":"319.701865ms","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:54:02.89668Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:54:03.397823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090204,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:54:03.879837Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.66934098s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-11T06:54:03.934902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.84857548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:54:03.934997Z","caller":"traceutil/trace.go:171","msg":"trace[1595745863] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1304; }","duration":"1.848727143s","start":"2026-06-11T06:54:02.086244Z","end":"2026-06-11T06:54:03.934971Z","steps":["trace[1595745863] 'range keys from in-memory index tree' (duration: 1.848462976s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.935039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.08622Z","time spent":"1.848810145s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-11T06:54:03.93528Z","caller":"traceutil/trace.go:171","msg":"trace[618760869] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"1.724913806s","start":"2026-06-11T06:54:02.21033Z","end":"2026-06-11T06:54:03.935244Z","steps":["trace[618760869] 'process raft request' (duration: 1.669699479s)","trace[618760869] 'compare' (duration: 54.485539ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:54:03.93528Z","caller":"traceutil/trace.go:171","msg":"trace[1747770678] linearizableReadLoop","detail":"{readStateIndex:1360; appliedIndex:1359; }","duration":"1.539308413s","start":"2026-06-11T06:54:02.395907Z","end":"2026-06-11T06:54:03.935215Z","steps":["trace[1747770678] 'read index received' (duration: 1.484117357s)","trace[1747770678] 'applied index is now lower than readState.Index' (duration: 55.189356ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:54:03.935404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.210295Z","time spent":"1.725041309s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:54:03.935572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.539650481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T06:54:03.935649Z","caller":"traceutil/trace.go:171","msg":"trace[680591738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1305; }","duration":"1.539779764s","start":"2026-06-11T06:54:02.39585Z","end":"2026-06-11T06:54:03.93563Z","steps":["trace[680591738] 'agreement among raft nodes before linearized reading' (duration: 1.539550878s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.935727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.395824Z","time spent":"1.539886037s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:54:03.936472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.538742309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-11T06:54:03.93651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448886714s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T06:54:03.936529Z","caller":"traceutil/trace.go:171","msg":"trace[937660376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1305; }","duration":"1.53881877s","start":"2026-06-11T06:54:02.397696Z","end":"2026-06-11T06:54:03.936515Z","steps":["trace[937660376] 'agreement among raft nodes before linearized reading' (duration: 1.538677457s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:03.936555Z","caller":"traceutil/trace.go:171","msg":"trace[1140367449] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1305; }","duration":"1.449009197s","start":"2026-06-11T06:54:02.487532Z","end":"2026-06-11T06:54:03.936541Z","steps":["trace[1140367449] 'agreement among raft nodes before linearized reading' (duration: 1.448890874s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.936584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.487506Z","time spent":"1.449071069s","remote":"127.0.0.1:37466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:54:03.936602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.397687Z","time spent":"1.538870232s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T06:54:03.936619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.532135259s","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-06-11T06:54:03.936686Z","caller":"traceutil/trace.go:171","msg":"trace[512970803] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1305; }","duration":"1.532242951s","start":"2026-06-11T06:54:02.40443Z","end":"2026-06-11T06:54:03.936673Z","steps":["trace[512970803] 'agreement among raft nodes before linearized reading' (duration: 1.532059797s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.936727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.404408Z","time spent":"1.532312223s","remote":"127.0.0.1:44786","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-06-11T06:54:03.93678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.607322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:54:03.936801Z","caller":"traceutil/trace.go:171","msg":"trace[302155058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1305; }","duration":"660.698214ms","start":"2026-06-11T06:54:03.276098Z","end":"2026-06-11T06:54:03.936796Z","steps":["trace[302155058] 'agreement among raft nodes before linearized reading' (duration: 660.596302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.936816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:03.276075Z","time spent":"660.737195ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:54:03.936913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000553591s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:54:03.936931Z","caller":"traceutil/trace.go:171","msg":"trace[1910372448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1305; }","duration":"1.000600782s","start":"2026-06-11T06:54:02.936323Z","end":"2026-06-11T06:54:03.936924Z","steps":["trace[1910372448] 'agreement among raft nodes before linearized reading' (duration: 1.000570901s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.936943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.936306Z","time spent":"1.000634213s","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:54:03.936984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.536532236s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:54:03.937029Z","caller":"traceutil/trace.go:171","msg":"trace[827779978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1305; }","duration":"1.536638047s","start":"2026-06-11T06:54:02.40038Z","end":"2026-06-11T06:54:03.937018Z","steps":["trace[827779978] 'agreement among raft nodes before linearized reading' (duration: 1.536499724s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:03.937127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:02.40036Z","time spent":"1.53672608s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-11T06:54:04.18808Z","caller":"traceutil/trace.go:171","msg":"trace[2128467694] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"246.449925ms","start":"2026-06-11T06:54:03.94157Z","end":"2026-06-11T06:54:04.18802Z","steps":["trace[2128467694] 'process raft request' (duration: 234.833294ms)","trace[2128467694] 'compare' (duration: 11.298124ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:54:04.188102Z","caller":"traceutil/trace.go:171","msg":"trace[1395058159] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"244.047547ms","start":"2026-06-11T06:54:03.944006Z","end":"2026-06-11T06:54:04.188054Z","steps":["trace[1395058159] 'process raft request' (duration: 243.901284ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:04.18822Z","caller":"traceutil/trace.go:171","msg":"trace[1255718684] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"245.021781ms","start":"2026-06-11T06:54:03.943188Z","end":"2026-06-11T06:54:04.18821Z","steps":["trace[1255718684] 'process raft request' (duration: 244.781685ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:04.188113Z","caller":"traceutil/trace.go:171","msg":"trace[2001030357] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"243.916005ms","start":"2026-06-11T06:54:03.944164Z","end":"2026-06-11T06:54:04.18808Z","steps":["trace[2001030357] 'process raft request' (duration: 243.846063ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:04.188331Z","caller":"traceutil/trace.go:171","msg":"trace[49810791] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1360; }","duration":"241.046035ms","start":"2026-06-11T06:54:03.947268Z","end":"2026-06-11T06:54:04.188314Z","steps":["trace[49810791] 'read index received' (duration: 22.665218ms)","trace[49810791] 'applied index is now lower than readState.Index' (duration: 218.379456ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:54:04.188371Z","caller":"traceutil/trace.go:171","msg":"trace[909509830] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"244.109059ms","start":"2026-06-11T06:54:03.944243Z","end":"2026-06-11T06:54:04.188352Z","steps":["trace[909509830] 'process raft request' (duration: 243.797832ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:04.188394Z","caller":"traceutil/trace.go:171","msg":"trace[1964743116] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"242.279835ms","start":"2026-06-11T06:54:03.946096Z","end":"2026-06-11T06:54:04.188376Z","steps":["trace[1964743116] 'process raft request' (duration: 242.124691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:54:04.188448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.163198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:54:04.188487Z","caller":"traceutil/trace.go:171","msg":"trace[700167638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1312; }","duration":"241.26281ms","start":"2026-06-11T06:54:03.947213Z","end":"2026-06-11T06:54:04.188476Z","steps":["trace[700167638] 'agreement among raft nodes before linearized reading' (duration: 241.162198ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:54:04.643829Z","caller":"traceutil/trace.go:171","msg":"trace[401917082] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"365.153859ms","start":"2026-06-11T06:54:04.278644Z","end":"2026-06-11T06:54:04.643798Z","steps":["trace[401917082] 'process raft request' (duration: 313.029447ms)","trace[401917082] 'compare' (duration: 51.352823ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:54:04.644117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:54:04.278622Z","time spent":"365.279132ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:54:14.774973Z","caller":"traceutil/trace.go:171","msg":"trace[490041365] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"108.045395ms","start":"2026-06-11T06:54:14.66689Z","end":"2026-06-11T06:54:14.774936Z","steps":["trace[490041365] 'process raft request' (duration: 55.083993ms)","trace[490041365] 'compare' (duration: 52.796708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:55:04.929673Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090896,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-11T06:55:04.934463Z","caller":"traceutil/trace.go:171","msg":"trace[1601066827] linearizableReadLoop","detail":"{readStateIndex:1670; appliedIndex:1668; }","duration":"550.069792ms","start":"2026-06-11T06:55:04.384369Z","end":"2026-06-11T06:55:04.934438Z","steps":["trace[1601066827] 'read index received' (duration: 548.192236ms)","trace[1601066827] 'applied index is now lower than readState.Index' (duration: 1.876256ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:55:04.934966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.577094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-11T06:55:04.935043Z","caller":"traceutil/trace.go:171","msg":"trace[2042106480] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1602; }","duration":"550.716408ms","start":"2026-06-11T06:55:04.384308Z","end":"2026-06-11T06:55:04.935024Z","steps":["trace[2042106480] 'agreement among raft nodes before linearized reading' (duration: 550.319048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:04.935073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:04.384279Z","time spent":"550.787829ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:55:04.935047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.478722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-11T06:55:04.935127Z","caller":"traceutil/trace.go:171","msg":"trace[1370168212] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1602; }","duration":"550.562704ms","start":"2026-06-11T06:55:04.384536Z","end":"2026-06-11T06:55:04.935099Z","steps":["trace[1370168212] 'agreement among raft nodes before linearized reading' (duration: 550.152334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:04.935153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:04.384452Z","time spent":"550.696397ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-11T06:55:06.384086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090911,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:06.884578Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090911,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:07.385183Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090911,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:07.788876Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.907359433s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:55:07.789318Z","caller":"traceutil/trace.go:171","msg":"trace[2144797169] transaction","detail":"{read_only:false; response_revision:1612; number_of_response:1; }","duration":"1.907877695s","start":"2026-06-11T06:55:05.881414Z","end":"2026-06-11T06:55:07.789292Z","steps":["trace[2144797169] 'process raft request' (duration: 1.907702521s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.789519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:05.881398Z","time spent":"1.907997779s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:55:07.792588Z","caller":"traceutil/trace.go:171","msg":"trace[921662606] transaction","detail":"{read_only:false; response_revision:1613; number_of_response:1; }","duration":"1.706915971s","start":"2026-06-11T06:55:06.085655Z","end":"2026-06-11T06:55:07.792571Z","steps":["trace[921662606] 'process raft request' (duration: 1.706716396s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.792656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.085623Z","time spent":"1.706999293s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:55:07.792682Z","caller":"traceutil/trace.go:171","msg":"trace[144206890] transaction","detail":"{read_only:false; response_revision:1614; number_of_response:1; }","duration":"850.14965ms","start":"2026-06-11T06:55:06.942478Z","end":"2026-06-11T06:55:07.792628Z","steps":["trace[144206890] 'process raft request' (duration: 850.026217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.7929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.942442Z","time spent":"850.355465ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:55:07.79287Z","caller":"traceutil/trace.go:171","msg":"trace[1055614946] linearizableReadLoop","detail":"{readStateIndex:1682; appliedIndex:1679; }","duration":"1.908803188s","start":"2026-06-11T06:55:05.883749Z","end":"2026-06-11T06:55:07.792553Z","steps":["trace[1055614946] 'read index received' (duration: 1.905372595s)","trace[1055614946] 'applied index is now lower than readState.Index' (duration: 3.429163ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:55:07.792955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.909160977s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-11T06:55:07.793079Z","caller":"traceutil/trace.go:171","msg":"trace[1118426644] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1614; }","duration":"1.90931181s","start":"2026-06-11T06:55:05.88373Z","end":"2026-06-11T06:55:07.793042Z","steps":["trace[1118426644] 'agreement among raft nodes before linearized reading' (duration: 1.908993182s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.793117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.852980707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:55:07.793155Z","caller":"traceutil/trace.go:171","msg":"trace[437571583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1614; }","duration":"1.853068999s","start":"2026-06-11T06:55:05.940074Z","end":"2026-06-11T06:55:07.793143Z","steps":["trace[437571583] 'agreement among raft nodes before linearized reading' (duration: 1.852990397s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.793226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:05.883724Z","time spent":"1.909418103s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-11T06:55:07.793356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.470117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-11T06:55:07.793475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.809883353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:55:07.793894Z","caller":"traceutil/trace.go:171","msg":"trace[732347271] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1614; }","duration":"1.810344884s","start":"2026-06-11T06:55:05.983531Z","end":"2026-06-11T06:55:07.793876Z","steps":["trace[732347271] 'agreement among raft nodes before linearized reading' (duration: 1.809896123s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.793523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.048452ms","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-06-11T06:55:07.793963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:05.983509Z","time spent":"1.810429987s","remote":"127.0.0.1:35978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-06-11T06:55:07.79402Z","caller":"traceutil/trace.go:171","msg":"trace[632002197] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1614; }","duration":"846.540713ms","start":"2026-06-11T06:55:06.947453Z","end":"2026-06-11T06:55:07.793994Z","steps":["trace[632002197] 'agreement among raft nodes before linearized reading' (duration: 845.944829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.794081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.947447Z","time spent":"846.616235ms","remote":"127.0.0.1:44786","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-06-11T06:55:07.793538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.610823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:55:07.794149Z","caller":"traceutil/trace.go:171","msg":"trace[1566644282] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1614; }","duration":"849.259969ms","start":"2026-06-11T06:55:06.944875Z","end":"2026-06-11T06:55:07.794135Z","steps":["trace[1566644282] 'agreement among raft nodes before linearized reading' (duration: 848.456489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.794184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.944853Z","time spent":"849.320871ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:55:07.793592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.200544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:55:07.794239Z","caller":"traceutil/trace.go:171","msg":"trace[581559642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1614; }","duration":"846.882772ms","start":"2026-06-11T06:55:06.94734Z","end":"2026-06-11T06:55:07.794223Z","steps":["trace[581559642] 'agreement among raft nodes before linearized reading' (duration: 846.172805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.79429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.947307Z","time spent":"846.968543ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:07.7936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.025351ms","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-06-11T06:55:07.79442Z","caller":"traceutil/trace.go:171","msg":"trace[1768740592] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1614; }","duration":"200.843491ms","start":"2026-06-11T06:55:07.593568Z","end":"2026-06-11T06:55:07.794411Z","steps":["trace[1768740592] 'agreement among raft nodes before linearized reading' (duration: 200.001071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.793652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.037867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-11T06:55:07.794566Z","caller":"traceutil/trace.go:171","msg":"trace[1744829981] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1614; }","duration":"845.946999ms","start":"2026-06-11T06:55:06.948601Z","end":"2026-06-11T06:55:07.794548Z","steps":["trace[1744829981] 'agreement among raft nodes before linearized reading' (duration: 845.013316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.79462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.948594Z","time spent":"846.01127ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-11T06:55:07.793701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.805695482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:55:07.79474Z","caller":"traceutil/trace.go:171","msg":"trace[1088722021] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1614; }","duration":"1.806728787s","start":"2026-06-11T06:55:05.987998Z","end":"2026-06-11T06:55:07.794727Z","steps":["trace[1088722021] 'agreement among raft nodes before linearized reading' (duration: 1.805681992s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.794772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:05.987967Z","time spent":"1.806795109s","remote":"127.0.0.1:35870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-06-11T06:55:07.793813Z","caller":"traceutil/trace.go:171","msg":"trace[711531129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1614; }","duration":"845.930388ms","start":"2026-06-11T06:55:06.94786Z","end":"2026-06-11T06:55:07.79379Z","steps":["trace[711531129] 'agreement among raft nodes before linearized reading' (duration: 845.378715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.793698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"844.683678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:55:07.794989Z","caller":"traceutil/trace.go:171","msg":"trace[622621369] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1614; }","duration":"846.01686ms","start":"2026-06-11T06:55:06.948964Z","end":"2026-06-11T06:55:07.79498Z","steps":["trace[622621369] 'agreement among raft nodes before linearized reading' (duration: 844.607766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:07.795015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.94895Z","time spent":"846.056872ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:07.794879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:06.947855Z","time spent":"847.013994ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:07.795252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:05.940052Z","time spent":"1.8551884s","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:55:10.307913Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:10.8084Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:11.308645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:11.809795Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:12.310616Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151670408090938,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T06:55:12.525487Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.724629087s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T06:55:12.525986Z","caller":"traceutil/trace.go:171","msg":"trace[1990024400] linearizableReadLoop","detail":"{readStateIndex:1692; appliedIndex:1691; }","duration":"2.718789795s","start":"2026-06-11T06:55:09.807165Z","end":"2026-06-11T06:55:12.525955Z","steps":["trace[1990024400] 'read index received' (duration: 2.718504668s)","trace[1990024400] 'applied index is now lower than readState.Index' (duration: 283.867µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:55:12.526086Z","caller":"traceutil/trace.go:171","msg":"trace[1707710459] transaction","detail":"{read_only:false; response_revision:1623; number_of_response:1; }","duration":"2.725405235s","start":"2026-06-11T06:55:09.800637Z","end":"2026-06-11T06:55:12.526042Z","steps":["trace[1707710459] 'process raft request' (duration: 2.725109578s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.719054562s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-11T06:55:12.526285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.800604Z","time spent":"2.72557623s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:55:12.526308Z","caller":"traceutil/trace.go:171","msg":"trace[1430996273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1623; }","duration":"2.719176535s","start":"2026-06-11T06:55:09.807119Z","end":"2026-06-11T06:55:12.526295Z","steps":["trace[1430996273] 'agreement among raft nodes before linearized reading' (duration: 2.718959489s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.806919Z","time spent":"2.719426201s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717227218s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T06:55:12.526415Z","caller":"traceutil/trace.go:171","msg":"trace[1000847510] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1623; }","duration":"2.71734023s","start":"2026-06-11T06:55:09.809059Z","end":"2026-06-11T06:55:12.526399Z","steps":["trace[1000847510] 'agreement among raft nodes before linearized reading' (duration: 2.717099024s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.809045Z","time spent":"2.717409602s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:12.52643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.577658219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-06-11T06:55:12.526553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.174175023s","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-06-11T06:55:12.526567Z","caller":"traceutil/trace.go:171","msg":"trace[1252355383] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1623; }","duration":"2.577801332s","start":"2026-06-11T06:55:09.948719Z","end":"2026-06-11T06:55:12.52652Z","steps":["trace[1252355383] 'agreement among raft nodes before linearized reading' (duration: 2.577443153s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:55:12.526595Z","caller":"traceutil/trace.go:171","msg":"trace[973179057] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1623; }","duration":"1.174256505s","start":"2026-06-11T06:55:11.352325Z","end":"2026-06-11T06:55:12.526582Z","steps":["trace[973179057] 'agreement among raft nodes before linearized reading' (duration: 1.174186534s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.579112294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"} {"level":"info","ts":"2026-06-11T06:55:12.526659Z","caller":"traceutil/trace.go:171","msg":"trace[812629128] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1623; }","duration":"2.579182486s","start":"2026-06-11T06:55:09.947468Z","end":"2026-06-11T06:55:12.52665Z","steps":["trace[812629128] 'agreement among raft nodes before linearized reading' (duration: 2.579105984s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.948712Z","time spent":"2.577898144s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.523383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:55:12.526703Z","caller":"traceutil/trace.go:171","msg":"trace[483157528] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1623; }","duration":"889.553373ms","start":"2026-06-11T06:55:11.637141Z","end":"2026-06-11T06:55:12.526694Z","steps":["trace[483157528] 'agreement among raft nodes before linearized reading' (duration: 889.503732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.715793402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-11T06:55:12.526767Z","caller":"traceutil/trace.go:171","msg":"trace[145292865] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1623; }","duration":"2.715864425s","start":"2026-06-11T06:55:09.810896Z","end":"2026-06-11T06:55:12.52676Z","steps":["trace[145292865] 'agreement among raft nodes before linearized reading' (duration: 2.715798363s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.810874Z","time spent":"2.715906085s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588187445s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T06:55:12.526819Z","caller":"traceutil/trace.go:171","msg":"trace[285839606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1623; }","duration":"1.588257837s","start":"2026-06-11T06:55:10.938552Z","end":"2026-06-11T06:55:12.52681Z","steps":["trace[285839606] 'agreement among raft nodes before linearized reading' (duration: 1.588209576s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.238351757s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T06:55:12.526861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:10.938529Z","time spent":"1.588323159s","remote":"127.0.0.1:44476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717444023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T06:55:12.526886Z","caller":"traceutil/trace.go:171","msg":"trace[1429089946] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1623; }","duration":"1.23847958s","start":"2026-06-11T06:55:11.288391Z","end":"2026-06-11T06:55:12.526871Z","steps":["trace[1429089946] 'agreement among raft nodes before linearized reading' (duration: 1.238350517s)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:55:12.526901Z","caller":"traceutil/trace.go:171","msg":"trace[1234020448] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1623; }","duration":"2.717504854s","start":"2026-06-11T06:55:09.809391Z","end":"2026-06-11T06:55:12.526896Z","steps":["trace[1234020448] 'agreement among raft nodes before linearized reading' (duration: 2.717445043s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.526919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.809366Z","time spent":"2.717547706s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T06:55:12.52692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:11.288368Z","time spent":"1.238542361s","remote":"127.0.0.1:35924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:55:12.526679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.947446Z","time spent":"2.579227337s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:11.637068Z","time spent":"889.664096ms","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-11T06:55:12.526992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717192036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-11T06:55:12.52703Z","caller":"traceutil/trace.go:171","msg":"trace[1325805057] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1623; }","duration":"2.717290179s","start":"2026-06-11T06:55:09.809729Z","end":"2026-06-11T06:55:12.527019Z","steps":["trace[1325805057] 'agreement among raft nodes before linearized reading' (duration: 2.717110565s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.527097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.80972Z","time spent":"2.717366921s","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T06:55:12.526626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:11.352304Z","time spent":"1.174314506s","remote":"127.0.0.1:44868","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":"warn","ts":"2026-06-11T06:55:12.527376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.717535484s","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-06-11T06:55:12.527411Z","caller":"traceutil/trace.go:171","msg":"trace[809072130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1623; }","duration":"2.717588636s","start":"2026-06-11T06:55:09.809811Z","end":"2026-06-11T06:55:12.5274Z","steps":["trace[809072130] 'agreement among raft nodes before linearized reading' (duration: 2.717487234s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:55:12.52744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:55:09.8098Z","time spent":"2.717634617s","remote":"127.0.0.1:44786","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-06-11T06:56:47.570209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.159911ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T06:56:47.570374Z","caller":"traceutil/trace.go:171","msg":"trace[18458078] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"469.303449ms","start":"2026-06-11T06:56:47.101046Z","end":"2026-06-11T06:56:47.570349Z","steps":["trace[18458078] 'process raft request' (duration: 113.583414ms)","trace[18458078] 'compare' (duration: 354.642419ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:56:47.570447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:56:47.101011Z","time spent":"469.402032ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T06:56:47.579366Z","caller":"traceutil/trace.go:171","msg":"trace[696870424] linearizableReadLoop","detail":"{readStateIndex:2149; appliedIndex:2146; }","duration":"419.968642ms","start":"2026-06-11T06:56:47.159377Z","end":"2026-06-11T06:56:47.579346Z","steps":["trace[696870424] 'read index received' (duration: 55.265001ms)","trace[696870424] 'applied index is now lower than readState.Index' (duration: 364.702951ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:56:47.579405Z","caller":"traceutil/trace.go:171","msg":"trace[1781313373] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"478.0516ms","start":"2026-06-11T06:56:47.101321Z","end":"2026-06-11T06:56:47.579373Z","steps":["trace[1781313373] 'process raft request' (duration: 477.904317ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:56:47.579473Z","caller":"traceutil/trace.go:171","msg":"trace[1359102628] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"478.083241ms","start":"2026-06-11T06:56:47.101379Z","end":"2026-06-11T06:56:47.579462Z","steps":["trace[1359102628] 'process raft request' (duration: 477.933877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:56:47.579578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:56:47.101164Z","time spent":"478.334666ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:56:47.579586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:56:47.101311Z","time spent":"478.181663ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T06:56:47.579786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.267551ms","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-06-11T06:56:47.579904Z","caller":"traceutil/trace.go:171","msg":"trace[1852192704] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2061; }","duration":"411.470796ms","start":"2026-06-11T06:56:47.168404Z","end":"2026-06-11T06:56:47.579875Z","steps":["trace[1852192704] 'agreement among raft nodes before linearized reading' (duration: 411.278372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:56:47.579921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.542445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"warn","ts":"2026-06-11T06:56:47.57998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:56:47.168383Z","time spent":"411.575759ms","remote":"127.0.0.1:44952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-11T06:56:47.580002Z","caller":"traceutil/trace.go:171","msg":"trace[2140376271] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2061; }","duration":"420.657598ms","start":"2026-06-11T06:56:47.159326Z","end":"2026-06-11T06:56:47.579984Z","steps":["trace[2140376271] 'agreement among raft nodes before linearized reading' (duration: 420.416092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:56:47.580053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T06:56:47.159306Z","time spent":"420.734699ms","remote":"127.0.0.1:44786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-11T06:56:47.780246Z","caller":"traceutil/trace.go:171","msg":"trace[689824804] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"158.430324ms","start":"2026-06-11T06:56:47.621787Z","end":"2026-06-11T06:56:47.780217Z","steps":["trace[689824804] 'process raft request' (duration: 85.422437ms)","trace[689824804] 'compare' (duration: 72.794802ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:56:48.014007Z","caller":"traceutil/trace.go:171","msg":"trace[1135217074] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"227.912547ms","start":"2026-06-11T06:56:47.786061Z","end":"2026-06-11T06:56:48.013973Z","steps":["trace[1135217074] 'process raft request' (duration: 136.311532ms)","trace[1135217074] 'compare' (duration: 91.37257ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:56:48.16137Z","caller":"traceutil/trace.go:171","msg":"trace[1480541854] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"135.089182ms","start":"2026-06-11T06:56:48.026237Z","end":"2026-06-11T06:56:48.161326Z","steps":["trace[1480541854] 'process raft request' (duration: 117.688123ms)","trace[1480541854] 'compare' (duration: 17.222295ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T06:56:48.166324Z","caller":"traceutil/trace.go:171","msg":"trace[738501748] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"139.269193ms","start":"2026-06-11T06:56:48.027024Z","end":"2026-06-11T06:56:48.166293Z","steps":["trace[738501748] 'process raft request' (duration: 139.043157ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:16.212697Z","caller":"traceutil/trace.go:171","msg":"trace[101756699] transaction","detail":"{read_only:false; response_revision:2500; number_of_response:1; }","duration":"167.554185ms","start":"2026-06-11T06:58:16.045116Z","end":"2026-06-11T06:58:16.21267Z","steps":["trace[101756699] 'process raft request' (duration: 166.965281ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:16.213704Z","caller":"traceutil/trace.go:171","msg":"trace[1280735416] linearizableReadLoop","detail":"{readStateIndex:2609; appliedIndex:2607; }","duration":"151.960069ms","start":"2026-06-11T06:58:16.061726Z","end":"2026-06-11T06:58:16.213686Z","steps":["trace[1280735416] 'read index received' (duration: 150.283889ms)","trace[1280735416] 'applied index is now lower than readState.Index' (duration: 1.67494ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T06:58:16.21387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.143544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-11T06:58:16.213856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.233442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:monitoring\" ","response":"range_response_count:1 size:694"} {"level":"info","ts":"2026-06-11T06:58:16.213907Z","caller":"traceutil/trace.go:171","msg":"trace[1820733924] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2501; }","duration":"152.221635ms","start":"2026-06-11T06:58:16.061674Z","end":"2026-06-11T06:58:16.213896Z","steps":["trace[1820733924] 'agreement among raft nodes before linearized reading' (duration: 152.092882ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:16.213922Z","caller":"traceutil/trace.go:171","msg":"trace[1702528421] range","detail":"{range_begin:/registry/clusterrolebindings/system:monitoring; range_end:; response_count:1; response_revision:2501; }","duration":"151.345925ms","start":"2026-06-11T06:58:16.062563Z","end":"2026-06-11T06:58:16.213909Z","steps":["trace[1702528421] 'agreement among raft nodes before linearized reading' (duration: 151.233442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:58:16.213946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.804611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node\" ","response":"range_response_count:1 size:603"} {"level":"info","ts":"2026-06-11T06:58:16.214028Z","caller":"traceutil/trace.go:171","msg":"trace[710026988] range","detail":"{range_begin:/registry/clusterrolebindings/system:node; range_end:; response_count:1; response_revision:2501; }","duration":"145.910963ms","start":"2026-06-11T06:58:16.068096Z","end":"2026-06-11T06:58:16.214007Z","steps":["trace[710026988] 'agreement among raft nodes before linearized reading' (duration: 145.732799ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T06:58:16.21373Z","caller":"traceutil/trace.go:171","msg":"trace[228485992] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"168.480467ms","start":"2026-06-11T06:58:16.045238Z","end":"2026-06-11T06:58:16.213718Z","steps":["trace[228485992] 'process raft request' (duration: 168.350274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T06:58:16.214116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.210951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-11T06:58:16.214208Z","caller":"traceutil/trace.go:171","msg":"trace[1822241162] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2501; }","duration":"151.326144ms","start":"2026-06-11T06:58:16.062855Z","end":"2026-06-11T06:58:16.214181Z","steps":["trace[1822241162] 'agreement among raft nodes before linearized reading' (duration: 151.012237ms)"],"step_count":1}