{"level":"warn","ts":"2026-04-16T06:05:16.798736Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T06:05:16.798813Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-16T06:05:16.798871Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T06:05:16.798884Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-16T06:05:16.798901Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T06:05:16.799467Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-16T06:05:16.799538Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-16T06:05:16.986683Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"186.944654ms"} {"level":"info","ts":"2026-04-16T06:05:17.443873Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-16T06:05:17.444013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:05:17.444049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-16T06:05:17.444074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:05:17.444088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-16T06:05:17.444197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-16T06:05:19.34381Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:05:20.150802Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:05:20.295148Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-16T06:05:20.297735Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:05:20.297906Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T06:05:20.298049Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T06:05:20.298071Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T06:05:20.298894Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:05:20.301909Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T06:05:20.302087Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-16T06:05:20.302172Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-16T06:05:20.302175Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:05:20.302248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:05:20.302684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-16T06:05:20.302867Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-16T06:05:20.784954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:05:20.785095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:05:20.785178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-16T06:05:20.785258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:05:20.785302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-16T06:05:20.785404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-16T06:05:20.78546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-16T06:05:20.853605Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:05:20.853723Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:20.853641Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:05:20.853648Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:20.854098Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:05:20.854123Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:05:20.857689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:05:20.858558Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-16T06:05:20.931057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:20.931411Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:20.931494Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:05:23.402692Z","caller":"traceutil/trace.go:171","msg":"trace[1335475126] transaction","detail":"{read_only:false; response_revision:76; number_of_response:1; }","duration":"113.561328ms","start":"2026-04-16T06:05:23.289103Z","end":"2026-04-16T06:05:23.402664Z","steps":["trace[1335475126] 'process raft request' (duration: 66.639583ms)","trace[1335475126] 'compare' (duration: 46.757156ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:24.116662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.928947ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-16T06:05:24.11678Z","caller":"traceutil/trace.go:171","msg":"trace[441639783] linearizableReadLoop","detail":"{readStateIndex:102; appliedIndex:101; }","duration":"132.156619ms","start":"2026-04-16T06:05:23.984606Z","end":"2026-04-16T06:05:24.116763Z","steps":["trace[441639783] 'read index received' (duration: 29.518252ms)","trace[441639783] 'applied index is now lower than readState.Index' (duration: 102.637197ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:24.116857Z","caller":"traceutil/trace.go:171","msg":"trace[585078985] transaction","detail":"{read_only:false; response_revision:98; number_of_response:1; }","duration":"178.024965ms","start":"2026-04-16T06:05:23.938777Z","end":"2026-04-16T06:05:24.116802Z","steps":["trace[585078985] 'process raft request' (duration: 75.411049ms)","trace[585078985] 'compare' (duration: 101.8039ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:24.116881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.284596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-16T06:05:24.11696Z","caller":"traceutil/trace.go:171","msg":"trace[2059042053] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:98; }","duration":"132.368841ms","start":"2026-04-16T06:05:23.984581Z","end":"2026-04-16T06:05:24.11695Z","steps":["trace[2059042053] 'agreement among raft nodes before linearized reading' (duration: 132.225853ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:24.460257Z","caller":"traceutil/trace.go:171","msg":"trace[948536564] transaction","detail":"{read_only:false; response_revision:116; number_of_response:1; }","duration":"126.906009ms","start":"2026-04-16T06:05:24.333313Z","end":"2026-04-16T06:05:24.460219Z","steps":["trace[948536564] 'process raft request' (duration: 122.754354ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:32.620287Z","caller":"traceutil/trace.go:171","msg":"trace[1629877074] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"110.416057ms","start":"2026-04-16T06:05:32.509856Z","end":"2026-04-16T06:05:32.620272Z","steps":["trace[1629877074] 'process raft request' (duration: 110.216615ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:32.620281Z","caller":"traceutil/trace.go:171","msg":"trace[2121842316] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"105.545686ms","start":"2026-04-16T06:05:32.514704Z","end":"2026-04-16T06:05:32.62025Z","steps":["trace[2121842316] 'read index received' (duration: 105.392537ms)","trace[2121842316] 'applied index is now lower than readState.Index' (duration: 151.679µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:32.6204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.692804ms","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-04-16T06:05:32.620574Z","caller":"traceutil/trace.go:171","msg":"trace[1451320222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:352; }","duration":"105.899927ms","start":"2026-04-16T06:05:32.514614Z","end":"2026-04-16T06:05:32.620514Z","steps":["trace[1451320222] 'agreement among raft nodes before linearized reading' (duration: 105.720116ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.64668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.996672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-04-16T06:05:32.646729Z","caller":"traceutil/trace.go:171","msg":"trace[496889041] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:353; }","duration":"131.073857ms","start":"2026-04-16T06:05:32.515644Z","end":"2026-04-16T06:05:32.646718Z","steps":["trace[496889041] 'agreement among raft nodes before linearized reading' (duration: 130.977801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.837064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.972285ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:05:32.837214Z","caller":"traceutil/trace.go:171","msg":"trace[565967635] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:364; }","duration":"171.504484ms","start":"2026-04-16T06:05:32.665691Z","end":"2026-04-16T06:05:32.837195Z","steps":["trace[565967635] 'read index received' (duration: 12.414469ms)","trace[565967635] 'applied index is now lower than readState.Index' (duration: 159.088455ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:32.837302Z","caller":"traceutil/trace.go:171","msg":"trace[1871014627] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"182.794498ms","start":"2026-04-16T06:05:32.654474Z","end":"2026-04-16T06:05:32.837268Z","steps":["trace[1871014627] 'process raft request' (duration: 40.400157ms)","trace[1871014627] 'compare' (duration: 141.827217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:32.837424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.723588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-16T06:05:32.837467Z","caller":"traceutil/trace.go:171","msg":"trace[1663307919] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:355; }","duration":"171.806233ms","start":"2026-04-16T06:05:32.665649Z","end":"2026-04-16T06:05:32.837455Z","steps":["trace[1663307919] 'agreement among raft nodes before linearized reading' (duration: 171.645913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.83765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.255912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-16T06:05:32.837699Z","caller":"traceutil/trace.go:171","msg":"trace[887743763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:355; }","duration":"121.356538ms","start":"2026-04-16T06:05:32.716329Z","end":"2026-04-16T06:05:32.837686Z","steps":["trace[887743763] 'agreement among raft nodes before linearized reading' (duration: 121.263402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.837853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.997768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-04-16T06:05:32.837887Z","caller":"traceutil/trace.go:171","msg":"trace[1218644198] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:355; }","duration":"118.064772ms","start":"2026-04-16T06:05:32.719815Z","end":"2026-04-16T06:05:32.837879Z","steps":["trace[1218644198] 'agreement among raft nodes before linearized reading' (duration: 118.008129ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.838179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.389472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-04-16T06:05:32.838206Z","caller":"traceutil/trace.go:171","msg":"trace[151545704] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:355; }","duration":"118.439354ms","start":"2026-04-16T06:05:32.71976Z","end":"2026-04-16T06:05:32.838199Z","steps":["trace[151545704] 'agreement among raft nodes before linearized reading' (duration: 118.385531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.838352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.628616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7303"} {"level":"info","ts":"2026-04-16T06:05:32.838387Z","caller":"traceutil/trace.go:171","msg":"trace[982627318] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:355; }","duration":"118.679499ms","start":"2026-04-16T06:05:32.719699Z","end":"2026-04-16T06:05:32.838379Z","steps":["trace[982627318] 'agreement among raft nodes before linearized reading' (duration: 118.619035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.838528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.903951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-bqr3o8\" ","response":"range_response_count:1 size:540"} {"level":"warn","ts":"2026-04-16T06:05:32.838529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.501468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5164"} {"level":"info","ts":"2026-04-16T06:05:32.838564Z","caller":"traceutil/trace.go:171","msg":"trace[1655588877] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-bqr3o8; range_end:; response_count:1; response_revision:355; }","duration":"118.976226ms","start":"2026-04-16T06:05:32.719579Z","end":"2026-04-16T06:05:32.838555Z","steps":["trace[1655588877] 'agreement among raft nodes before linearized reading' (duration: 118.920733ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:32.838577Z","caller":"traceutil/trace.go:171","msg":"trace[324217087] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:355; }","duration":"118.573702ms","start":"2026-04-16T06:05:32.719991Z","end":"2026-04-16T06:05:32.838565Z","steps":["trace[324217087] 'agreement among raft nodes before linearized reading' (duration: 118.486127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.83855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.595443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-16T06:05:32.83863Z","caller":"traceutil/trace.go:171","msg":"trace[1865187808] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:355; }","duration":"118.6953ms","start":"2026-04-16T06:05:32.719913Z","end":"2026-04-16T06:05:32.838609Z","steps":["trace[1865187808] 'agreement among raft nodes before linearized reading' (duration: 118.578573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.838702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.259163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4198"} {"level":"info","ts":"2026-04-16T06:05:32.838736Z","caller":"traceutil/trace.go:171","msg":"trace[1929230289] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:355; }","duration":"119.313286ms","start":"2026-04-16T06:05:32.719415Z","end":"2026-04-16T06:05:32.838728Z","steps":["trace[1929230289] 'agreement among raft nodes before linearized reading' (duration: 119.259292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:32.839289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.428883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4664"} {"level":"info","ts":"2026-04-16T06:05:32.839336Z","caller":"traceutil/trace.go:171","msg":"trace[1317765601] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:355; }","duration":"119.494187ms","start":"2026-04-16T06:05:32.719831Z","end":"2026-04-16T06:05:32.839325Z","steps":["trace[1317765601] 'agreement among raft nodes before linearized reading' (duration: 119.412082ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:34.890416Z","caller":"traceutil/trace.go:171","msg":"trace[1756217693] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"114.009788ms","start":"2026-04-16T06:05:34.776363Z","end":"2026-04-16T06:05:34.890372Z","steps":["trace[1756217693] 'process raft request' (duration: 36.304877ms)","trace[1756217693] 'compare' (duration: 77.391763ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:56.337983Z","caller":"traceutil/trace.go:171","msg":"trace[949691955] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:524; }","duration":"109.109492ms","start":"2026-04-16T06:05:56.228847Z","end":"2026-04-16T06:05:56.337957Z","steps":["trace[949691955] 'read index received' (duration: 14.392938ms)","trace[949691955] 'applied index is now lower than readState.Index' (duration: 94.715584ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:56.338124Z","caller":"traceutil/trace.go:171","msg":"trace[2007199759] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"101.778573ms","start":"2026-04-16T06:05:56.236319Z","end":"2026-04-16T06:05:56.338097Z","steps":["trace[2007199759] 'process raft request' (duration: 101.58181ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:56.337972Z","caller":"traceutil/trace.go:171","msg":"trace[923913321] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"113.846697ms","start":"2026-04-16T06:05:56.224066Z","end":"2026-04-16T06:05:56.337912Z","steps":["trace[923913321] 'process raft request' (duration: 113.575649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:56.338211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.340497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-04-16T06:05:56.338255Z","caller":"traceutil/trace.go:171","msg":"trace[1354665463] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:510; }","duration":"109.421622ms","start":"2026-04-16T06:05:56.228822Z","end":"2026-04-16T06:05:56.338244Z","steps":["trace[1354665463] 'agreement among raft nodes before linearized reading' (duration: 109.266251ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:56.33808Z","caller":"traceutil/trace.go:171","msg":"trace[451189112] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"108.741147ms","start":"2026-04-16T06:05:56.229324Z","end":"2026-04-16T06:05:56.338065Z","steps":["trace[451189112] 'process raft request' (duration: 108.528303ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:56.338505Z","caller":"traceutil/trace.go:171","msg":"trace[902438603] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"112.735242ms","start":"2026-04-16T06:05:56.225649Z","end":"2026-04-16T06:05:56.338384Z","steps":["trace[902438603] 'process raft request' (duration: 112.143693ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:56.362135Z","caller":"traceutil/trace.go:171","msg":"trace[1091841467] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"116.257127ms","start":"2026-04-16T06:05:56.245847Z","end":"2026-04-16T06:05:56.362104Z","steps":["trace[1091841467] 'process raft request' (duration: 116.046583ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:56.362942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.101143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-wfm8g\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-04-16T06:05:56.36302Z","caller":"traceutil/trace.go:171","msg":"trace[955417546] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-wfm8g; range_end:; response_count:1; response_revision:512; }","duration":"117.205801ms","start":"2026-04-16T06:05:56.245798Z","end":"2026-04-16T06:05:56.363004Z","steps":["trace[955417546] 'agreement among raft nodes before linearized reading' (duration: 116.814495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:59.651295Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439430611677453,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:05:59.739044Z","caller":"traceutil/trace.go:171","msg":"trace[1308565940] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"617.077209ms","start":"2026-04-16T06:05:59.12193Z","end":"2026-04-16T06:05:59.739007Z","steps":["trace[1308565940] 'process raft request' (duration: 573.310956ms)","trace[1308565940] 'compare' (duration: 43.180854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:05:59.739203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:59.121911Z","time spent":"617.210228ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:05:59.743835Z","caller":"traceutil/trace.go:171","msg":"trace[358840444] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:644; }","duration":"592.868772ms","start":"2026-04-16T06:05:59.150947Z","end":"2026-04-16T06:05:59.743816Z","steps":["trace[358840444] 'read index received' (duration: 544.268633ms)","trace[358840444] 'applied index is now lower than readState.Index' (duration: 48.598979ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:05:59.743951Z","caller":"traceutil/trace.go:171","msg":"trace[1558290758] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"245.081542ms","start":"2026-04-16T06:05:59.498859Z","end":"2026-04-16T06:05:59.74394Z","steps":["trace[1558290758] 'process raft request' (duration: 244.90139ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:05:59.74412Z","caller":"traceutil/trace.go:171","msg":"trace[807667595] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"445.04482ms","start":"2026-04-16T06:05:59.299038Z","end":"2026-04-16T06:05:59.744083Z","steps":["trace[807667595] 'process raft request' (duration: 444.690766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:59.744269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.311531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-04-16T06:05:59.744317Z","caller":"traceutil/trace.go:171","msg":"trace[176911424] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:627; }","duration":"593.380246ms","start":"2026-04-16T06:05:59.150924Z","end":"2026-04-16T06:05:59.744304Z","steps":["trace[176911424] 'agreement among raft nodes before linearized reading' (duration: 593.194873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:59.744355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:59.150908Z","time spent":"593.43954ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":1,"response size":7731,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-16T06:05:59.744345Z","caller":"traceutil/trace.go:171","msg":"trace[875090207] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"566.242061ms","start":"2026-04-16T06:05:59.178055Z","end":"2026-04-16T06:05:59.744297Z","steps":["trace[875090207] 'process raft request' (duration: 565.285067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:05:59.744502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:59.299012Z","time spent":"445.323089ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:05:59.744536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:05:59.178033Z","time spent":"566.406562ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:05:59.744419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.327601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:05:59.744722Z","caller":"traceutil/trace.go:171","msg":"trace[296604024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"219.689765ms","start":"2026-04-16T06:05:59.525009Z","end":"2026-04-16T06:05:59.744698Z","steps":["trace[296604024] 'agreement among raft nodes before linearized reading' (duration: 219.241925ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:00.426658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.722527ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:06:00.426831Z","caller":"traceutil/trace.go:171","msg":"trace[1607811704] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"298.814013ms","start":"2026-04-16T06:06:00.127978Z","end":"2026-04-16T06:06:00.426792Z","steps":["trace[1607811704] 'process raft request' (duration: 189.83098ms)","trace[1607811704] 'compare' (duration: 108.607068ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:00.426949Z","caller":"traceutil/trace.go:171","msg":"trace[790401335] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"287.713304ms","start":"2026-04-16T06:06:00.139206Z","end":"2026-04-16T06:06:00.426919Z","steps":["trace[790401335] 'read index received' (duration: 52.885948ms)","trace[790401335] 'applied index is now lower than readState.Index' (duration: 234.824916ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:00.539705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.93293ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T06:06:00.539791Z","caller":"traceutil/trace.go:171","msg":"trace[1036803288] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"112.76425ms","start":"2026-04-16T06:06:00.427013Z","end":"2026-04-16T06:06:00.539778Z","steps":["trace[1036803288] 'read index received' (duration: 44.763µs)","trace[1036803288] 'applied index is now lower than readState.Index' (duration: 112.718396ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:00.539804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.57885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:208485"} {"level":"info","ts":"2026-04-16T06:06:00.539882Z","caller":"traceutil/trace.go:171","msg":"trace[1360990132] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:638; }","duration":"400.697428ms","start":"2026-04-16T06:06:00.139165Z","end":"2026-04-16T06:06:00.539862Z","steps":["trace[1360990132] 'agreement among raft nodes before linearized reading' (duration: 287.871245ms)","trace[1360990132] 'range keys from in-memory index tree' (duration: 112.586617ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:00.539927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:00.139148Z","time spent":"400.766243ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":208508,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-04-16T06:06:00.539943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.019562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T06:06:00.539976Z","caller":"traceutil/trace.go:171","msg":"trace[356605905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:638; }","duration":"222.073025ms","start":"2026-04-16T06:06:00.317886Z","end":"2026-04-16T06:06:00.539959Z","steps":["trace[356605905] 'agreement among raft nodes before linearized reading' (duration: 221.959027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:00.540031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.018869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-04-16T06:06:00.540096Z","caller":"traceutil/trace.go:171","msg":"trace[1202147324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:638; }","duration":"243.132506ms","start":"2026-04-16T06:06:00.296946Z","end":"2026-04-16T06:06:00.540079Z","steps":["trace[1202147324] 'agreement among raft nodes before linearized reading' (duration: 242.929622ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:00.558266Z","caller":"traceutil/trace.go:171","msg":"trace[196783082] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"122.70682ms","start":"2026-04-16T06:06:00.435528Z","end":"2026-04-16T06:06:00.558235Z","steps":["trace[196783082] 'process raft request' (duration: 122.521918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:02.026025Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439430611677504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:06:02.526306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439430611677504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:06:02.57683Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.055000511s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T06:06:02.577262Z","caller":"traceutil/trace.go:171","msg":"trace[2099744270] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"1.055644725s","start":"2026-04-16T06:06:01.521598Z","end":"2026-04-16T06:06:02.577243Z","steps":["trace[2099744270] 'process raft request' (duration: 1.055514046s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:02.5774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:01.521579Z","time spent":"1.055746401s","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:06:03.043724Z","caller":"traceutil/trace.go:171","msg":"trace[271970584] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"1.518470981s","start":"2026-04-16T06:06:01.525237Z","end":"2026-04-16T06:06:03.043708Z","steps":["trace[271970584] 'read index received' (duration: 1.052272477s)","trace[271970584] 'applied index is now lower than readState.Index' (duration: 466.197854ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:03.043833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518595519s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.043814Z","caller":"traceutil/trace.go:171","msg":"trace[85658075] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.314399336s","start":"2026-04-16T06:06:01.729382Z","end":"2026-04-16T06:06:03.043781Z","steps":["trace[85658075] 'process raft request' (duration: 1.304991655s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.043863Z","caller":"traceutil/trace.go:171","msg":"trace[1359777693] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"1.518836845s","start":"2026-04-16T06:06:01.52502Z","end":"2026-04-16T06:06:03.043857Z","steps":["trace[1359777693] 'agreement among raft nodes before linearized reading' (duration: 1.51876612s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.04391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:01.524998Z","time spent":"1.51890606s","remote":"127.0.0.1:45242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:06:03.043995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:01.729342Z","time spent":"1.314574377s","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:06:03.045097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.209492034s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.045129Z","caller":"traceutil/trace.go:171","msg":"trace[2015492630] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:649; }","duration":"1.209563288s","start":"2026-04-16T06:06:01.835559Z","end":"2026-04-16T06:06:03.045122Z","steps":["trace[2015492630] 'agreement among raft nodes before linearized reading' (duration: 1.209505354s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.04515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:01.835538Z","time spent":"1.209606972s","remote":"127.0.0.1:45434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-04-16T06:06:03.045172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.854713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.045232Z","caller":"traceutil/trace.go:171","msg":"trace[978389637] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:649; }","duration":"536.94267ms","start":"2026-04-16T06:06:02.508276Z","end":"2026-04-16T06:06:03.045219Z","steps":["trace[978389637] 'agreement among raft nodes before linearized reading' (duration: 536.827972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.04519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.68079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.045274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.508257Z","time spent":"537.007654ms","remote":"127.0.0.1:49224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-16T06:06:03.045314Z","caller":"traceutil/trace.go:171","msg":"trace[209946025] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:649; }","duration":"219.874724ms","start":"2026-04-16T06:06:02.82542Z","end":"2026-04-16T06:06:03.045295Z","steps":["trace[209946025] 'agreement among raft nodes before linearized reading' (duration: 219.660749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.045404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.65756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-04-16T06:06:03.045433Z","caller":"traceutil/trace.go:171","msg":"trace[1241844144] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:649; }","duration":"541.709624ms","start":"2026-04-16T06:06:02.503717Z","end":"2026-04-16T06:06:03.045426Z","steps":["trace[1241844144] 'agreement among raft nodes before linearized reading' (duration: 541.557953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.045469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.31627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.045452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.503702Z","time spent":"541.745616ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:06:03.045512Z","caller":"traceutil/trace.go:171","msg":"trace[409538892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:649; }","duration":"246.393445ms","start":"2026-04-16T06:06:02.799105Z","end":"2026-04-16T06:06:03.045498Z","steps":["trace[409538892] 'agreement among raft nodes before linearized reading' (duration: 246.32191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.045675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.569061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.045731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.487345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.04579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.630421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.045796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.740395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-16T06:06:03.045814Z","caller":"traceutil/trace.go:171","msg":"trace[1261103690] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:649; }","duration":"100.601873ms","start":"2026-04-16T06:06:02.945195Z","end":"2026-04-16T06:06:03.045796Z","steps":["trace[1261103690] 'agreement among raft nodes before linearized reading' (duration: 100.436152ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.045835Z","caller":"traceutil/trace.go:171","msg":"trace[1641585745] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:649; }","duration":"246.76136ms","start":"2026-04-16T06:06:02.799063Z","end":"2026-04-16T06:06:03.045824Z","steps":["trace[1641585745] 'agreement among raft nodes before linearized reading' (duration: 246.628481ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.045851Z","caller":"traceutil/trace.go:171","msg":"trace[1655522646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"849.832151ms","start":"2026-04-16T06:06:02.196012Z","end":"2026-04-16T06:06:03.045844Z","steps":["trace[1655522646] 'agreement among raft nodes before linearized reading' (duration: 849.732354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.045899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.19599Z","time spent":"849.881635ms","remote":"127.0.0.1:45508","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-04-16T06:06:03.045895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.940225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.045956Z","caller":"traceutil/trace.go:171","msg":"trace[1064771323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:649; }","duration":"188.00462ms","start":"2026-04-16T06:06:02.85792Z","end":"2026-04-16T06:06:03.045924Z","steps":["trace[1064771323] 'agreement among raft nodes before linearized reading' (duration: 187.86518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.045992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.05347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.046028Z","caller":"traceutil/trace.go:171","msg":"trace[1294828458] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:649; }","duration":"247.116664ms","start":"2026-04-16T06:06:02.798903Z","end":"2026-04-16T06:06:03.046019Z","steps":["trace[1294828458] 'agreement among raft nodes before linearized reading' (duration: 247.063031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.046088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"948.832395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-16T06:06:03.046119Z","caller":"traceutil/trace.go:171","msg":"trace[1400404592] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:649; }","duration":"948.89465ms","start":"2026-04-16T06:06:02.097215Z","end":"2026-04-16T06:06:03.046109Z","steps":["trace[1400404592] 'agreement among raft nodes before linearized reading' (duration: 948.813325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.046142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.097196Z","time spent":"948.942233ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5200,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-04-16T06:06:03.04615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.234197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.046184Z","caller":"traceutil/trace.go:171","msg":"trace[449210635] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:649; }","duration":"384.27704ms","start":"2026-04-16T06:06:02.661899Z","end":"2026-04-16T06:06:03.046176Z","steps":["trace[449210635] 'agreement among raft nodes before linearized reading' (duration: 384.229087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.0462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.12969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.04623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.877114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.046255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.525627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.046262Z","caller":"traceutil/trace.go:171","msg":"trace[962359899] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:649; }","duration":"649.211095ms","start":"2026-04-16T06:06:02.397037Z","end":"2026-04-16T06:06:03.046248Z","steps":["trace[962359899] 'agreement among raft nodes before linearized reading' (duration: 649.123729ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.046287Z","caller":"traceutil/trace.go:171","msg":"trace[93673852] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:649; }","duration":"384.576291ms","start":"2026-04-16T06:06:02.661703Z","end":"2026-04-16T06:06:03.046279Z","steps":["trace[93673852] 'agreement among raft nodes before linearized reading' (duration: 384.534168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.046304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.397033Z","time spent":"649.261029ms","remote":"127.0.0.1:49216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:06:03.046308Z","caller":"traceutil/trace.go:171","msg":"trace[1651841168] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:649; }","duration":"219.943958ms","start":"2026-04-16T06:06:02.826313Z","end":"2026-04-16T06:06:03.046257Z","steps":["trace[1651841168] 'agreement among raft nodes before linearized reading' (duration: 219.840841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.04632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.661689Z","time spent":"384.625214ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:06:03.046339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.474335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"warn","ts":"2026-04-16T06:06:03.047068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.360636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.04716Z","caller":"traceutil/trace.go:171","msg":"trace[1126674377] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:649; }","duration":"538.804396ms","start":"2026-04-16T06:06:02.508315Z","end":"2026-04-16T06:06:03.047119Z","steps":["trace[1126674377] 'agreement among raft nodes before linearized reading' (duration: 538.684208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.047225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.473658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T06:06:03.047245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.50827Z","time spent":"538.959057ms","remote":"127.0.0.1:49224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:06:03.047298Z","caller":"traceutil/trace.go:171","msg":"trace[1769090247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:649; }","duration":"473.562365ms","start":"2026-04-16T06:06:02.573703Z","end":"2026-04-16T06:06:03.047265Z","steps":["trace[1769090247] 'agreement among raft nodes before linearized reading' (duration: 472.712267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.04734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.573687Z","time spent":"473.64231ms","remote":"127.0.0.1:45508","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-04-16T06:06:03.047707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.673265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.04777Z","caller":"traceutil/trace.go:171","msg":"trace[1589359551] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:649; }","duration":"650.738389ms","start":"2026-04-16T06:06:02.397015Z","end":"2026-04-16T06:06:03.047754Z","steps":["trace[1589359551] 'agreement among raft nodes before linearized reading' (duration: 650.539076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.047806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.396988Z","time spent":"650.806974ms","remote":"127.0.0.1:49216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:06:03.047852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.980237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.047963Z","caller":"traceutil/trace.go:171","msg":"trace[1878332033] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:649; }","duration":"222.493512ms","start":"2026-04-16T06:06:02.825431Z","end":"2026-04-16T06:06:03.047925Z","steps":["trace[1878332033] 'agreement among raft nodes before linearized reading' (duration: 221.965566ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.048189Z","caller":"traceutil/trace.go:171","msg":"trace[1143637377] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"374.39543ms","start":"2026-04-16T06:06:02.671982Z","end":"2026-04-16T06:06:03.046378Z","steps":["trace[1143637377] 'process raft request' (duration: 372.954701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.048301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.671953Z","time spent":"376.273738ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:03.048636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.548461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.048695Z","caller":"traceutil/trace.go:171","msg":"trace[1869982716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:649; }","duration":"539.794564ms","start":"2026-04-16T06:06:02.508874Z","end":"2026-04-16T06:06:03.048669Z","steps":["trace[1869982716] 'agreement among raft nodes before linearized reading' (duration: 537.554281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.048737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.508866Z","time spent":"539.859759ms","remote":"127.0.0.1:49224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:06:03.046404Z","caller":"traceutil/trace.go:171","msg":"trace[788498942] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:649; }","duration":"749.582063ms","start":"2026-04-16T06:06:02.29681Z","end":"2026-04-16T06:06:03.046392Z","steps":["trace[788498942] 'agreement among raft nodes before linearized reading' (duration: 748.67109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.049254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.296783Z","time spent":"752.441648ms","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-04-16T06:06:03.045762Z","caller":"traceutil/trace.go:171","msg":"trace[1703759428] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:649; }","duration":"100.670668ms","start":"2026-04-16T06:06:02.94506Z","end":"2026-04-16T06:06:03.045731Z","steps":["trace[1703759428] 'agreement among raft nodes before linearized reading' (duration: 100.577781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.05025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.260292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.046237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.149497733s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-04-16T06:06:03.050321Z","caller":"traceutil/trace.go:171","msg":"trace[1466989300] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:649; }","duration":"104.355438ms","start":"2026-04-16T06:06:02.945936Z","end":"2026-04-16T06:06:03.050291Z","steps":["trace[1466989300] 'agreement among raft nodes before linearized reading' (duration: 104.257752ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:03.050388Z","caller":"traceutil/trace.go:171","msg":"trace[1175615664] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:649; }","duration":"1.153608243s","start":"2026-04-16T06:06:01.896735Z","end":"2026-04-16T06:06:03.050343Z","steps":["trace[1175615664] 'agreement among raft nodes before linearized reading' (duration: 1.149467181s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.046077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.761192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:03.050422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.280075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.050457Z","caller":"traceutil/trace.go:171","msg":"trace[1513282746] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:649; }","duration":"192.477654ms","start":"2026-04-16T06:06:02.857966Z","end":"2026-04-16T06:06:03.050444Z","steps":["trace[1513282746] 'agreement among raft nodes before linearized reading' (duration: 187.739381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.050451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:01.896717Z","time spent":"1.15371411s","remote":"127.0.0.1:45302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"warn","ts":"2026-04-16T06:06:03.046217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.661893Z","time spent":"384.315773ms","remote":"127.0.0.1:49238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:06:03.050479Z","caller":"traceutil/trace.go:171","msg":"trace[715971234] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:649; }","duration":"647.36564ms","start":"2026-04-16T06:06:02.403102Z","end":"2026-04-16T06:06:03.050467Z","steps":["trace[715971234] 'agreement among raft nodes before linearized reading' (duration: 647.265674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.05107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:02.403086Z","time spent":"647.958742ms","remote":"127.0.0.1:49216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:06:03.05477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.139462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.054813Z","caller":"traceutil/trace.go:171","msg":"trace[1307769414] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:649; }","duration":"168.205486ms","start":"2026-04-16T06:06:02.886593Z","end":"2026-04-16T06:06:03.054798Z","steps":["trace[1307769414] 'agreement among raft nodes before linearized reading' (duration: 168.142782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.055008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.197394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.055041Z","caller":"traceutil/trace.go:171","msg":"trace[911204308] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:649; }","duration":"169.341764ms","start":"2026-04-16T06:06:02.885685Z","end":"2026-04-16T06:06:03.055027Z","steps":["trace[911204308] 'agreement among raft nodes before linearized reading' (duration: 169.179833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:03.055229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.523346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:03.055258Z","caller":"traceutil/trace.go:171","msg":"trace[2140265172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:649; }","duration":"169.597621ms","start":"2026-04-16T06:06:02.885647Z","end":"2026-04-16T06:06:03.055244Z","steps":["trace[2140265172] 'agreement among raft nodes before linearized reading' (duration: 169.519755ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:07.177735Z","caller":"traceutil/trace.go:171","msg":"trace[1937156724] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"378.018131ms","start":"2026-04-16T06:06:06.799694Z","end":"2026-04-16T06:06:07.177712Z","steps":["trace[1937156724] 'process raft request' (duration: 377.892023ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:07.177954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:06.799673Z","time spent":"378.208044ms","remote":"127.0.0.1:45412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:09.07673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.731648601s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:06:09.07697Z","caller":"traceutil/trace.go:171","msg":"trace[700463747] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"2.008328574s","start":"2026-04-16T06:06:07.068587Z","end":"2026-04-16T06:06:09.076915Z","steps":["trace[700463747] 'process raft request' (duration: 275.464259ms)","trace[700463747] 'compare' (duration: 1.72875408s)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:06:09.077039Z","caller":"traceutil/trace.go:171","msg":"trace[301565310] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"1.440396804s","start":"2026-04-16T06:06:07.63662Z","end":"2026-04-16T06:06:09.077017Z","steps":["trace[301565310] 'process raft request' (duration: 1.440302727s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.077123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.636597Z","time spent":"1.44049133s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:09.077117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.068554Z","time spent":"2.008482434s","remote":"127.0.0.1:45330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:06:09.077119Z","caller":"traceutil/trace.go:171","msg":"trace[1557322931] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:707; }","duration":"1.998889952s","start":"2026-04-16T06:06:07.078137Z","end":"2026-04-16T06:06:09.077027Z","steps":["trace[1557322931] 'read index received' (duration: 99.552186ms)","trace[1557322931] 'applied index is now lower than readState.Index' (duration: 1.899331826s)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:09.077319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999182843s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-16T06:06:09.077365Z","caller":"traceutil/trace.go:171","msg":"trace[1697094588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:687; }","duration":"1.999261549s","start":"2026-04-16T06:06:07.078088Z","end":"2026-04-16T06:06:09.07735Z","steps":["trace[1697094588] 'agreement among raft nodes before linearized reading' (duration: 1.999107338s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.077385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.078068Z","time spent":"1.999312612s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T06:06:09.077387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.911332434s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T06:06:09.077417Z","caller":"traceutil/trace.go:171","msg":"trace[2012959662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:687; }","duration":"1.911401379s","start":"2026-04-16T06:06:07.166007Z","end":"2026-04-16T06:06:09.077409Z","steps":["trace[2012959662] 'agreement among raft nodes before linearized reading' (duration: 1.911309173s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.077464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.997288613s","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-04-16T06:06:09.077487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.914094655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-16T06:06:09.077535Z","caller":"traceutil/trace.go:171","msg":"trace[762691778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:687; }","duration":"1.91416577s","start":"2026-04-16T06:06:07.163361Z","end":"2026-04-16T06:06:09.077526Z","steps":["trace[762691778] 'agreement among raft nodes before linearized reading' (duration: 1.914080284s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:09.077541Z","caller":"traceutil/trace.go:171","msg":"trace[462064944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:687; }","duration":"1.997369459s","start":"2026-04-16T06:06:07.080137Z","end":"2026-04-16T06:06:09.077506Z","steps":["trace[462064944] 'agreement among raft nodes before linearized reading' (duration: 1.997137533s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.07756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.163347Z","time spent":"1.914207573s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T06:06:09.077579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.550921926s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:06:09.077467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.165982Z","time spent":"1.911453323s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:06:09.077589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.080105Z","time spent":"1.997474246s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T06:06:09.077607Z","caller":"traceutil/trace.go:171","msg":"trace[549998895] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"1.550949028s","start":"2026-04-16T06:06:07.526649Z","end":"2026-04-16T06:06:09.077598Z","steps":["trace[549998895] 'agreement among raft nodes before linearized reading' (duration: 1.550849391s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.077636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.52659Z","time spent":"1.551032575s","remote":"127.0.0.1:45242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:06:09.077681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99493925s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:06:09.077707Z","caller":"traceutil/trace.go:171","msg":"trace[1208730663] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:687; }","duration":"1.994997395s","start":"2026-04-16T06:06:07.082703Z","end":"2026-04-16T06:06:09.077701Z","steps":["trace[1208730663] 'agreement among raft nodes before linearized reading' (duration: 1.994928841s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:09.077729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:07.082683Z","time spent":"1.995040788s","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T06:06:25.4556Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6432439430611677889,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:06:25.469053Z","caller":"traceutil/trace.go:171","msg":"trace[1414214721] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"514.546048ms","start":"2026-04-16T06:06:24.954485Z","end":"2026-04-16T06:06:25.469031Z","steps":["trace[1414214721] 'read index received' (duration: 514.346434ms)","trace[1414214721] 'applied index is now lower than readState.Index' (duration: 198.454µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:06:25.469202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.693359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:06:25.469211Z","caller":"traceutil/trace.go:171","msg":"trace[1249101397] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"570.213165ms","start":"2026-04-16T06:06:24.898885Z","end":"2026-04-16T06:06:25.469098Z","steps":["trace[1249101397] 'process raft request' (duration: 570.010871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.469353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.990319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T06:06:25.469385Z","caller":"traceutil/trace.go:171","msg":"trace[1714167207] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:808; }","duration":"310.053984ms","start":"2026-04-16T06:06:25.159323Z","end":"2026-04-16T06:06:25.469377Z","steps":["trace[1714167207] 'agreement among raft nodes before linearized reading' (duration: 309.941866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.46939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:24.898848Z","time spent":"570.436951ms","remote":"127.0.0.1:45412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:06:25.469422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.711057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:06:25.469478Z","caller":"traceutil/trace.go:171","msg":"trace[1403656266] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:808; }","duration":"294.818996ms","start":"2026-04-16T06:06:25.174646Z","end":"2026-04-16T06:06:25.469465Z","steps":["trace[1403656266] 'agreement among raft nodes before linearized reading' (duration: 294.669435ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:06:25.469239Z","caller":"traceutil/trace.go:171","msg":"trace[758497123] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:808; }","duration":"514.793766ms","start":"2026-04-16T06:06:24.954436Z","end":"2026-04-16T06:06:25.469229Z","steps":["trace[758497123] 'agreement among raft nodes before linearized reading' (duration: 514.71506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.469492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.456242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-16T06:06:25.469546Z","caller":"traceutil/trace.go:171","msg":"trace[2057539760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:808; }","duration":"305.534438ms","start":"2026-04-16T06:06:25.164004Z","end":"2026-04-16T06:06:25.469538Z","steps":["trace[2057539760] 'agreement among raft nodes before linearized reading' (duration: 305.438371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.469576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:25.163988Z","time spent":"305.582941ms","remote":"127.0.0.1:45508","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-04-16T06:06:25.469421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:25.159307Z","time spent":"310.104348ms","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:06:25.469628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.878544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:06:25.469691Z","caller":"traceutil/trace.go:171","msg":"trace[1897968354] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:808; }","duration":"244.983251ms","start":"2026-04-16T06:06:25.224691Z","end":"2026-04-16T06:06:25.469675Z","steps":["trace[1897968354] 'agreement among raft nodes before linearized reading' (duration: 244.758135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.469637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:24.954412Z","time spent":"515.169033ms","remote":"127.0.0.1:45546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:06:25.469629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.707146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-16T06:06:25.469797Z","caller":"traceutil/trace.go:171","msg":"trace[1164323965] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:808; }","duration":"298.882448ms","start":"2026-04-16T06:06:25.170882Z","end":"2026-04-16T06:06:25.469764Z","steps":["trace[1164323965] 'agreement among raft nodes before linearized reading' (duration: 298.606998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.471228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.203225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-16T06:06:25.471416Z","caller":"traceutil/trace.go:171","msg":"trace[1651750582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:808; }","duration":"305.454682ms","start":"2026-04-16T06:06:25.165932Z","end":"2026-04-16T06:06:25.471386Z","steps":["trace[1651750582] 'agreement among raft nodes before linearized reading' (duration: 303.401974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:06:25.472153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:06:25.165922Z","time spent":"306.201346ms","remote":"127.0.0.1:45508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T06:07:54.134051Z","caller":"traceutil/trace.go:171","msg":"trace[145110809] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"126.13713ms","start":"2026-04-16T06:07:54.007886Z","end":"2026-04-16T06:07:54.134023Z","steps":["trace[145110809] 'process raft request' (duration: 35.050295ms)","trace[145110809] 'compare' (duration: 90.918874ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:54.134227Z","caller":"traceutil/trace.go:171","msg":"trace[1885945712] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"117.028601ms","start":"2026-04-16T06:07:54.017182Z","end":"2026-04-16T06:07:54.134211Z","steps":["trace[1885945712] 'read index received' (duration: 25.722746ms)","trace[1885945712] 'applied index is now lower than readState.Index' (duration: 91.304805ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:07:54.134352Z","caller":"traceutil/trace.go:171","msg":"trace[633766114] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"125.139699ms","start":"2026-04-16T06:07:54.009201Z","end":"2026-04-16T06:07:54.134341Z","steps":["trace[633766114] 'process raft request' (duration: 124.780016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:07:54.134386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.188103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:07:54.13442Z","caller":"traceutil/trace.go:171","msg":"trace[1579746015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"117.273629ms","start":"2026-04-16T06:07:54.017137Z","end":"2026-04-16T06:07:54.13441Z","steps":["trace[1579746015] 'agreement among raft nodes before linearized reading' (duration: 117.131276ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:07:54.359695Z","caller":"traceutil/trace.go:171","msg":"trace[1400233668] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"220.901479ms","start":"2026-04-16T06:07:54.138764Z","end":"2026-04-16T06:07:54.359666Z","steps":["trace[1400233668] 'process raft request' (duration: 180.319751ms)","trace[1400233668] 'compare' (duration: 40.397827ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:08:08.19235Z","caller":"traceutil/trace.go:171","msg":"trace[1333733827] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"138.834683ms","start":"2026-04-16T06:08:08.053494Z","end":"2026-04-16T06:08:08.192328Z","steps":["trace[1333733827] 'process raft request' (duration: 138.722257ms)"],"step_count":1}