{"level":"warn","ts":"2026-06-18T12:35:09.554793Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T12:35:09.55489Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-18T12:35:09.554954Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T12:35:09.554966Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-06-18T12:35:09.554983Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-18T12:35:09.555625Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-06-18T12:35:09.555695Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-18T12:35:09.557809Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.852574ms"} {"level":"info","ts":"2026-06-18T12:35:09.577332Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-06-18T12:35:09.577435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-06-18T12:35:09.577457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-06-18T12:35:09.577473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-18T12:35:09.577482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-06-18T12:35:09.577524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-06-18T12:35:09.587132Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-18T12:35:09.593528Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-18T12:35:09.59507Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-18T12:35:09.597089Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-18T12:35:09.597361Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-18T12:35:09.599354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-06-18T12:35:09.599198Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-18T12:35:09.599427Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-18T12:35:09.599444Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-18T12:35:09.5995Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-06-18T12:35:09.603452Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-18T12:35:09.60361Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-06-18T12:35:09.60364Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-06-18T12:35:09.604031Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-18T12:35:09.604084Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-18T12:35:10.078117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-06-18T12:35:10.078184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-18T12:35:10.07823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-06-18T12:35:10.078251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-06-18T12:35:10.078273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-06-18T12:35:10.078301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-06-18T12:35:10.078315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-06-18T12:35:10.07984Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T12:35:10.080204Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-06-18T12:35:10.080311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T12:35:10.080366Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T12:35:10.08081Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T12:35:10.08096Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T12:35:10.081002Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T12:35:10.083304Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-06-18T12:35:10.084445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-18T12:35:10.086929Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-18T12:35:10.086967Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-18T12:35:14.200117Z","caller":"traceutil/trace.go:171","msg":"trace[751065176] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"140.311453ms","start":"2026-06-18T12:35:14.059784Z","end":"2026-06-18T12:35:14.200095Z","steps":["trace[751065176] 'process raft request' (duration: 140.169349ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:31.359687Z","caller":"traceutil/trace.go:171","msg":"trace[994782627] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"253.77427ms","start":"2026-06-18T12:35:31.105879Z","end":"2026-06-18T12:35:31.359653Z","steps":["trace[994782627] 'process raft request' (duration: 253.626597ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:31.484751Z","caller":"traceutil/trace.go:171","msg":"trace[1897410451] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"100.984663ms","start":"2026-06-18T12:35:31.383712Z","end":"2026-06-18T12:35:31.484696Z","steps":["trace[1897410451] 'process raft request' (duration: 72.066124ms)","trace[1897410451] 'compare' (duration: 28.729114ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:32.984312Z","caller":"traceutil/trace.go:171","msg":"trace[567436031] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:442; }","duration":"193.565177ms","start":"2026-06-18T12:35:32.790725Z","end":"2026-06-18T12:35:32.984291Z","steps":["trace[567436031] 'read index received' (duration: 193.454725ms)","trace[567436031] 'applied index is now lower than readState.Index' (duration: 109.812µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:32.984371Z","caller":"traceutil/trace.go:171","msg":"trace[397793181] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"197.072974ms","start":"2026-06-18T12:35:32.787262Z","end":"2026-06-18T12:35:32.984335Z","steps":["trace[397793181] 'process raft request' (duration: 196.929961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:32.984418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.678231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:32.984471Z","caller":"traceutil/trace.go:171","msg":"trace[1608099918] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:431; }","duration":"193.785392ms","start":"2026-06-18T12:35:32.790678Z","end":"2026-06-18T12:35:32.984464Z","steps":["trace[1608099918] 'agreement among raft nodes before linearized reading' (duration: 193.69613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:33.416803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.438579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-18T12:35:33.41691Z","caller":"traceutil/trace.go:171","msg":"trace[1792365092] linearizableReadLoop","detail":"{readStateIndex:444; appliedIndex:443; }","duration":"221.176764ms","start":"2026-06-18T12:35:33.195719Z","end":"2026-06-18T12:35:33.416895Z","steps":["trace[1792365092] 'read index received' (duration: 49.242633ms)","trace[1792365092] 'applied index is now lower than readState.Index' (duration: 171.933231ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:35:33.416985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.262395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.25\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-18T12:35:33.417008Z","caller":"traceutil/trace.go:171","msg":"trace[982118893] range","detail":"{range_begin:/registry/masterleases/199.204.45.25; range_end:; response_count:1; response_revision:432; }","duration":"221.319046ms","start":"2026-06-18T12:35:33.195682Z","end":"2026-06-18T12:35:33.417001Z","steps":["trace[982118893] 'agreement among raft nodes before linearized reading' (duration: 221.247924ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:33.417047Z","caller":"traceutil/trace.go:171","msg":"trace[1112200122] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"423.569875ms","start":"2026-06-18T12:35:32.993402Z","end":"2026-06-18T12:35:33.416972Z","steps":["trace[1112200122] 'process raft request' (duration: 251.608124ms)","trace[1112200122] 'compare' (duration: 171.261705ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:35:33.417198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:32.99337Z","time spent":"423.76363ms","remote":"127.0.0.1:60524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3678,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-18T12:35:34.976506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.157405684s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-18T12:35:34.976786Z","caller":"traceutil/trace.go:171","msg":"trace[1182491684] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"1.555527279s","start":"2026-06-18T12:35:33.421195Z","end":"2026-06-18T12:35:34.976722Z","steps":["trace[1182491684] 'process raft request' (duration: 397.843618ms)","trace[1182491684] 'compare' (duration: 1.157254691s)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:34.976887Z","caller":"traceutil/trace.go:171","msg":"trace[1793069024] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"1.555415637s","start":"2026-06-18T12:35:33.421437Z","end":"2026-06-18T12:35:34.976852Z","steps":["trace[1793069024] 'process raft request' (duration: 1.555179082s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.976971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.421183Z","time spent":"1.555710223s","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-18T12:35:34.976985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.42143Z","time spent":"1.555507269s","remote":"127.0.0.1:60202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-18T12:35:34.977031Z","caller":"traceutil/trace.go:171","msg":"trace[1035792480] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"1.552569194s","start":"2026-06-18T12:35:33.424448Z","end":"2026-06-18T12:35:34.977017Z","steps":["trace[1035792480] 'process raft request' (duration: 1.552237837s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.977274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.42444Z","time spent":"1.552625685s","remote":"127.0.0.1:60502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:35:34.977306Z","caller":"traceutil/trace.go:171","msg":"trace[538480115] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:445; }","duration":"1.488913814s","start":"2026-06-18T12:35:33.488381Z","end":"2026-06-18T12:35:34.977294Z","steps":["trace[538480115] 'read index received' (duration: 330.756773ms)","trace[538480115] 'applied index is now lower than readState.Index' (duration: 1.158156081s)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:34.977374Z","caller":"traceutil/trace.go:171","msg":"trace[1679507690] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"1.532597755s","start":"2026-06-18T12:35:33.444764Z","end":"2026-06-18T12:35:34.977361Z","steps":["trace[1679507690] 'process raft request' (duration: 1.532217317s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.977425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.444741Z","time spent":"1.532656326s","remote":"127.0.0.1:60052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:35:34.977481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.489101908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-18T12:35:34.977485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34639295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-18T12:35:34.977513Z","caller":"traceutil/trace.go:171","msg":"trace[1744412931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:436; }","duration":"1.489165659s","start":"2026-06-18T12:35:33.488337Z","end":"2026-06-18T12:35:34.977503Z","steps":["trace[1744412931] 'agreement among raft nodes before linearized reading' (duration: 1.489031156s)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:34.977528Z","caller":"traceutil/trace.go:171","msg":"trace[133009408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:436; }","duration":"1.346479241s","start":"2026-06-18T12:35:33.631037Z","end":"2026-06-18T12:35:34.977516Z","steps":["trace[133009408] 'agreement among raft nodes before linearized reading' (duration: 1.346349118s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.977544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.48832Z","time spent":"1.48921708s","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-18T12:35:34.977564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.631014Z","time spent":"1.346541103s","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-18T12:35:34.977602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184910979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T12:35:34.977664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.231105645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-18T12:35:34.977673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"958.193065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-18T12:35:34.977682Z","caller":"traceutil/trace.go:171","msg":"trace[900887679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"1.185019272s","start":"2026-06-18T12:35:33.79264Z","end":"2026-06-18T12:35:34.977659Z","steps":["trace[900887679] 'agreement among raft nodes before linearized reading' (duration: 1.184899809s)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:34.977692Z","caller":"traceutil/trace.go:171","msg":"trace[116863682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:436; }","duration":"1.231132045s","start":"2026-06-18T12:35:33.746551Z","end":"2026-06-18T12:35:34.977683Z","steps":["trace[116863682] 'agreement among raft nodes before linearized reading' (duration: 1.231081224s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.977724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.746489Z","time spent":"1.231230007s","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-18T12:35:34.977726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:33.792623Z","time spent":"1.185095393s","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-18T12:35:34.977729Z","caller":"traceutil/trace.go:171","msg":"trace[814828165] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:436; }","duration":"958.264217ms","start":"2026-06-18T12:35:34.019434Z","end":"2026-06-18T12:35:34.977698Z","steps":["trace[814828165] 'agreement among raft nodes before linearized reading' (duration: 958.203855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:34.977762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:34.019418Z","time spent":"958.337488ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-18T12:35:35.138854Z","caller":"traceutil/trace.go:171","msg":"trace[1903369835] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"155.313229ms","start":"2026-06-18T12:35:34.983491Z","end":"2026-06-18T12:35:35.138805Z","steps":["trace[1903369835] 'process raft request' (duration: 155.234397ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.138924Z","caller":"traceutil/trace.go:171","msg":"trace[521643990] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"155.459462ms","start":"2026-06-18T12:35:34.983396Z","end":"2026-06-18T12:35:35.138856Z","steps":["trace[521643990] 'process raft request' (duration: 139.536564ms)","trace[521643990] 'compare' (duration: 15.648272ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:35.139062Z","caller":"traceutil/trace.go:171","msg":"trace[1923612739] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"155.439392ms","start":"2026-06-18T12:35:34.983614Z","end":"2026-06-18T12:35:35.139053Z","steps":["trace[1923612739] 'process raft request' (duration: 155.150485ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.139183Z","caller":"traceutil/trace.go:171","msg":"trace[1233100920] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"152.889467ms","start":"2026-06-18T12:35:34.986278Z","end":"2026-06-18T12:35:35.139167Z","steps":["trace[1233100920] 'process raft request' (duration: 152.821475ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.139273Z","caller":"traceutil/trace.go:171","msg":"trace[1662233060] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"155.457163ms","start":"2026-06-18T12:35:34.983797Z","end":"2026-06-18T12:35:35.139254Z","steps":["trace[1662233060] 'process raft request' (duration: 155.197297ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.139329Z","caller":"traceutil/trace.go:171","msg":"trace[1435870918] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"153.254595ms","start":"2026-06-18T12:35:34.986064Z","end":"2026-06-18T12:35:35.139319Z","steps":["trace[1435870918] 'process raft request' (duration: 152.995409ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.139461Z","caller":"traceutil/trace.go:171","msg":"trace[740215008] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"153.093711ms","start":"2026-06-18T12:35:34.986357Z","end":"2026-06-18T12:35:35.139451Z","steps":["trace[740215008] 'process raft request' (duration: 152.778084ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.139546Z","caller":"traceutil/trace.go:171","msg":"trace[1794750536] linearizableReadLoop","detail":"{readStateIndex:451; appliedIndex:450; }","duration":"156.061987ms","start":"2026-06-18T12:35:34.983475Z","end":"2026-06-18T12:35:35.139537Z","steps":["trace[1794750536] 'read index received' (duration: 32.410612ms)","trace[1794750536] 'applied index is now lower than readState.Index' (duration: 123.650745ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:35.139578Z","caller":"traceutil/trace.go:171","msg":"trace[1710642574] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"151.22899ms","start":"2026-06-18T12:35:34.988337Z","end":"2026-06-18T12:35:35.139566Z","steps":["trace[1710642574] 'process raft request' (duration: 151.036156ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:35.139656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.163649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-18T12:35:35.139687Z","caller":"traceutil/trace.go:171","msg":"trace[570266628] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:445; }","duration":"156.22677ms","start":"2026-06-18T12:35:34.983451Z","end":"2026-06-18T12:35:35.139678Z","steps":["trace[570266628] 'agreement among raft nodes before linearized reading' (duration: 156.155068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:35.139687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.861072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:35.139717Z","caller":"traceutil/trace.go:171","msg":"trace[263734116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:445; }","duration":"150.910353ms","start":"2026-06-18T12:35:34.988798Z","end":"2026-06-18T12:35:35.139709Z","steps":["trace[263734116] 'agreement among raft nodes before linearized reading' (duration: 150.853612ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:35.263218Z","caller":"traceutil/trace.go:171","msg":"trace[141713724] transaction","detail":"{read_only:false; number_of_response:1; response_revision:448; }","duration":"110.097048ms","start":"2026-06-18T12:35:35.153095Z","end":"2026-06-18T12:35:35.263192Z","steps":["trace[141713724] 'process raft request' (duration: 99.028085ms)","trace[141713724] 'compare' (duration: 10.9236ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:43.062717Z","caller":"traceutil/trace.go:171","msg":"trace[1805062020] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:492; }","duration":"271.12408ms","start":"2026-06-18T12:35:42.791561Z","end":"2026-06-18T12:35:43.062685Z","steps":["trace[1805062020] 'read index received' (duration: 270.895866ms)","trace[1805062020] 'applied index is now lower than readState.Index' (duration: 227.264µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:43.062885Z","caller":"traceutil/trace.go:171","msg":"trace[265311] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"292.616392ms","start":"2026-06-18T12:35:42.770252Z","end":"2026-06-18T12:35:43.062868Z","steps":["trace[265311] 'process raft request' (duration: 292.296246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:43.062929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.359335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:43.062964Z","caller":"traceutil/trace.go:171","msg":"trace[100381700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"271.442157ms","start":"2026-06-18T12:35:42.791509Z","end":"2026-06-18T12:35:43.062951Z","steps":["trace[100381700] 'agreement among raft nodes before linearized reading' (duration: 271.377926ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:45.402072Z","caller":"traceutil/trace.go:171","msg":"trace[1597534665] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:501; }","duration":"121.104978ms","start":"2026-06-18T12:35:45.280947Z","end":"2026-06-18T12:35:45.402052Z","steps":["trace[1597534665] 'read index received' (duration: 29.365457ms)","trace[1597534665] 'applied index is now lower than readState.Index' (duration: 91.738631ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:35:45.402343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.374184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-18T12:35:45.40238Z","caller":"traceutil/trace.go:171","msg":"trace[390460368] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"123.907368ms","start":"2026-06-18T12:35:45.27843Z","end":"2026-06-18T12:35:45.402337Z","steps":["trace[390460368] 'process raft request' (duration: 123.580411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:45.402433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.80695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-18T12:35:45.402418Z","caller":"traceutil/trace.go:171","msg":"trace[1990234187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:488; }","duration":"121.498236ms","start":"2026-06-18T12:35:45.280905Z","end":"2026-06-18T12:35:45.402403Z","steps":["trace[1990234187] 'agreement among raft nodes before linearized reading' (duration: 121.351773ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:45.402503Z","caller":"traceutil/trace.go:171","msg":"trace[384136573] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:488; }","duration":"119.916203ms","start":"2026-06-18T12:35:45.28257Z","end":"2026-06-18T12:35:45.402486Z","steps":["trace[384136573] 'agreement among raft nodes before linearized reading' (duration: 119.78277ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:45.402117Z","caller":"traceutil/trace.go:171","msg":"trace[1260570287] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"123.810487ms","start":"2026-06-18T12:35:45.278274Z","end":"2026-06-18T12:35:45.402084Z","steps":["trace[1260570287] 'process raft request' (duration: 60.210287ms)","trace[1260570287] 'compare' (duration: 63.351673ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:45.730133Z","caller":"traceutil/trace.go:171","msg":"trace[1384351482] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"145.246484ms","start":"2026-06-18T12:35:45.584855Z","end":"2026-06-18T12:35:45.730102Z","steps":["trace[1384351482] 'process raft request' (duration: 144.837895ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:45.825672Z","caller":"traceutil/trace.go:171","msg":"trace[312037404] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"126.010443ms","start":"2026-06-18T12:35:45.699638Z","end":"2026-06-18T12:35:45.825649Z","steps":["trace[312037404] 'process raft request' (duration: 125.87259ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:45.849759Z","caller":"traceutil/trace.go:171","msg":"trace[258244791] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"116.602741ms","start":"2026-06-18T12:35:45.733109Z","end":"2026-06-18T12:35:45.849711Z","steps":["trace[258244791] 'process raft request' (duration: 111.046452ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.180423Z","caller":"traceutil/trace.go:171","msg":"trace[250839462] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"133.711531ms","start":"2026-06-18T12:35:46.046668Z","end":"2026-06-18T12:35:46.180379Z","steps":["trace[250839462] 'process raft request' (duration: 94.801852ms)","trace[250839462] 'compare' (duration: 38.49209ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:46.180828Z","caller":"traceutil/trace.go:171","msg":"trace[1044035924] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"133.953417ms","start":"2026-06-18T12:35:46.04686Z","end":"2026-06-18T12:35:46.180813Z","steps":["trace[1044035924] 'process raft request' (duration: 133.745882ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.180874Z","caller":"traceutil/trace.go:171","msg":"trace[1478224367] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"133.754812ms","start":"2026-06-18T12:35:46.047081Z","end":"2026-06-18T12:35:46.180836Z","steps":["trace[1478224367] 'process raft request' (duration: 133.617439ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.181124Z","caller":"traceutil/trace.go:171","msg":"trace[976889631] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"133.519426ms","start":"2026-06-18T12:35:46.047518Z","end":"2026-06-18T12:35:46.181037Z","steps":["trace[976889631] 'process raft request' (duration: 133.23515ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.181622Z","caller":"traceutil/trace.go:171","msg":"trace[80661742] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"132.707539ms","start":"2026-06-18T12:35:46.048901Z","end":"2026-06-18T12:35:46.181608Z","steps":["trace[80661742] 'process raft request' (duration: 131.890872ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.181952Z","caller":"traceutil/trace.go:171","msg":"trace[790151041] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"130.231657ms","start":"2026-06-18T12:35:46.051703Z","end":"2026-06-18T12:35:46.181935Z","steps":["trace[790151041] 'process raft request' (duration: 129.721075ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.181807Z","caller":"traceutil/trace.go:171","msg":"trace[2056521508] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:522; }","duration":"133.367863ms","start":"2026-06-18T12:35:46.048394Z","end":"2026-06-18T12:35:46.181762Z","steps":["trace[2056521508] 'read index received' (duration: 24.446072ms)","trace[2056521508] 'applied index is now lower than readState.Index' (duration: 108.920801ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:35:46.18227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.859865ms","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-06-18T12:35:46.182316Z","caller":"traceutil/trace.go:171","msg":"trace[298611559] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:513; }","duration":"133.977227ms","start":"2026-06-18T12:35:46.048326Z","end":"2026-06-18T12:35:46.182303Z","steps":["trace[298611559] 'agreement among raft nodes before linearized reading' (duration: 133.800914ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.424403Z","caller":"traceutil/trace.go:171","msg":"trace[2074445923] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:534; }","duration":"134.221622ms","start":"2026-06-18T12:35:46.290162Z","end":"2026-06-18T12:35:46.424383Z","steps":["trace[2074445923] 'read index received' (duration: 82.994249ms)","trace[2074445923] 'applied index is now lower than readState.Index' (duration: 51.226563ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:46.425016Z","caller":"traceutil/trace.go:171","msg":"trace[1262344037] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"172.558699ms","start":"2026-06-18T12:35:46.252445Z","end":"2026-06-18T12:35:46.425004Z","steps":["trace[1262344037] 'process raft request' (duration: 171.785553ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:46.425017Z","caller":"traceutil/trace.go:171","msg":"trace[1559027193] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"179.941337ms","start":"2026-06-18T12:35:46.245045Z","end":"2026-06-18T12:35:46.424986Z","steps":["trace[1559027193] 'process raft request' (duration: 128.158532ms)","trace[1559027193] 'compare' (duration: 50.792393ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:46.425329Z","caller":"traceutil/trace.go:171","msg":"trace[1465847361] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"171.441955ms","start":"2026-06-18T12:35:46.253849Z","end":"2026-06-18T12:35:46.425291Z","steps":["trace[1465847361] 'process raft request' (duration: 170.487995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:46.425525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.331746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"info","ts":"2026-06-18T12:35:46.425575Z","caller":"traceutil/trace.go:171","msg":"trace[1199685286] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:521; }","duration":"135.401478ms","start":"2026-06-18T12:35:46.290156Z","end":"2026-06-18T12:35:46.425558Z","steps":["trace[1199685286] 'agreement among raft nodes before linearized reading' (duration: 134.880376ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:47.994447Z","caller":"traceutil/trace.go:171","msg":"trace[435162625] transaction","detail":"{read_only:false; number_of_response:0; response_revision:551; }","duration":"132.414427ms","start":"2026-06-18T12:35:47.861997Z","end":"2026-06-18T12:35:47.994411Z","steps":["trace[435162625] 'process raft request' (duration: 115.491037ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:47.994658Z","caller":"traceutil/trace.go:171","msg":"trace[1641405797] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"110.765407ms","start":"2026-06-18T12:35:47.883869Z","end":"2026-06-18T12:35:47.994635Z","steps":["trace[1641405797] 'process raft request' (duration: 110.628264ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:47.994702Z","caller":"traceutil/trace.go:171","msg":"trace[1777012621] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"110.906369ms","start":"2026-06-18T12:35:47.883763Z","end":"2026-06-18T12:35:47.994669Z","steps":["trace[1777012621] 'process raft request' (duration: 110.610453ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:48.016533Z","caller":"traceutil/trace.go:171","msg":"trace[1845661792] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"110.402289ms","start":"2026-06-18T12:35:47.906105Z","end":"2026-06-18T12:35:48.016507Z","steps":["trace[1845661792] 'process raft request' (duration: 110.184545ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:48.016548Z","caller":"traceutil/trace.go:171","msg":"trace[208858042] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"110.273286ms","start":"2026-06-18T12:35:47.90625Z","end":"2026-06-18T12:35:48.016523Z","steps":["trace[208858042] 'process raft request' (duration: 110.195245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:49.530152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.797401ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-18T12:35:49.53083Z","caller":"traceutil/trace.go:171","msg":"trace[1048390074] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"878.814344ms","start":"2026-06-18T12:35:48.651974Z","end":"2026-06-18T12:35:49.530788Z","steps":["trace[1048390074] 'process raft request' (duration: 878.475267ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:49.530964Z","caller":"traceutil/trace.go:171","msg":"trace[2008417320] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:609; }","duration":"738.990307ms","start":"2026-06-18T12:35:48.791959Z","end":"2026-06-18T12:35:49.530949Z","steps":["trace[2008417320] 'read index received' (duration: 245.528381ms)","trace[2008417320] 'applied index is now lower than readState.Index' (duration: 493.461085ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:35:49.530973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:48.651954Z","time spent":"878.939877ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:35:49.531162Z","caller":"traceutil/trace.go:171","msg":"trace[1445650508] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"863.03913ms","start":"2026-06-18T12:35:48.668094Z","end":"2026-06-18T12:35:49.531134Z","steps":["trace[1445650508] 'process raft request' (duration: 862.641291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:49.531223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.522402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-18T12:35:49.531277Z","caller":"traceutil/trace.go:171","msg":"trace[706941741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:593; }","duration":"228.611124ms","start":"2026-06-18T12:35:49.302649Z","end":"2026-06-18T12:35:49.53126Z","steps":["trace[706941741] 'agreement among raft nodes before linearized reading' (duration: 228.491992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:49.531312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:48.668053Z","time spent":"863.172833ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-18T12:35:49.531319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.375993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T12:35:49.531452Z","caller":"traceutil/trace.go:171","msg":"trace[692309959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:593; }","duration":"189.545797ms","start":"2026-06-18T12:35:49.341892Z","end":"2026-06-18T12:35:49.531437Z","steps":["trace[692309959] 'agreement among raft nodes before linearized reading' (duration: 189.376363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:49.531513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.542238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:49.531557Z","caller":"traceutil/trace.go:171","msg":"trace[286119666] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:593; }","duration":"739.61831ms","start":"2026-06-18T12:35:48.791925Z","end":"2026-06-18T12:35:49.531544Z","steps":["trace[286119666] 'agreement among raft nodes before linearized reading' (duration: 739.178091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:49.531582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:48.79191Z","time spent":"739.667961ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-18T12:35:50.31143Z","caller":"traceutil/trace.go:171","msg":"trace[833933961] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"275.987175ms","start":"2026-06-18T12:35:50.035423Z","end":"2026-06-18T12:35:50.31141Z","steps":["trace[833933961] 'read index received' (duration: 275.593357ms)","trace[833933961] 'applied index is now lower than readState.Index' (duration: 392.888µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:50.311539Z","caller":"traceutil/trace.go:171","msg":"trace[1961484253] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"280.905179ms","start":"2026-06-18T12:35:50.03058Z","end":"2026-06-18T12:35:50.311486Z","steps":["trace[1961484253] 'process raft request' (duration: 280.605963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.311688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.243881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-06-18T12:35:50.312751Z","caller":"traceutil/trace.go:171","msg":"trace[1350552523] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:603; }","duration":"277.336384ms","start":"2026-06-18T12:35:50.035398Z","end":"2026-06-18T12:35:50.312734Z","steps":["trace[1350552523] 'agreement among raft nodes before linearized reading' (duration: 276.175699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.311856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.583459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.312859Z","caller":"traceutil/trace.go:171","msg":"trace[890242822] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:603; }","duration":"129.5691ms","start":"2026-06-18T12:35:50.18326Z","end":"2026-06-18T12:35:50.312829Z","steps":["trace[890242822] 'agreement among raft nodes before linearized reading' (duration: 128.565278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.311943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.055615ms","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-06-18T12:35:50.312973Z","caller":"traceutil/trace.go:171","msg":"trace[1935918080] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:603; }","duration":"241.156719ms","start":"2026-06-18T12:35:50.071806Z","end":"2026-06-18T12:35:50.312963Z","steps":["trace[1935918080] 'agreement among raft nodes before linearized reading' (duration: 240.020704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.311995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.539429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.313129Z","caller":"traceutil/trace.go:171","msg":"trace[1360598659] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:603; }","duration":"130.684043ms","start":"2026-06-18T12:35:50.182434Z","end":"2026-06-18T12:35:50.313118Z","steps":["trace[1360598659] 'agreement among raft nodes before linearized reading' (duration: 129.538998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.690532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.313269Z","caller":"traceutil/trace.go:171","msg":"trace[1002489402] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:603; }","duration":"130.935058ms","start":"2026-06-18T12:35:50.182324Z","end":"2026-06-18T12:35:50.313259Z","steps":["trace[1002489402] 'agreement among raft nodes before linearized reading' (duration: 129.707751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.293355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.313369Z","caller":"traceutil/trace.go:171","msg":"trace[1581764532] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"149.607323ms","start":"2026-06-18T12:35:50.163753Z","end":"2026-06-18T12:35:50.313361Z","steps":["trace[1581764532] 'agreement among raft nodes before linearized reading' (duration: 148.311355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.662403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.313462Z","caller":"traceutil/trace.go:171","msg":"trace[901297379] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"149.990911ms","start":"2026-06-18T12:35:50.163458Z","end":"2026-06-18T12:35:50.313449Z","steps":["trace[901297379] 'agreement among raft nodes before linearized reading' (duration: 148.660762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.801515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.313554Z","caller":"traceutil/trace.go:171","msg":"trace[234001118] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:603; }","duration":"150.203186ms","start":"2026-06-18T12:35:50.163343Z","end":"2026-06-18T12:35:50.313546Z","steps":["trace[234001118] 'agreement among raft nodes before linearized reading' (duration: 148.809476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.38511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.31361Z","caller":"traceutil/trace.go:171","msg":"trace[514321154] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:603; }","duration":"168.716136ms","start":"2026-06-18T12:35:50.144872Z","end":"2026-06-18T12:35:50.313588Z","steps":["trace[514321154] 'agreement among raft nodes before linearized reading' (duration: 167.392469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.312356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.220577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T12:35:50.312412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.324249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T12:35:50.312445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.809399ms","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-06-18T12:35:50.31254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.356681ms","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-06-18T12:35:50.312651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.783541ms","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-06-18T12:35:50.312655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.512665ms","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":"info","ts":"2026-06-18T12:35:50.313915Z","caller":"traceutil/trace.go:171","msg":"trace[1907211776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:603; }","duration":"169.860752ms","start":"2026-06-18T12:35:50.144047Z","end":"2026-06-18T12:35:50.313907Z","steps":["trace[1907211776] 'agreement among raft nodes before linearized reading' (duration: 168.323949ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:50.313922Z","caller":"traceutil/trace.go:171","msg":"trace[1723996771] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:603; }","duration":"196.73593ms","start":"2026-06-18T12:35:50.117175Z","end":"2026-06-18T12:35:50.313911Z","steps":["trace[1723996771] 'agreement among raft nodes before linearized reading' (duration: 195.284949ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:50.313948Z","caller":"traceutil/trace.go:171","msg":"trace[952075072] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:603; }","duration":"242.071578ms","start":"2026-06-18T12:35:50.071848Z","end":"2026-06-18T12:35:50.31392Z","steps":["trace[952075072] 'agreement among raft nodes before linearized reading' (duration: 240.776111ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:50.314087Z","caller":"traceutil/trace.go:171","msg":"trace[782888837] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:603; }","duration":"196.461233ms","start":"2026-06-18T12:35:50.117616Z","end":"2026-06-18T12:35:50.314077Z","steps":["trace[782888837] 'agreement among raft nodes before linearized reading' (duration: 194.812319ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:50.314157Z","caller":"traceutil/trace.go:171","msg":"trace[1054870339] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:603; }","duration":"170.048666ms","start":"2026-06-18T12:35:50.1441Z","end":"2026-06-18T12:35:50.314149Z","steps":["trace[1054870339] 'agreement among raft nodes before linearized reading' (duration: 168.234298ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:50.314389Z","caller":"traceutil/trace.go:171","msg":"trace[810699184] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:603; }","duration":"196.792072ms","start":"2026-06-18T12:35:50.117095Z","end":"2026-06-18T12:35:50.313887Z","steps":["trace[810699184] 'agreement among raft nodes before linearized reading' (duration: 195.489764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.657403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.023187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.657453Z","caller":"traceutil/trace.go:171","msg":"trace[579479029] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:603; }","duration":"250.093618ms","start":"2026-06-18T12:35:50.407349Z","end":"2026-06-18T12:35:50.657443Z","steps":["trace[579479029] 'count revisions from in-memory index tree' (duration: 249.974596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.657564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.282412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.657608Z","caller":"traceutil/trace.go:171","msg":"trace[1978636586] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:603; }","duration":"250.351013ms","start":"2026-06-18T12:35:50.407251Z","end":"2026-06-18T12:35:50.657602Z","steps":["trace[1978636586] 'range keys from in-memory index tree' (duration: 250.129579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.65789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.186476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570096"} {"level":"info","ts":"2026-06-18T12:35:50.657916Z","caller":"traceutil/trace.go:171","msg":"trace[262321564] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:603; }","duration":"238.235877ms","start":"2026-06-18T12:35:50.419674Z","end":"2026-06-18T12:35:50.65791Z","steps":["trace[262321564] 'range keys from in-memory index tree' (duration: 237.961161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.518398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.658151Z","caller":"traceutil/trace.go:171","msg":"trace[150357951] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:603; }","duration":"232.569408ms","start":"2026-06-18T12:35:50.425573Z","end":"2026-06-18T12:35:50.658143Z","steps":["trace[150357951] 'count revisions from in-memory index tree' (duration: 232.482077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.63627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.658305Z","caller":"traceutil/trace.go:171","msg":"trace[1033140841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:603; }","duration":"232.671801ms","start":"2026-06-18T12:35:50.425625Z","end":"2026-06-18T12:35:50.658297Z","steps":["trace[1033140841] 'range keys from in-memory index tree' (duration: 232.581498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.68102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.65844Z","caller":"traceutil/trace.go:171","msg":"trace[399458943] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:603; }","duration":"232.73432ms","start":"2026-06-18T12:35:50.425698Z","end":"2026-06-18T12:35:50.658432Z","steps":["trace[399458943] 'range keys from in-memory index tree' (duration: 232.631758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.037929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.658574Z","caller":"traceutil/trace.go:171","msg":"trace[1042368697] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:603; }","duration":"209.06827ms","start":"2026-06-18T12:35:50.449499Z","end":"2026-06-18T12:35:50.658567Z","steps":["trace[1042368697] 'count revisions from in-memory index tree' (duration: 209.000448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.07543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.658718Z","caller":"traceutil/trace.go:171","msg":"trace[1516960663] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:603; }","duration":"209.138721ms","start":"2026-06-18T12:35:50.449569Z","end":"2026-06-18T12:35:50.658708Z","steps":["trace[1516960663] 'range keys from in-memory index tree' (duration: 209.007498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.658883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.180932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.658926Z","caller":"traceutil/trace.go:171","msg":"trace[816015294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:603; }","duration":"209.226353ms","start":"2026-06-18T12:35:50.449691Z","end":"2026-06-18T12:35:50.658918Z","steps":["trace[816015294] 'range keys from in-memory index tree' (duration: 209.130631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.659043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.865516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.659073Z","caller":"traceutil/trace.go:171","msg":"trace[1165092719] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"155.905016ms","start":"2026-06-18T12:35:50.50316Z","end":"2026-06-18T12:35:50.659065Z","steps":["trace[1165092719] 'count revisions from in-memory index tree' (duration: 155.836604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.659392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.07494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.659417Z","caller":"traceutil/trace.go:171","msg":"trace[1086056165] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"156.323424ms","start":"2026-06-18T12:35:50.503088Z","end":"2026-06-18T12:35:50.659412Z","steps":["trace[1086056165] 'range keys from in-memory index tree' (duration: 155.975628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.659512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.818367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.659536Z","caller":"traceutil/trace.go:171","msg":"trace[973302689] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"114.865839ms","start":"2026-06-18T12:35:50.544665Z","end":"2026-06-18T12:35:50.659531Z","steps":["trace[973302689] 'range keys from in-memory index tree' (duration: 114.763076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.659646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.994912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.659669Z","caller":"traceutil/trace.go:171","msg":"trace[1619435079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"115.057803ms","start":"2026-06-18T12:35:50.544606Z","end":"2026-06-18T12:35:50.659663Z","steps":["trace[1619435079] 'range keys from in-memory index tree' (duration: 114.872239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.659767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.022011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.659794Z","caller":"traceutil/trace.go:171","msg":"trace[998892133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:603; }","duration":"115.071833ms","start":"2026-06-18T12:35:50.544715Z","end":"2026-06-18T12:35:50.659787Z","steps":["trace[998892133] 'count revisions from in-memory index tree' (duration: 114.9666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.65991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.106045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.65994Z","caller":"traceutil/trace.go:171","msg":"trace[841660232] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"107.158156ms","start":"2026-06-18T12:35:50.552774Z","end":"2026-06-18T12:35:50.659932Z","steps":["trace[841660232] 'range keys from in-memory index tree' (duration: 107.039344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.660061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.039813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.66009Z","caller":"traceutil/trace.go:171","msg":"trace[1819186178] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"107.092935ms","start":"2026-06-18T12:35:50.552988Z","end":"2026-06-18T12:35:50.660081Z","steps":["trace[1819186178] 'count revisions from in-memory index tree' (duration: 106.975771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:50.660311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.506883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:50.660348Z","caller":"traceutil/trace.go:171","msg":"trace[925985635] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:603; }","duration":"106.555253ms","start":"2026-06-18T12:35:50.553785Z","end":"2026-06-18T12:35:50.66034Z","steps":["trace[925985635] 'range keys from in-memory index tree' (duration: 106.44151ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:35:54.532263Z","caller":"traceutil/trace.go:171","msg":"trace[1815208889] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"299.975023ms","start":"2026-06-18T12:35:54.232268Z","end":"2026-06-18T12:35:54.532243Z","steps":["trace[1815208889] 'process raft request' (duration: 299.796258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:54.532377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:54.232249Z","time spent":"300.077704ms","remote":"127.0.0.1:60126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":397,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-18T12:35:55.808508Z","caller":"traceutil/trace.go:171","msg":"trace[983688780] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"118.117272ms","start":"2026-06-18T12:35:55.690367Z","end":"2026-06-18T12:35:55.808484Z","steps":["trace[983688780] 'process raft request' (duration: 66.377799ms)","trace[983688780] 'compare' (duration: 51.627151ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:56.68001Z","caller":"traceutil/trace.go:171","msg":"trace[1413781324] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"356.518309ms","start":"2026-06-18T12:35:56.323473Z","end":"2026-06-18T12:35:56.679991Z","steps":["trace[1413781324] 'process raft request' (duration: 356.405577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:56.680122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:56.32345Z","time spent":"356.616742ms","remote":"127.0.0.1:60202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:35:57.293099Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423282443652715,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-18T12:35:57.585549Z","caller":"traceutil/trace.go:171","msg":"trace[1713839080] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"792.540967ms","start":"2026-06-18T12:35:56.792985Z","end":"2026-06-18T12:35:57.585526Z","steps":["trace[1713839080] 'read index received' (duration: 791.753492ms)","trace[1713839080] 'applied index is now lower than readState.Index' (duration: 786.495µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:57.585641Z","caller":"traceutil/trace.go:171","msg":"trace[878451431] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.040675472s","start":"2026-06-18T12:35:56.544932Z","end":"2026-06-18T12:35:57.585607Z","steps":["trace[878451431] 'process raft request' (duration: 1.040049039s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:57.585772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"792.768672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T12:35:57.585802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:56.544902Z","time spent":"1.040808664s","remote":"127.0.0.1:60104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:35:57.585837Z","caller":"traceutil/trace.go:171","msg":"trace[481786204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"792.891674ms","start":"2026-06-18T12:35:56.792931Z","end":"2026-06-18T12:35:57.585822Z","steps":["trace[481786204] 'agreement among raft nodes before linearized reading' (duration: 792.746391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:57.585878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:56.792904Z","time spent":"792.966436ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-18T12:35:58.145208Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423282443652718,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-18T12:35:58.448589Z","caller":"traceutil/trace.go:171","msg":"trace[1133279231] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"803.737765ms","start":"2026-06-18T12:35:57.644831Z","end":"2026-06-18T12:35:58.448569Z","steps":["trace[1133279231] 'read index received' (duration: 803.622873ms)","trace[1133279231] 'applied index is now lower than readState.Index' (duration: 114.062µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:35:58.448657Z","caller":"traceutil/trace.go:171","msg":"trace[573088656] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"814.888428ms","start":"2026-06-18T12:35:57.633735Z","end":"2026-06-18T12:35:58.448623Z","steps":["trace[573088656] 'process raft request' (duration: 814.708505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.448803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.96499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-18T12:35:58.448806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.633708Z","time spent":"815.03056ms","remote":"127.0.0.1:60362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-18T12:35:58.448835Z","caller":"traceutil/trace.go:171","msg":"trace[257453693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"804.047831ms","start":"2026-06-18T12:35:57.644779Z","end":"2026-06-18T12:35:58.448827Z","steps":["trace[257453693] 'agreement among raft nodes before linearized reading' (duration: 803.895418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.448859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.64476Z","time spent":"804.094093ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-18T12:35:58.448964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.788443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:35:58.449025Z","caller":"traceutil/trace.go:171","msg":"trace[1309556006] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"659.883605ms","start":"2026-06-18T12:35:57.789123Z","end":"2026-06-18T12:35:58.449007Z","steps":["trace[1309556006] 'agreement among raft nodes before linearized reading' (duration: 659.808033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.449059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.78908Z","time spent":"659.970997ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-18T12:35:58.449062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.155628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-18T12:35:58.449128Z","caller":"traceutil/trace.go:171","msg":"trace[2118698655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"797.236269ms","start":"2026-06-18T12:35:57.651881Z","end":"2026-06-18T12:35:58.449117Z","steps":["trace[2118698655] 'agreement among raft nodes before linearized reading' (duration: 797.101576ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.449425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.856343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-18T12:35:58.449469Z","caller":"traceutil/trace.go:171","msg":"trace[2037580660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"797.927454ms","start":"2026-06-18T12:35:57.65153Z","end":"2026-06-18T12:35:58.449457Z","steps":["trace[2037580660] 'agreement among raft nodes before linearized reading' (duration: 797.345252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.449467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.651875Z","time spent":"797.578976ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-18T12:35:58.449515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.651514Z","time spent":"797.987016ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-18T12:35:58.449694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.308231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T12:35:58.449787Z","caller":"traceutil/trace.go:171","msg":"trace[450643176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"797.417213ms","start":"2026-06-18T12:35:57.652346Z","end":"2026-06-18T12:35:58.449764Z","steps":["trace[450643176] 'agreement among raft nodes before linearized reading' (duration: 796.555256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:35:58.449839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:57.652288Z","time spent":"797.541656ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-18T12:36:00.134113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.427883447s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-18T12:36:00.134141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.885619ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:00.134248Z","caller":"traceutil/trace.go:171","msg":"trace[1047061055] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:639; }","duration":"471.003373ms","start":"2026-06-18T12:35:59.66322Z","end":"2026-06-18T12:36:00.134223Z","steps":["trace[1047061055] 'range keys from in-memory index tree' (duration: 470.865499ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:00.134283Z","caller":"traceutil/trace.go:171","msg":"trace[1029436261] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"1.342755336s","start":"2026-06-18T12:35:58.791437Z","end":"2026-06-18T12:36:00.134192Z","steps":["trace[1029436261] 'read index received' (duration: 43.802µs)","trace[1029436261] 'applied index is now lower than readState.Index' (duration: 1.342710424s)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:00.13435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.342903039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:00.134372Z","caller":"traceutil/trace.go:171","msg":"trace[2065808485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"1.342958341s","start":"2026-06-18T12:35:58.791406Z","end":"2026-06-18T12:36:00.134364Z","steps":["trace[2065808485] 'agreement among raft nodes before linearized reading' (duration: 1.342903129s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:00.134397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:58.791391Z","time spent":"1.343000661s","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-18T12:36:00.636364Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423282443652730,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-18T12:36:00.797042Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.874471614s","expected-duration":"1s"} {"level":"info","ts":"2026-06-18T12:36:00.798721Z","caller":"traceutil/trace.go:171","msg":"trace[609267466] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"662.562182ms","start":"2026-06-18T12:36:00.136133Z","end":"2026-06-18T12:36:00.798696Z","steps":["trace[609267466] 'read index received' (duration: 661.087992ms)","trace[609267466] 'applied index is now lower than readState.Index' (duration: 1.47308ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:00.798753Z","caller":"traceutil/trace.go:171","msg":"trace[1886966969] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"1.883127534s","start":"2026-06-18T12:35:58.915591Z","end":"2026-06-18T12:36:00.798719Z","steps":["trace[1886966969] 'process raft request' (duration: 1.882076952s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:00.798989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:35:58.915559Z","time spent":"1.883313618s","remote":"127.0.0.1:60104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:36:00.799026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.868288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:00.799099Z","caller":"traceutil/trace.go:171","msg":"trace[426132682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:640; }","duration":"662.989041ms","start":"2026-06-18T12:36:00.136093Z","end":"2026-06-18T12:36:00.799082Z","steps":["trace[426132682] 'agreement among raft nodes before linearized reading' (duration: 662.788827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:00.799177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:00.136076Z","time spent":"663.089483ms","remote":"127.0.0.1:60026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-18T12:36:00.799286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.172314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-18T12:36:00.799163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.811032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-18T12:36:00.799315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.155845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-18T12:36:00.799328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.210976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-18T12:36:00.799342Z","caller":"traceutil/trace.go:171","msg":"trace[367466441] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"319.047978ms","start":"2026-06-18T12:36:00.480278Z","end":"2026-06-18T12:36:00.799326Z","steps":["trace[367466441] 'agreement among raft nodes before linearized reading' (duration: 318.70637ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:00.79937Z","caller":"traceutil/trace.go:171","msg":"trace[1863346861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"283.205696ms","start":"2026-06-18T12:36:00.516147Z","end":"2026-06-18T12:36:00.799353Z","steps":["trace[1863346861] 'agreement among raft nodes before linearized reading' (duration: 283.081472ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:00.799387Z","caller":"traceutil/trace.go:171","msg":"trace[1873872655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"283.308337ms","start":"2026-06-18T12:36:00.516063Z","end":"2026-06-18T12:36:00.799372Z","steps":["trace[1873872655] 'agreement among raft nodes before linearized reading' (duration: 283.146803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:00.799394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:00.480257Z","time spent":"319.124039ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-18T12:36:00.799326Z","caller":"traceutil/trace.go:171","msg":"trace[164348671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"283.243526ms","start":"2026-06-18T12:36:00.516068Z","end":"2026-06-18T12:36:00.799311Z","steps":["trace[164348671] 'agreement among raft nodes before linearized reading' (duration: 283.154483ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:02.07379Z","caller":"traceutil/trace.go:171","msg":"trace[680255621] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"183.299343ms","start":"2026-06-18T12:36:01.890463Z","end":"2026-06-18T12:36:02.073762Z","steps":["trace[680255621] 'process raft request' (duration: 182.6898ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:02.691852Z","caller":"traceutil/trace.go:171","msg":"trace[285585562] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"158.445304ms","start":"2026-06-18T12:36:02.533384Z","end":"2026-06-18T12:36:02.691829Z","steps":["trace[285585562] 'process raft request' (duration: 156.76143ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:03.577479Z","caller":"traceutil/trace.go:171","msg":"trace[730108163] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"274.820742ms","start":"2026-06-18T12:36:03.302629Z","end":"2026-06-18T12:36:03.577449Z","steps":["trace[730108163] 'process raft request' (duration: 274.411473ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:03.577445Z","caller":"traceutil/trace.go:171","msg":"trace[1419708477] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"231.862445ms","start":"2026-06-18T12:36:03.345299Z","end":"2026-06-18T12:36:03.577162Z","steps":["trace[1419708477] 'read index received' (duration: 231.66926ms)","trace[1419708477] 'applied index is now lower than readState.Index' (duration: 192.065µs)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:03.577889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.541878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dkktz\" ","response":"range_response_count:1 size:17520"} {"level":"info","ts":"2026-06-18T12:36:03.577954Z","caller":"traceutil/trace.go:171","msg":"trace[466869593] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dkktz; range_end:; response_count:1; response_revision:686; }","duration":"232.66791ms","start":"2026-06-18T12:36:03.345268Z","end":"2026-06-18T12:36:03.577936Z","steps":["trace[466869593] 'agreement among raft nodes before linearized reading' (duration: 232.265682ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:03.909903Z","caller":"traceutil/trace.go:171","msg":"trace[1316922651] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"394.901188ms","start":"2026-06-18T12:36:03.514978Z","end":"2026-06-18T12:36:03.909879Z","steps":["trace[1316922651] 'process raft request' (duration: 394.842267ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:03.909918Z","caller":"traceutil/trace.go:171","msg":"trace[1663055779] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"564.472887ms","start":"2026-06-18T12:36:03.34537Z","end":"2026-06-18T12:36:03.909843Z","steps":["trace[1663055779] 'process raft request' (duration: 544.668608ms)","trace[1663055779] 'compare' (duration: 19.528093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:03.910085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.34535Z","time spent":"564.658981ms","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":765,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-18T12:36:03.909923Z","caller":"traceutil/trace.go:171","msg":"trace[1428652322] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"408.08179ms","start":"2026-06-18T12:36:03.501811Z","end":"2026-06-18T12:36:03.909893Z","steps":["trace[1428652322] 'process raft request' (duration: 407.951957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:03.910293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.501782Z","time spent":"408.459378ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-18T12:36:03.91029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.514951Z","time spent":"395.03154ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:03.953973Z","caller":"traceutil/trace.go:171","msg":"trace[1276756581] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"366.809448ms","start":"2026-06-18T12:36:03.587141Z","end":"2026-06-18T12:36:03.95395Z","steps":["trace[1276756581] 'process raft request' (duration: 366.617764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:03.954107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.587112Z","time spent":"366.926291ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:03.954228Z","caller":"traceutil/trace.go:171","msg":"trace[414664540] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:708; }","duration":"254.079913ms","start":"2026-06-18T12:36:03.70014Z","end":"2026-06-18T12:36:03.954219Z","steps":["trace[414664540] 'read index received' (duration: 189.914818ms)","trace[414664540] 'applied index is now lower than readState.Index' (duration: 64.164675ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:03.954459Z","caller":"traceutil/trace.go:171","msg":"trace[1565572453] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"355.24822ms","start":"2026-06-18T12:36:03.599202Z","end":"2026-06-18T12:36:03.95445Z","steps":["trace[1565572453] 'process raft request' (duration: 354.687279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:03.954508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.599184Z","time spent":"355.297532ms","remote":"127.0.0.1:60202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17771,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:36:03.954613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.971942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:03.954748Z","caller":"traceutil/trace.go:171","msg":"trace[434444728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"162.110295ms","start":"2026-06-18T12:36:03.792594Z","end":"2026-06-18T12:36:03.954705Z","steps":["trace[434444728] 'agreement among raft nodes before linearized reading' (duration: 161.930632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:03.95501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.865259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:03.955167Z","caller":"traceutil/trace.go:171","msg":"trace[726383537] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:691; }","duration":"255.044493ms","start":"2026-06-18T12:36:03.70011Z","end":"2026-06-18T12:36:03.955154Z","steps":["trace[726383537] 'agreement among raft nodes before linearized reading' (duration: 254.865319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:04.180739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.219124ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T12:36:04.180852Z","caller":"traceutil/trace.go:171","msg":"trace[958694448] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"214.726785ms","start":"2026-06-18T12:36:03.966107Z","end":"2026-06-18T12:36:04.180834Z","steps":["trace[958694448] 'process raft request' (duration: 99.340227ms)","trace[958694448] 'compare' (duration: 115.105231ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:04.3811Z","caller":"traceutil/trace.go:171","msg":"trace[353658413] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"410.442256ms","start":"2026-06-18T12:36:03.970637Z","end":"2026-06-18T12:36:04.38108Z","steps":["trace[353658413] 'process raft request' (duration: 410.388205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:04.381581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.970618Z","time spent":"410.903244ms","remote":"127.0.0.1:60202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4675,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:04.38118Z","caller":"traceutil/trace.go:171","msg":"trace[1880328390] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"413.406926ms","start":"2026-06-18T12:36:03.967753Z","end":"2026-06-18T12:36:04.38116Z","steps":["trace[1880328390] 'process raft request' (duration: 401.93939ms)","trace[1880328390] 'compare' (duration: 11.255522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:04.381953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:03.967731Z","time spent":"414.115292ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:04.38251Z","caller":"traceutil/trace.go:171","msg":"trace[1716912518] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"279.413437ms","start":"2026-06-18T12:36:04.103075Z","end":"2026-06-18T12:36:04.382488Z","steps":["trace[1716912518] 'process raft request' (duration: 279.140561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:04.818574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.084972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:04.818684Z","caller":"traceutil/trace.go:171","msg":"trace[920503156] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:705; }","duration":"118.276286ms","start":"2026-06-18T12:36:04.700382Z","end":"2026-06-18T12:36:04.818659Z","steps":["trace[920503156] 'range keys from in-memory index tree' (duration: 117.98977ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:06.943544Z","caller":"traceutil/trace.go:171","msg":"trace[1264650983] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"377.309587ms","start":"2026-06-18T12:36:06.566204Z","end":"2026-06-18T12:36:06.943514Z","steps":["trace[1264650983] 'process raft request' (duration: 377.061642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:06.943748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:06.566181Z","time spent":"377.455019ms","remote":"127.0.0.1:60064","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-06-18T12:36:07.064726Z","caller":"traceutil/trace.go:171","msg":"trace[90642211] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"465.758369ms","start":"2026-06-18T12:36:06.598937Z","end":"2026-06-18T12:36:07.064695Z","steps":["trace[90642211] 'process raft request' (duration: 438.880368ms)","trace[90642211] 'compare' (duration: 26.652556ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:07.064916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:06.598903Z","time spent":"465.920502ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:07.065085Z","caller":"traceutil/trace.go:171","msg":"trace[1684530087] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:748; }","duration":"363.778776ms","start":"2026-06-18T12:36:06.701283Z","end":"2026-06-18T12:36:07.065062Z","steps":["trace[1684530087] 'read index received' (duration: 241.941827ms)","trace[1684530087] 'applied index is now lower than readState.Index' (duration: 121.835789ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:07.065373Z","caller":"traceutil/trace.go:171","msg":"trace[2094208823] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"423.34664ms","start":"2026-06-18T12:36:06.641836Z","end":"2026-06-18T12:36:07.065183Z","steps":["trace[2094208823] 'process raft request' (duration: 422.801988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.065518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:06.641816Z","time spent":"423.659325ms","remote":"127.0.0.1:60092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-18T12:36:07.065613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.303306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-06-18T12:36:07.065699Z","caller":"traceutil/trace.go:171","msg":"trace[261150101] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:729; }","duration":"364.442699ms","start":"2026-06-18T12:36:06.70124Z","end":"2026-06-18T12:36:07.065683Z","steps":["trace[261150101] 'agreement among raft nodes before linearized reading' (duration: 364.038991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.065823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:06.70122Z","time spent":"364.589442ms","remote":"127.0.0.1:60064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-18T12:36:07.098794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.65725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T12:36:07.098876Z","caller":"traceutil/trace.go:171","msg":"trace[523278750] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:730; }","duration":"190.742481ms","start":"2026-06-18T12:36:06.908119Z","end":"2026-06-18T12:36:07.098861Z","steps":["trace[523278750] 'agreement among raft nodes before linearized reading' (duration: 190.619959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.098778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.919266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-18T12:36:07.098977Z","caller":"traceutil/trace.go:171","msg":"trace[2143570790] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:730; }","duration":"191.157272ms","start":"2026-06-18T12:36:06.907806Z","end":"2026-06-18T12:36:07.098963Z","steps":["trace[2143570790] 'agreement among raft nodes before linearized reading' (duration: 190.851185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.098928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.512221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-18T12:36:07.099045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.265693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-18T12:36:07.099048Z","caller":"traceutil/trace.go:171","msg":"trace[1190641483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:730; }","duration":"196.670124ms","start":"2026-06-18T12:36:06.902359Z","end":"2026-06-18T12:36:07.099029Z","steps":["trace[1190641483] 'agreement among raft nodes before linearized reading' (duration: 196.346667ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:07.099093Z","caller":"traceutil/trace.go:171","msg":"trace[25234015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"191.335545ms","start":"2026-06-18T12:36:06.907742Z","end":"2026-06-18T12:36:07.099078Z","steps":["trace[25234015] 'agreement among raft nodes before linearized reading' (duration: 190.978768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.098968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.90981ms","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":"info","ts":"2026-06-18T12:36:07.099172Z","caller":"traceutil/trace.go:171","msg":"trace[867333280] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:730; }","duration":"198.178035ms","start":"2026-06-18T12:36:06.900979Z","end":"2026-06-18T12:36:07.099157Z","steps":["trace[867333280] 'agreement among raft nodes before linearized reading' (duration: 197.798378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.099224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.373646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:07.099252Z","caller":"traceutil/trace.go:171","msg":"trace[1995133707] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"306.943658ms","start":"2026-06-18T12:36:06.7923Z","end":"2026-06-18T12:36:07.099244Z","steps":["trace[1995133707] 'agreement among raft nodes before linearized reading' (duration: 306.347196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:07.099297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:06.792284Z","time spent":"307.005859ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-18T12:36:15.190354Z","caller":"traceutil/trace.go:171","msg":"trace[1391886877] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"603.561683ms","start":"2026-06-18T12:36:14.586768Z","end":"2026-06-18T12:36:15.19033Z","steps":["trace[1391886877] 'process raft request' (duration: 603.330168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:15.190475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:14.58674Z","time spent":"603.673044ms","remote":"127.0.0.1:60502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:36:19.81365Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3986423282443653059,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-18T12:36:20.155009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.755217ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:20.155139Z","caller":"traceutil/trace.go:171","msg":"trace[1349062804] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:815; }","duration":"491.893809ms","start":"2026-06-18T12:36:19.663228Z","end":"2026-06-18T12:36:20.155121Z","steps":["trace[1349062804] 'range keys from in-memory index tree' (duration: 491.738106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.157163Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.600683015s","expected-duration":"1s"} {"level":"info","ts":"2026-06-18T12:36:20.157559Z","caller":"traceutil/trace.go:171","msg":"trace[1179877086] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.725376409s","start":"2026-06-18T12:36:18.432166Z","end":"2026-06-18T12:36:20.157542Z","steps":["trace[1179877086] 'process raft request' (duration: 1.725199055s)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.157662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:18.432152Z","time spent":"1.725452791s","remote":"127.0.0.1:60202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:20.161529Z","caller":"traceutil/trace.go:171","msg":"trace[1716763953] linearizableReadLoop","detail":"{readStateIndex:843; appliedIndex:841; }","duration":"848.896887ms","start":"2026-06-18T12:36:19.312617Z","end":"2026-06-18T12:36:20.161514Z","steps":["trace[1716763953] 'read index received' (duration: 844.764733ms)","trace[1716763953] 'applied index is now lower than readState.Index' (duration: 4.131214ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:20.161739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.473786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T12:36:20.161755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.123902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-18T12:36:20.161782Z","caller":"traceutil/trace.go:171","msg":"trace[379306586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"371.514497ms","start":"2026-06-18T12:36:19.790255Z","end":"2026-06-18T12:36:20.16177Z","steps":["trace[379306586] 'agreement among raft nodes before linearized reading' (duration: 371.450844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.161694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.6356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T12:36:20.161907Z","caller":"traceutil/trace.go:171","msg":"trace[508838145] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:816; }","duration":"838.880706ms","start":"2026-06-18T12:36:19.323014Z","end":"2026-06-18T12:36:20.161894Z","steps":["trace[508838145] 'agreement among raft nodes before linearized reading' (duration: 838.63106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.161897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.493436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-18T12:36:20.161901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.7902Z","time spent":"371.69203ms","remote":"127.0.0.1:60020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-18T12:36:20.161959Z","caller":"traceutil/trace.go:171","msg":"trace[302867261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"823.596518ms","start":"2026-06-18T12:36:19.338347Z","end":"2026-06-18T12:36:20.161944Z","steps":["trace[302867261] 'agreement among raft nodes before linearized reading' (duration: 823.403824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.161864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.597296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-18T12:36:20.162057Z","caller":"traceutil/trace.go:171","msg":"trace[38635213] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"811.804551ms","start":"2026-06-18T12:36:19.350237Z","end":"2026-06-18T12:36:20.162041Z","steps":["trace[38635213] 'agreement among raft nodes before linearized reading' (duration: 811.479005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.161946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.322999Z","time spent":"838.938087ms","remote":"127.0.0.1:60432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-06-18T12:36:20.162144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.350231Z","time spent":"811.899353ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-18T12:36:20.16182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.023484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-18T12:36:20.162373Z","caller":"traceutil/trace.go:171","msg":"trace[167863164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:816; }","duration":"812.587536ms","start":"2026-06-18T12:36:19.349773Z","end":"2026-06-18T12:36:20.162361Z","steps":["trace[167863164] 'agreement among raft nodes before linearized reading' (duration: 811.950244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.162518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.360792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-18T12:36:20.162595Z","caller":"traceutil/trace.go:171","msg":"trace[1149131376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"812.455953ms","start":"2026-06-18T12:36:19.350126Z","end":"2026-06-18T12:36:20.162582Z","steps":["trace[1149131376] 'agreement among raft nodes before linearized reading' (duration: 812.2595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.162636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.350118Z","time spent":"812.508324ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-18T12:36:20.162493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.349764Z","time spent":"812.716188ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-18T12:36:20.161996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.338334Z","time spent":"823.65403ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-18T12:36:20.161783Z","caller":"traceutil/trace.go:171","msg":"trace[1143226292] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"849.165323ms","start":"2026-06-18T12:36:19.312611Z","end":"2026-06-18T12:36:20.161776Z","steps":["trace[1143226292] 'agreement among raft nodes before linearized reading' (duration: 849.002829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:20.162877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:19.312557Z","time spent":"850.303355ms","remote":"127.0.0.1:60292","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":"info","ts":"2026-06-18T12:36:32.945703Z","caller":"traceutil/trace.go:171","msg":"trace[978810514] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"127.73913ms","start":"2026-06-18T12:36:32.81794Z","end":"2026-06-18T12:36:32.945679Z","steps":["trace[978810514] 'process raft request' (duration: 127.590817ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:34.694502Z","caller":"traceutil/trace.go:171","msg":"trace[67360190] linearizableReadLoop","detail":"{readStateIndex:1013; appliedIndex:1011; }","duration":"299.514461ms","start":"2026-06-18T12:36:34.394959Z","end":"2026-06-18T12:36:34.694474Z","steps":["trace[67360190] 'read index received' (duration: 265.981218ms)","trace[67360190] 'applied index is now lower than readState.Index' (duration: 33.532343ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:34.694593Z","caller":"traceutil/trace.go:171","msg":"trace[733709219] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"340.163334ms","start":"2026-06-18T12:36:34.354421Z","end":"2026-06-18T12:36:34.694584Z","steps":["trace[733709219] 'process raft request' (duration: 339.94328ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:34.694519Z","caller":"traceutil/trace.go:171","msg":"trace[1623820399] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"340.670083ms","start":"2026-06-18T12:36:34.353821Z","end":"2026-06-18T12:36:34.694491Z","steps":["trace[1623820399] 'process raft request' (duration: 307.173781ms)","trace[1623820399] 'compare' (duration: 33.105965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:34.694691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:34.354405Z","time spent":"340.217755ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:36:34.694765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.776996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-18T12:36:34.694801Z","caller":"traceutil/trace.go:171","msg":"trace[397996875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:983; }","duration":"299.906818ms","start":"2026-06-18T12:36:34.394887Z","end":"2026-06-18T12:36:34.694793Z","steps":["trace[397996875] 'agreement among raft nodes before linearized reading' (duration: 299.729035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:34.694778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:34.353803Z","time spent":"340.898098ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:34.770881Z","caller":"traceutil/trace.go:171","msg":"trace[424896426] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"364.359363ms","start":"2026-06-18T12:36:34.406489Z","end":"2026-06-18T12:36:34.770849Z","steps":["trace[424896426] 'process raft request' (duration: 364.079707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:34.770945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.556238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-4dqlr\" ","response":"range_response_count:1 size:5071"} {"level":"info","ts":"2026-06-18T12:36:34.771035Z","caller":"traceutil/trace.go:171","msg":"trace[1523934539] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-4dqlr; range_end:; response_count:1; response_revision:984; }","duration":"276.690759ms","start":"2026-06-18T12:36:34.494321Z","end":"2026-06-18T12:36:34.771012Z","steps":["trace[1523934539] 'agreement among raft nodes before linearized reading' (duration: 276.397143ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:36:34.771053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:36:34.406472Z","time spent":"364.492445ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-18T12:36:34.864307Z","caller":"traceutil/trace.go:171","msg":"trace[1751102400] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"165.222836ms","start":"2026-06-18T12:36:34.699062Z","end":"2026-06-18T12:36:34.864285Z","steps":["trace[1751102400] 'process raft request' (duration: 127.585632ms)","trace[1751102400] 'compare' (duration: 37.066984ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:34.980949Z","caller":"traceutil/trace.go:171","msg":"trace[1555014717] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"110.626496ms","start":"2026-06-18T12:36:34.870297Z","end":"2026-06-18T12:36:34.980923Z","steps":["trace[1555014717] 'process raft request' (duration: 94.925535ms)","trace[1555014717] 'compare' (duration: 15.458086ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:35.166318Z","caller":"traceutil/trace.go:171","msg":"trace[1821688344] transaction","detail":"{read_only:false; number_of_response:1; response_revision:988; }","duration":"182.840621ms","start":"2026-06-18T12:36:34.983459Z","end":"2026-06-18T12:36:35.166299Z","steps":["trace[1821688344] 'process raft request' (duration: 182.237769ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:50.544105Z","caller":"traceutil/trace.go:171","msg":"trace[633273160] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"104.878941ms","start":"2026-06-18T12:36:50.439206Z","end":"2026-06-18T12:36:50.544085Z","steps":["trace[633273160] 'process raft request' (duration: 104.732888ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:50.59761Z","caller":"traceutil/trace.go:171","msg":"trace[1353526704] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"157.820501ms","start":"2026-06-18T12:36:50.439766Z","end":"2026-06-18T12:36:50.597586Z","steps":["trace[1353526704] 'process raft request' (duration: 157.687438ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:54.928968Z","caller":"traceutil/trace.go:171","msg":"trace[283634813] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1094; }","duration":"137.176651ms","start":"2026-06-18T12:36:54.791765Z","end":"2026-06-18T12:36:54.928942Z","steps":["trace[283634813] 'read index received' (duration: 51.309956ms)","trace[283634813] 'applied index is now lower than readState.Index' (duration: 85.865445ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:54.929093Z","caller":"traceutil/trace.go:171","msg":"trace[2110908847] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"144.948572ms","start":"2026-06-18T12:36:54.784109Z","end":"2026-06-18T12:36:54.929057Z","steps":["trace[2110908847] 'process raft request' (duration: 116.408659ms)","trace[2110908847] 'compare' (duration: 28.288428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:54.929407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.325253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:36:54.92947Z","caller":"traceutil/trace.go:171","msg":"trace[1476908883] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1062; }","duration":"137.750601ms","start":"2026-06-18T12:36:54.791705Z","end":"2026-06-18T12:36:54.929455Z","steps":["trace[1476908883] 'agreement among raft nodes before linearized reading' (duration: 137.350234ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:55.182751Z","caller":"traceutil/trace.go:171","msg":"trace[99914621] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"237.86441ms","start":"2026-06-18T12:36:54.94485Z","end":"2026-06-18T12:36:55.182714Z","steps":["trace[99914621] 'process raft request' (duration: 215.485237ms)","trace[99914621] 'compare' (duration: 22.239241ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:36:55.182996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.544958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-18T12:36:55.183079Z","caller":"traceutil/trace.go:171","msg":"trace[942231711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1063; }","duration":"198.674701ms","start":"2026-06-18T12:36:54.984386Z","end":"2026-06-18T12:36:55.183061Z","steps":["trace[942231711] 'agreement among raft nodes before linearized reading' (duration: 198.393516ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:55.182703Z","caller":"traceutil/trace.go:171","msg":"trace[1480155712] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1096; }","duration":"198.243973ms","start":"2026-06-18T12:36:54.984434Z","end":"2026-06-18T12:36:55.182678Z","steps":["trace[1480155712] 'read index received' (duration: 175.9099ms)","trace[1480155712] 'applied index is now lower than readState.Index' (duration: 22.333243ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:36:55.184201Z","caller":"traceutil/trace.go:171","msg":"trace[376312351] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"135.386174ms","start":"2026-06-18T12:36:55.048797Z","end":"2026-06-18T12:36:55.184183Z","steps":["trace[376312351] 'process raft request' (duration: 135.258521ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:56.699655Z","caller":"traceutil/trace.go:171","msg":"trace[1723896758] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"100.20905ms","start":"2026-06-18T12:36:56.599417Z","end":"2026-06-18T12:36:56.699626Z","steps":["trace[1723896758] 'process raft request' (duration: 99.894334ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:36:59.35917Z","caller":"traceutil/trace.go:171","msg":"trace[672082895] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"108.479725ms","start":"2026-06-18T12:36:59.250662Z","end":"2026-06-18T12:36:59.359141Z","steps":["trace[672082895] 'process raft request' (duration: 87.563421ms)","trace[672082895] 'compare' (duration: 20.786162ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:37:15.096441Z","caller":"traceutil/trace.go:171","msg":"trace[1715147543] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"110.593534ms","start":"2026-06-18T12:37:14.985813Z","end":"2026-06-18T12:37:15.096406Z","steps":["trace[1715147543] 'process raft request' (duration: 108.921602ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:37:29.038594Z","caller":"traceutil/trace.go:171","msg":"trace[524958389] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"136.025172ms","start":"2026-06-18T12:37:28.902538Z","end":"2026-06-18T12:37:29.038564Z","steps":["trace[524958389] 'process raft request' (duration: 135.847228ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:37:45.342333Z","caller":"traceutil/trace.go:171","msg":"trace[1196829511] linearizableReadLoop","detail":"{readStateIndex:1268; appliedIndex:1267; }","duration":"119.636873ms","start":"2026-06-18T12:37:45.222673Z","end":"2026-06-18T12:37:45.34231Z","steps":["trace[1196829511] 'read index received' (duration: 119.441139ms)","trace[1196829511] 'applied index is now lower than readState.Index' (duration: 194.814µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:37:45.342449Z","caller":"traceutil/trace.go:171","msg":"trace[1868901357] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"120.824026ms","start":"2026-06-18T12:37:45.22159Z","end":"2026-06-18T12:37:45.342415Z","steps":["trace[1868901357] 'process raft request' (duration: 120.591892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:45.342537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.842567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-18T12:37:45.342605Z","caller":"traceutil/trace.go:171","msg":"trace[1385959168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"119.930529ms","start":"2026-06-18T12:37:45.222656Z","end":"2026-06-18T12:37:45.342587Z","steps":["trace[1385959168] 'agreement among raft nodes before linearized reading' (duration: 119.749756ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:37:45.539049Z","caller":"traceutil/trace.go:171","msg":"trace[1574758870] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"167.675728ms","start":"2026-06-18T12:37:45.371351Z","end":"2026-06-18T12:37:45.539027Z","steps":["trace[1574758870] 'read index received' (duration: 167.442174ms)","trace[1574758870] 'applied index is now lower than readState.Index' (duration: 232.704µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:37:45.539116Z","caller":"traceutil/trace.go:171","msg":"trace[1084515988] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"191.363535ms","start":"2026-06-18T12:37:45.347713Z","end":"2026-06-18T12:37:45.539077Z","steps":["trace[1084515988] 'process raft request' (duration: 191.081979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:45.539245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.873443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-18T12:37:45.539277Z","caller":"traceutil/trace.go:171","msg":"trace[993299603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1225; }","duration":"167.968685ms","start":"2026-06-18T12:37:45.3713Z","end":"2026-06-18T12:37:45.539269Z","steps":["trace[993299603] 'agreement among raft nodes before linearized reading' (duration: 167.824712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:45.539825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.542987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-18T12:37:45.539873Z","caller":"traceutil/trace.go:171","msg":"trace[239928822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1226; }","duration":"167.611138ms","start":"2026-06-18T12:37:45.37225Z","end":"2026-06-18T12:37:45.539862Z","steps":["trace[239928822] 'agreement among raft nodes before linearized reading' (duration: 167.485316ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:37:45.539882Z","caller":"traceutil/trace.go:171","msg":"trace[2073974771] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"117.132146ms","start":"2026-06-18T12:37:45.422729Z","end":"2026-06-18T12:37:45.539861Z","steps":["trace[2073974771] 'process raft request' (duration: 116.935993ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:37:46.736577Z","caller":"traceutil/trace.go:171","msg":"trace[1745111824] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1273; }","duration":"364.83606ms","start":"2026-06-18T12:37:46.371714Z","end":"2026-06-18T12:37:46.73655Z","steps":["trace[1745111824] 'read index received' (duration: 364.597476ms)","trace[1745111824] 'applied index is now lower than readState.Index' (duration: 237.454µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:37:46.736965Z","caller":"traceutil/trace.go:171","msg":"trace[2139322989] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"370.12902ms","start":"2026-06-18T12:37:46.366788Z","end":"2026-06-18T12:37:46.736917Z","steps":["trace[2139322989] 'process raft request' (duration: 369.615281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:46.737049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.436181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:37:46.737086Z","caller":"traceutil/trace.go:171","msg":"trace[737951933] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1230; }","duration":"168.524943ms","start":"2026-06-18T12:37:46.568548Z","end":"2026-06-18T12:37:46.737073Z","steps":["trace[737951933] 'agreement among raft nodes before linearized reading' (duration: 168.475542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:46.737117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:37:46.366758Z","time spent":"370.279862ms","remote":"127.0.0.1:60292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T12:37:46.736989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.819926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T12:37:46.73732Z","caller":"traceutil/trace.go:171","msg":"trace[1028053871] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1230; }","duration":"240.178743ms","start":"2026-06-18T12:37:46.497104Z","end":"2026-06-18T12:37:46.737282Z","steps":["trace[1028053871] 'agreement among raft nodes before linearized reading' (duration: 239.830136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:46.737391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.678656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050264"} {"level":"info","ts":"2026-06-18T12:37:46.737451Z","caller":"traceutil/trace.go:171","msg":"trace[201005836] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1230; }","duration":"365.774587ms","start":"2026-06-18T12:37:46.371665Z","end":"2026-06-18T12:37:46.73744Z","steps":["trace[201005836] 'agreement among raft nodes before linearized reading' (duration: 365.104815ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:37:46.737477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T12:37:46.371644Z","time spent":"365.825389ms","remote":"127.0.0.1:60104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":1050287,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-06-18T12:38:07.284262Z","caller":"traceutil/trace.go:171","msg":"trace[1130416717] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"128.151667ms","start":"2026-06-18T12:38:07.156086Z","end":"2026-06-18T12:38:07.284238Z","steps":["trace[1130416717] 'process raft request' (duration: 128.002644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:38:09.900191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.900369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:38:09.900291Z","caller":"traceutil/trace.go:171","msg":"trace[2098289615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1340; }","duration":"109.046471ms","start":"2026-06-18T12:38:09.791226Z","end":"2026-06-18T12:38:09.900272Z","steps":["trace[2098289615] 'range keys from in-memory index tree' (duration: 108.815137ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:38:09.900276Z","caller":"traceutil/trace.go:171","msg":"trace[1514849914] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"108.204926ms","start":"2026-06-18T12:38:09.792049Z","end":"2026-06-18T12:38:09.900254Z","steps":["trace[1514849914] 'process raft request' (duration: 51.108606ms)","trace[1514849914] 'compare' (duration: 56.997878ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T12:38:11.77097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.289631ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T12:38:11.771362Z","caller":"traceutil/trace.go:171","msg":"trace[1119913290] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"130.829225ms","start":"2026-06-18T12:38:11.640504Z","end":"2026-06-18T12:38:11.771333Z","steps":["trace[1119913290] 'process raft request' (duration: 16.090887ms)","trace[1119913290] 'compare' (duration: 114.170908ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:38:11.951191Z","caller":"traceutil/trace.go:171","msg":"trace[156769087] linearizableReadLoop","detail":"{readStateIndex:1401; appliedIndex:1398; }","duration":"158.607535ms","start":"2026-06-18T12:38:11.792564Z","end":"2026-06-18T12:38:11.951172Z","steps":["trace[156769087] 'read index received' (duration: 11.393227ms)","trace[156769087] 'applied index is now lower than readState.Index' (duration: 147.213548ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:38:11.951239Z","caller":"traceutil/trace.go:171","msg":"trace[460857433] transaction","detail":"{read_only:false; response_revision:1349; number_of_response:1; }","duration":"175.722163ms","start":"2026-06-18T12:38:11.775491Z","end":"2026-06-18T12:38:11.951213Z","steps":["trace[460857433] 'process raft request' (duration: 175.167182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:38:11.951529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.951982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T12:38:11.951581Z","caller":"traceutil/trace.go:171","msg":"trace[410479498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1350; }","duration":"159.038244ms","start":"2026-06-18T12:38:11.792529Z","end":"2026-06-18T12:38:11.951567Z","steps":["trace[410479498] 'agreement among raft nodes before linearized reading' (duration: 158.938192ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:38:11.951364Z","caller":"traceutil/trace.go:171","msg":"trace[683315491] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"174.628832ms","start":"2026-06-18T12:38:11.77672Z","end":"2026-06-18T12:38:11.951349Z","steps":["trace[683315491] 'process raft request' (duration: 174.404856ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:38:14.078241Z","caller":"traceutil/trace.go:171","msg":"trace[1825720476] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"117.304277ms","start":"2026-06-18T12:38:13.960908Z","end":"2026-06-18T12:38:14.078213Z","steps":["trace[1825720476] 'process raft request' (duration: 117.130793ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T12:38:14.079485Z","caller":"traceutil/trace.go:171","msg":"trace[1966773436] linearizableReadLoop","detail":"{readStateIndex:1409; appliedIndex:1407; }","duration":"108.983358ms","start":"2026-06-18T12:38:13.970474Z","end":"2026-06-18T12:38:14.079457Z","steps":["trace[1966773436] 'read index received' (duration: 107.602841ms)","trace[1966773436] 'applied index is now lower than readState.Index' (duration: 1.379316ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T12:38:14.079669Z","caller":"traceutil/trace.go:171","msg":"trace[1121495005] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"117.915129ms","start":"2026-06-18T12:38:13.961731Z","end":"2026-06-18T12:38:14.079646Z","steps":["trace[1121495005] 'process raft request' (duration: 117.593732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T12:38:14.07971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.206152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-18T12:38:14.079783Z","caller":"traceutil/trace.go:171","msg":"trace[2075923283] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1357; }","duration":"109.323834ms","start":"2026-06-18T12:38:13.970445Z","end":"2026-06-18T12:38:14.079768Z","steps":["trace[2075923283] 'agreement among raft nodes before linearized reading' (duration: 109.123751ms)"],"step_count":1}