{"level":"warn","ts":"2026-02-17T23:05:57.658652Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T23:05:57.65879Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.89: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.89:2380","--initial-cluster=instance=https://199.204.45.89:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.89:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.89: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-02-17T23:05:57.658889Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-17T23:05:57.658934Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-02-17T23:05:57.658967Z","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-02-17T23:05:57.661545Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"]} {"level":"info","ts":"2026-02-17T23:05:57.661891Z","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":2,"max-cpu-available":2,"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.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.89: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-02-17T23:05:57.666855Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.271339ms"} {"level":"info","ts":"2026-02-17T23:05:57.703153Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c3b8446219deb8c1","cluster-id":"fe02a46d8aa9751f"} {"level":"info","ts":"2026-02-17T23:05:57.703221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T23:05:57.703382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 0"} {"level":"info","ts":"2026-02-17T23:05:57.703397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c3b8446219deb8c1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T23:05:57.703404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became follower at term 1"} {"level":"info","ts":"2026-02-17T23:05:57.703531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"warn","ts":"2026-02-17T23:05:57.712548Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T23:05:57.715108Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T23:05:57.720174Z","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-02-17T23:05:57.730211Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c3b8446219deb8c1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T23:05:57.758004Z","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-02-17T23:05:57.758331Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c3b8446219deb8c1","initial-advertise-peer-urls":["https://199.204.45.89:2380"],"listen-peer-urls":["https://199.204.45.89:2380"],"advertise-client-urls":["https://199.204.45.89:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.89:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T23:05:57.758419Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T23:05:57.75844Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c3b8446219deb8c1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T23:05:57.758597Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-02-17T23:05:57.758646Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.89:2380"} {"level":"info","ts":"2026-02-17T23:05:57.758613Z","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-02-17T23:05:57.758719Z","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-02-17T23:05:57.758745Z","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-02-17T23:05:57.758967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 switched to configuration voters=(14103097421242218689)"} {"level":"info","ts":"2026-02-17T23:05:57.761855Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","added-peer-id":"c3b8446219deb8c1","added-peer-peer-urls":["https://199.204.45.89:2380"]} {"level":"info","ts":"2026-02-17T23:05:58.705723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T23:05:58.70583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T23:05:58.705895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgPreVoteResp from c3b8446219deb8c1 at term 1"} {"level":"info","ts":"2026-02-17T23:05:58.705968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became candidate at term 2"} {"level":"info","ts":"2026-02-17T23:05:58.706041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 received MsgVoteResp from c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-02-17T23:05:58.706099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c3b8446219deb8c1 became leader at term 2"} {"level":"info","ts":"2026-02-17T23:05:58.706165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c3b8446219deb8c1 elected leader c3b8446219deb8c1 at term 2"} {"level":"info","ts":"2026-02-17T23:05:58.70814Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c3b8446219deb8c1","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.89:2379]}","request-path":"/0/members/c3b8446219deb8c1/attributes","cluster-id":"fe02a46d8aa9751f","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T23:05:58.708337Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:05:58.70845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:05:58.708796Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T23:05:58.70914Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T23:05:58.713721Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T23:05:58.71379Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fe02a46d8aa9751f","local-member-id":"c3b8446219deb8c1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:05:58.713892Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:05:58.713962Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T23:05:58.715213Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.89:2379"} {"level":"info","ts":"2026-02-17T23:05:58.716829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-17T23:06:02.520966Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093969113958700,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T23:06:02.561068Z","caller":"traceutil/trace.go:171","msg":"trace[42551613] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"713.179021ms","start":"2026-02-17T23:06:01.847868Z","end":"2026-02-17T23:06:02.561047Z","steps":["trace[42551613] 'process raft request' (duration: 713.067936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:02.561516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:01.847858Z","time spent":"713.280215ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5855,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:02.670857Z","caller":"traceutil/trace.go:171","msg":"trace[1930920705] linearizableReadLoop","detail":"{readStateIndex:252; appliedIndex:250; }","duration":"650.446587ms","start":"2026-02-17T23:06:02.020392Z","end":"2026-02-17T23:06:02.670838Z","steps":["trace[1930920705] 'read index received' (duration: 541.667424ms)","trace[1930920705] 'applied index is now lower than readState.Index' (duration: 108.778353ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:02.670947Z","caller":"traceutil/trace.go:171","msg":"trace[352842544] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"529.4586ms","start":"2026-02-17T23:06:02.141482Z","end":"2026-02-17T23:06:02.670941Z","steps":["trace[352842544] 'process raft request' (duration: 524.767015ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:02.671014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:02.141462Z","time spent":"529.503692ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2883,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:06:02.671091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.693365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3179"} {"level":"info","ts":"2026-02-17T23:06:02.671175Z","caller":"traceutil/trace.go:171","msg":"trace[1232936659] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:246; }","duration":"650.826231ms","start":"2026-02-17T23:06:02.020336Z","end":"2026-02-17T23:06:02.671162Z","steps":["trace[1232936659] 'agreement among raft nodes before linearized reading' (duration: 650.649244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:02.671204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:02.020317Z","time spent":"650.880652ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3203,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T23:06:02.67271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.187681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:02.672761Z","caller":"traceutil/trace.go:171","msg":"trace[1428911372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:246; }","duration":"486.246434ms","start":"2026-02-17T23:06:02.186489Z","end":"2026-02-17T23:06:02.672736Z","steps":["trace[1428911372] 'agreement among raft nodes before linearized reading' (duration: 486.179211ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:02.672784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:02.186478Z","time spent":"486.300526ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:06:02.674874Z","caller":"traceutil/trace.go:171","msg":"trace[1266326971] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"384.766841ms","start":"2026-02-17T23:06:02.288917Z","end":"2026-02-17T23:06:02.673683Z","steps":["trace[1266326971] 'process raft request' (duration: 381.889955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:02.675204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:02.288893Z","time spent":"386.173523ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3937,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:06:05.06167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.28463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-17T23:06:05.061757Z","caller":"traceutil/trace.go:171","msg":"trace[65509576] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:315; }","duration":"101.415114ms","start":"2026-02-17T23:06:04.960328Z","end":"2026-02-17T23:06:05.061743Z","steps":["trace[65509576] 'range keys from in-memory index tree' (duration: 101.183657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:08.267205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.680095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:08.267568Z","caller":"traceutil/trace.go:171","msg":"trace[1767657175] linearizableReadLoop","detail":"{readStateIndex:349; appliedIndex:348; }","duration":"135.180776ms","start":"2026-02-17T23:06:08.132369Z","end":"2026-02-17T23:06:08.267549Z","steps":["trace[1767657175] 'read index received' (duration: 49.073µs)","trace[1767657175] 'applied index is now lower than readState.Index' (duration: 135.130243ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:08.267766Z","caller":"traceutil/trace.go:171","msg":"trace[1689175961] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"407.881788ms","start":"2026-02-17T23:06:07.859872Z","end":"2026-02-17T23:06:08.267754Z","steps":["trace[1689175961] 'process raft request' (duration: 166.396097ms)","trace[1689175961] 'compare' (duration: 240.557309ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:08.268146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:07.859856Z","time spent":"408.015253ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":203,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:06:08.268451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.073387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-17T23:06:08.268628Z","caller":"traceutil/trace.go:171","msg":"trace[1372220559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:339; }","duration":"136.251763ms","start":"2026-02-17T23:06:08.132362Z","end":"2026-02-17T23:06:08.268613Z","steps":["trace[1372220559] 'agreement among raft nodes before linearized reading' (duration: 136.010355ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:08.462547Z","caller":"traceutil/trace.go:171","msg":"trace[1286563084] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"186.680636ms","start":"2026-02-17T23:06:08.275845Z","end":"2026-02-17T23:06:08.462525Z","steps":["trace[1286563084] 'process raft request' (duration: 185.551647ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:08.46491Z","caller":"traceutil/trace.go:171","msg":"trace[1067353902] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"187.321279ms","start":"2026-02-17T23:06:08.27758Z","end":"2026-02-17T23:06:08.464901Z","steps":["trace[1067353902] 'process raft request' (duration: 187.159473ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:08.465196Z","caller":"traceutil/trace.go:171","msg":"trace[555964984] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"187.142633ms","start":"2026-02-17T23:06:08.278043Z","end":"2026-02-17T23:06:08.465186Z","steps":["trace[555964984] 'process raft request' (duration: 186.76701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:10.729129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.689161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:10.72968Z","caller":"traceutil/trace.go:171","msg":"trace[1722325188] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"231.074575ms","start":"2026-02-17T23:06:10.498587Z","end":"2026-02-17T23:06:10.729661Z","steps":["trace[1722325188] 'process raft request' (duration: 55.553226ms)","trace[1722325188] 'compare' (duration: 174.442282ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:10.730154Z","caller":"traceutil/trace.go:171","msg":"trace[374560033] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"175.031573ms","start":"2026-02-17T23:06:10.555083Z","end":"2026-02-17T23:06:10.730115Z","steps":["trace[374560033] 'process raft request' (duration: 174.523376ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:10.730517Z","caller":"traceutil/trace.go:171","msg":"trace[1112576766] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"109.482839ms","start":"2026-02-17T23:06:10.621017Z","end":"2026-02-17T23:06:10.7305Z","steps":["trace[1112576766] 'process raft request' (duration: 109.418266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:27.815385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.430698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:27.815723Z","caller":"traceutil/trace.go:171","msg":"trace[830976442] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"176.992598ms","start":"2026-02-17T23:06:27.638717Z","end":"2026-02-17T23:06:27.815709Z","steps":["trace[830976442] 'process raft request' (duration: 176.865635ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:27.816026Z","caller":"traceutil/trace.go:171","msg":"trace[1941211494] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"180.141086ms","start":"2026-02-17T23:06:27.635878Z","end":"2026-02-17T23:06:27.816019Z","steps":["trace[1941211494] 'process raft request' (duration: 61.007698ms)","trace[1941211494] 'compare' (duration: 118.341796ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:27.817128Z","caller":"traceutil/trace.go:171","msg":"trace[794691353] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"175.181268ms","start":"2026-02-17T23:06:27.64194Z","end":"2026-02-17T23:06:27.817122Z","steps":["trace[794691353] 'process raft request' (duration: 173.695227ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:27.818481Z","caller":"traceutil/trace.go:171","msg":"trace[866961218] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"172.421661ms","start":"2026-02-17T23:06:27.646052Z","end":"2026-02-17T23:06:27.818474Z","steps":["trace[866961218] 'process raft request' (duration: 169.603413ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:27.818819Z","caller":"traceutil/trace.go:171","msg":"trace[1312935866] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:512; }","duration":"166.329882ms","start":"2026-02-17T23:06:27.652467Z","end":"2026-02-17T23:06:27.818796Z","steps":["trace[1312935866] 'read index received' (duration: 44.367235ms)","trace[1312935866] 'applied index is now lower than readState.Index' (duration: 121.962117ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:27.819052Z","caller":"traceutil/trace.go:171","msg":"trace[2018560120] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"172.926035ms","start":"2026-02-17T23:06:27.646101Z","end":"2026-02-17T23:06:27.819027Z","steps":["trace[2018560120] 'process raft request' (duration: 172.344219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:27.823986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.020971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4313"} {"level":"info","ts":"2026-02-17T23:06:27.825885Z","caller":"traceutil/trace.go:171","msg":"trace[2104307291] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:503; }","duration":"173.44277ms","start":"2026-02-17T23:06:27.652432Z","end":"2026-02-17T23:06:27.825875Z","steps":["trace[2104307291] 'agreement among raft nodes before linearized reading' (duration: 166.921748ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:27.824225Z","caller":"traceutil/trace.go:171","msg":"trace[1562710974] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"178.005777ms","start":"2026-02-17T23:06:27.646102Z","end":"2026-02-17T23:06:27.824108Z","steps":["trace[1562710974] 'process raft request' (duration: 169.570232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.319052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093969113959228,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T23:06:28.49668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.893066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:28.496841Z","caller":"traceutil/trace.go:171","msg":"trace[343970818] linearizableReadLoop","detail":"{readStateIndex:522; appliedIndex:518; }","duration":"677.822836ms","start":"2026-02-17T23:06:27.819008Z","end":"2026-02-17T23:06:28.496831Z","steps":["trace[343970818] 'read index received' (duration: 526.527459ms)","trace[343970818] 'applied index is now lower than readState.Index' (duration: 151.292816ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:28.496888Z","caller":"traceutil/trace.go:171","msg":"trace[1703748117] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"659.374622ms","start":"2026-02-17T23:06:27.837507Z","end":"2026-02-17T23:06:28.496881Z","steps":["trace[1703748117] 'process raft request' (duration: 659.274529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.496934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.837475Z","time spent":"659.442644ms","remote":"127.0.0.1:47298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:28.497198Z","caller":"traceutil/trace.go:171","msg":"trace[152719794] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"659.378531ms","start":"2026-02-17T23:06:27.837814Z","end":"2026-02-17T23:06:28.497193Z","steps":["trace[152719794] 'process raft request' (duration: 658.992291ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.497229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.837804Z","time spent":"659.407303ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4595,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:28.497311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"829.976232ms","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-02-17T23:06:28.497324Z","caller":"traceutil/trace.go:171","msg":"trace[1013676864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"830.014653ms","start":"2026-02-17T23:06:27.667304Z","end":"2026-02-17T23:06:28.497319Z","steps":["trace[1013676864] 'agreement among raft nodes before linearized reading' (duration: 829.981442ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.497337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.667291Z","time spent":"830.043434ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T23:06:28.49743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.779058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs7j\" ","response":"range_response_count:1 size:14921"} {"level":"info","ts":"2026-02-17T23:06:28.497444Z","caller":"traceutil/trace.go:171","msg":"trace[2133717354] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs7j; range_end:; response_count:1; response_revision:507; }","duration":"666.816789ms","start":"2026-02-17T23:06:27.830622Z","end":"2026-02-17T23:06:28.497439Z","steps":["trace[2133717354] 'agreement among raft nodes before linearized reading' (duration: 666.786618ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.497455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.830605Z","time spent":"666.847359ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":14945,"request content":"key:\"/registry/pods/kube-system/cilium-kbs7j\" "} {"level":"warn","ts":"2026-02-17T23:06:28.497602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.988317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:28.497616Z","caller":"traceutil/trace.go:171","msg":"trace[459143165] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:507; }","duration":"416.014209ms","start":"2026-02-17T23:06:28.081598Z","end":"2026-02-17T23:06:28.497612Z","steps":["trace[459143165] 'agreement among raft nodes before linearized reading' (duration: 415.989928ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.49763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:28.081548Z","time spent":"416.07892ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:06:28.497661Z","caller":"traceutil/trace.go:171","msg":"trace[1999874355] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"798.151506ms","start":"2026-02-17T23:06:27.699475Z","end":"2026-02-17T23:06:28.497627Z","steps":["trace[1999874355] 'process raft request' (duration: 646.254663ms)","trace[1999874355] 'compare' (duration: 150.732942ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:28.497895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.699455Z","time spent":"798.302791ms","remote":"127.0.0.1:46894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317263,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:28.498113Z","caller":"traceutil/trace.go:171","msg":"trace[834955525] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"672.559309ms","start":"2026-02-17T23:06:27.825529Z","end":"2026-02-17T23:06:28.498088Z","steps":["trace[834955525] 'process raft request' (duration: 671.218092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.498153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:27.825491Z","time spent":"672.643331ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":671,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:06:28.499443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.843299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-02-17T23:06:28.499469Z","caller":"traceutil/trace.go:171","msg":"trace[2004814691] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:507; }","duration":"417.89974ms","start":"2026-02-17T23:06:28.081563Z","end":"2026-02-17T23:06:28.499463Z","steps":["trace[2004814691] 'agreement among raft nodes before linearized reading' (duration: 417.798137ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.499487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:28.081548Z","time spent":"417.934012ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":544,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium\" "} {"level":"warn","ts":"2026-02-17T23:06:28.499537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.917081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-02-17T23:06:28.499571Z","caller":"traceutil/trace.go:171","msg":"trace[1652768986] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:507; }","duration":"417.990493ms","start":"2026-02-17T23:06:28.081571Z","end":"2026-02-17T23:06:28.499561Z","steps":["trace[1652768986] 'agreement among raft nodes before linearized reading' (duration: 417.815888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:28.499615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:28.081564Z","time spent":"418.046104ms","remote":"127.0.0.1:46998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":562,"request content":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" "} {"level":"warn","ts":"2026-02-17T23:06:31.10822Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093969113959255,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T23:06:31.243963Z","caller":"traceutil/trace.go:171","msg":"trace[2015676751] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"667.868113ms","start":"2026-02-17T23:06:30.576073Z","end":"2026-02-17T23:06:31.243941Z","steps":["trace[2015676751] 'process raft request' (duration: 667.721018ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.244167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:30.576058Z","time spent":"668.033327ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:31.813202Z","caller":"traceutil/trace.go:171","msg":"trace[1518888457] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"741.291868ms","start":"2026-02-17T23:06:31.071888Z","end":"2026-02-17T23:06:31.813179Z","steps":["trace[1518888457] 'process raft request' (duration: 708.579926ms)","trace[1518888457] 'compare' (duration: 32.23679ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:31.813341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.07187Z","time spent":"741.404891ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:31.813084Z","caller":"traceutil/trace.go:171","msg":"trace[2045906536] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:532; }","duration":"1.205171351s","start":"2026-02-17T23:06:30.60789Z","end":"2026-02-17T23:06:31.813061Z","steps":["trace[2045906536] 'read index received' (duration: 635.944881ms)","trace[2045906536] 'applied index is now lower than readState.Index' (duration: 569.22538ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:31.813646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"988.8832ms","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-02-17T23:06:31.813724Z","caller":"traceutil/trace.go:171","msg":"trace[1208113657] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:519; }","duration":"988.929722ms","start":"2026-02-17T23:06:30.824753Z","end":"2026-02-17T23:06:31.813683Z","steps":["trace[1208113657] 'agreement among raft nodes before linearized reading' (duration: 988.85754ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.813761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:30.824718Z","time spent":"989.035825ms","remote":"127.0.0.1:47068","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-02-17T23:06:31.813653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205668535s","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-02-17T23:06:31.814997Z","caller":"traceutil/trace.go:171","msg":"trace[1528261269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:519; }","duration":"1.207125243s","start":"2026-02-17T23:06:30.607857Z","end":"2026-02-17T23:06:31.814982Z","steps":["trace[1528261269] 'agreement among raft nodes before linearized reading' (duration: 1.205658174s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.813948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.285011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-02-17T23:06:31.813996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.838863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T23:06:31.814031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.134226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"warn","ts":"2026-02-17T23:06:31.814063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.07266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:31.815743Z","caller":"traceutil/trace.go:171","msg":"trace[776919042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"930.779885ms","start":"2026-02-17T23:06:30.88495Z","end":"2026-02-17T23:06:31.815729Z","steps":["trace[776919042] 'agreement among raft nodes before linearized reading' (duration: 929.09671ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.815825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:30.884938Z","time spent":"930.871857ms","remote":"127.0.0.1:47068","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-02-17T23:06:31.816539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:30.607842Z","time spent":"1.208680895s","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T23:06:31.816973Z","caller":"traceutil/trace.go:171","msg":"trace[419639247] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:519; }","duration":"395.342283ms","start":"2026-02-17T23:06:31.421617Z","end":"2026-02-17T23:06:31.81696Z","steps":["trace[419639247] 'agreement among raft nodes before linearized reading' (duration: 392.299802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.817068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.421595Z","time spent":"395.458785ms","remote":"127.0.0.1:46824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.89\" "} {"level":"info","ts":"2026-02-17T23:06:31.817279Z","caller":"traceutil/trace.go:171","msg":"trace[426493691] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:519; }","duration":"835.403853ms","start":"2026-02-17T23:06:30.98186Z","end":"2026-02-17T23:06:31.817264Z","steps":["trace[426493691] 'agreement among raft nodes before linearized reading' (duration: 832.149606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.818059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:30.981841Z","time spent":"836.204523ms","remote":"127.0.0.1:46972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4042,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-02-17T23:06:31.817336Z","caller":"traceutil/trace.go:171","msg":"trace[346630982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"745.204042ms","start":"2026-02-17T23:06:31.072125Z","end":"2026-02-17T23:06:31.817329Z","steps":["trace[346630982] 'agreement among raft nodes before linearized reading' (duration: 741.855123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:31.818217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:31.072109Z","time spent":"746.099636ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T23:06:38.157864Z","caller":"traceutil/trace.go:171","msg":"trace[1758778638] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"231.484854ms","start":"2026-02-17T23:06:37.926357Z","end":"2026-02-17T23:06:38.157842Z","steps":["trace[1758778638] 'read index received' (duration: 231.277978ms)","trace[1758778638] 'applied index is now lower than readState.Index' (duration: 206.076µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:38.157973Z","caller":"traceutil/trace.go:171","msg":"trace[2085372664] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"241.465365ms","start":"2026-02-17T23:06:37.916499Z","end":"2026-02-17T23:06:38.157965Z","steps":["trace[2085372664] 'process raft request' (duration: 241.218608ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:38.158287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.915695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:38.158342Z","caller":"traceutil/trace.go:171","msg":"trace[1925775529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:562; }","duration":"231.997757ms","start":"2026-02-17T23:06:37.926328Z","end":"2026-02-17T23:06:38.158326Z","steps":["trace[1925775529] 'agreement among raft nodes before linearized reading' (duration: 231.885064ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:40.023915Z","caller":"traceutil/trace.go:171","msg":"trace[1459570983] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"165.42969ms","start":"2026-02-17T23:06:39.858469Z","end":"2026-02-17T23:06:40.023899Z","steps":["trace[1459570983] 'read index received' (duration: 165.286136ms)","trace[1459570983] 'applied index is now lower than readState.Index' (duration: 142.964µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:40.02405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.563434ms","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-02-17T23:06:40.024071Z","caller":"traceutil/trace.go:171","msg":"trace[974568589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"165.624535ms","start":"2026-02-17T23:06:39.858439Z","end":"2026-02-17T23:06:40.024064Z","steps":["trace[974568589] 'agreement among raft nodes before linearized reading' (duration: 165.523182ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:40.024758Z","caller":"traceutil/trace.go:171","msg":"trace[1091116664] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"758.304047ms","start":"2026-02-17T23:06:39.266446Z","end":"2026-02-17T23:06:40.02475Z","steps":["trace[1091116664] 'process raft request' (duration: 757.369045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:40.024834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:39.26643Z","time spent":"758.352718ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:41.44651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.068628524s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:41.446757Z","caller":"traceutil/trace.go:171","msg":"trace[970999650] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.418327212s","start":"2026-02-17T23:06:40.028416Z","end":"2026-02-17T23:06:41.446743Z","steps":["trace[970999650] 'process raft request' (duration: 349.251836ms)","trace[970999650] 'compare' (duration: 1.066804561s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:41.44683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:40.028399Z","time spent":"1.418394224s","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:41.446616Z","caller":"traceutil/trace.go:171","msg":"trace[1089479656] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:581; }","duration":"1.377263736s","start":"2026-02-17T23:06:40.069337Z","end":"2026-02-17T23:06:41.4466Z","steps":["trace[1089479656] 'read index received' (duration: 308.315613ms)","trace[1089479656] 'applied index is now lower than readState.Index' (duration: 1.068946952s)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:41.448858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.379503089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:41.448896Z","caller":"traceutil/trace.go:171","msg":"trace[2044563167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"1.37957516s","start":"2026-02-17T23:06:40.069306Z","end":"2026-02-17T23:06:41.448881Z","steps":["trace[2044563167] 'agreement among raft nodes before linearized reading' (duration: 1.379492098s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:41.448919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:40.069291Z","time spent":"1.379623811s","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:06:41.449104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286390189s","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-02-17T23:06:41.449117Z","caller":"traceutil/trace.go:171","msg":"trace[651135957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"1.2864422s","start":"2026-02-17T23:06:40.16267Z","end":"2026-02-17T23:06:41.449113Z","steps":["trace[651135957] 'agreement among raft nodes before linearized reading' (duration: 1.286374948s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:41.449129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:40.162654Z","time spent":"1.28647191s","remote":"127.0.0.1:47068","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-02-17T23:06:41.449291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272783178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:41.449305Z","caller":"traceutil/trace.go:171","msg":"trace[526306049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:565; }","duration":"1.27282119s","start":"2026-02-17T23:06:40.176479Z","end":"2026-02-17T23:06:41.4493Z","steps":["trace[526306049] 'agreement among raft nodes before linearized reading' (duration: 1.272782319s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:41.449316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:40.176465Z","time spent":"1.2728479s","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:06:42.182105Z","caller":"traceutil/trace.go:171","msg":"trace[992793877] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"150.12534ms","start":"2026-02-17T23:06:42.031959Z","end":"2026-02-17T23:06:42.182085Z","steps":["trace[992793877] 'process raft request' (duration: 149.971936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.365276Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13313093969113959388,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T23:06:45.440887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368910303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:45.440997Z","caller":"traceutil/trace.go:171","msg":"trace[813492890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.369037526s","start":"2026-02-17T23:06:44.071933Z","end":"2026-02-17T23:06:45.440971Z","steps":["trace[813492890] 'range keys from in-memory index tree' (duration: 1.368831052s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.441049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:44.071884Z","time spent":"1.369154419s","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:06:45.441121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255874499s","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-02-17T23:06:45.441192Z","caller":"traceutil/trace.go:171","msg":"trace[1340501110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.255992072s","start":"2026-02-17T23:06:44.185168Z","end":"2026-02-17T23:06:45.44116Z","steps":["trace[1340501110] 'range keys from in-memory index tree' (duration: 1.255660264s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.441237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:44.185145Z","time spent":"1.256083114s","remote":"127.0.0.1:47068","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-02-17T23:06:45.441729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.460873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:45.441785Z","caller":"traceutil/trace.go:171","msg":"trace[937614990] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"1.102040364s","start":"2026-02-17T23:06:44.339733Z","end":"2026-02-17T23:06:45.441773Z","steps":["trace[937614990] 'process raft request' (duration: 341.453588ms)","trace[937614990] 'compare' (duration: 759.402159ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:45.441827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:44.339714Z","time spent":"1.102094166s","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:45.629179Z","caller":"traceutil/trace.go:171","msg":"trace[1277566133] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"177.632839ms","start":"2026-02-17T23:06:45.451528Z","end":"2026-02-17T23:06:45.629161Z","steps":["trace[1277566133] 'process raft request' (duration: 177.586158ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:45.629444Z","caller":"traceutil/trace.go:171","msg":"trace[1302972986] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"974.886677ms","start":"2026-02-17T23:06:44.654549Z","end":"2026-02-17T23:06:45.629436Z","steps":["trace[1302972986] 'process raft request' (duration: 943.893412ms)","trace[1302972986] 'compare' (duration: 30.425551ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:45.629538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:44.654529Z","time spent":"974.934148ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:45.629618Z","caller":"traceutil/trace.go:171","msg":"trace[1825300713] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"765.21599ms","start":"2026-02-17T23:06:44.864395Z","end":"2026-02-17T23:06:45.629611Z","steps":["trace[1825300713] 'read index received' (duration: 734.145923ms)","trace[1825300713] 'applied index is now lower than readState.Index' (duration: 31.068937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:45.629812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.414624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs7j\" ","response":"range_response_count:1 size:17167"} {"level":"info","ts":"2026-02-17T23:06:45.629835Z","caller":"traceutil/trace.go:171","msg":"trace[1614431863] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs7j; range_end:; response_count:1; response_revision:583; }","duration":"765.441045ms","start":"2026-02-17T23:06:44.864387Z","end":"2026-02-17T23:06:45.629829Z","steps":["trace[1614431863] 'agreement among raft nodes before linearized reading' (duration: 765.350482ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.629854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:44.864328Z","time spent":"765.521366ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17191,"request content":"key:\"/registry/pods/kube-system/cilium-kbs7j\" "} {"level":"warn","ts":"2026-02-17T23:06:45.629958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.012676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:45.629974Z","caller":"traceutil/trace.go:171","msg":"trace[65394421] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"184.049638ms","start":"2026-02-17T23:06:45.445919Z","end":"2026-02-17T23:06:45.629968Z","steps":["trace[65394421] 'agreement among raft nodes before linearized reading' (duration: 184.024567ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.63015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.724843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:45.630169Z","caller":"traceutil/trace.go:171","msg":"trace[214609177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:583; }","duration":"158.764474ms","start":"2026-02-17T23:06:45.4714Z","end":"2026-02-17T23:06:45.630164Z","steps":["trace[214609177] 'agreement among raft nodes before linearized reading' (duration: 158.707823ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.630269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.539336ms","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-02-17T23:06:45.630284Z","caller":"traceutil/trace.go:171","msg":"trace[311105880] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:583; }","duration":"167.578627ms","start":"2026-02-17T23:06:45.462701Z","end":"2026-02-17T23:06:45.63028Z","steps":["trace[311105880] 'agreement among raft nodes before linearized reading' (duration: 167.530556ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:45.630402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.440264ms","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-02-17T23:06:45.630418Z","caller":"traceutil/trace.go:171","msg":"trace[968931665] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:583; }","duration":"174.470926ms","start":"2026-02-17T23:06:45.455942Z","end":"2026-02-17T23:06:45.630413Z","steps":["trace[968931665] 'agreement among raft nodes before linearized reading' (duration: 174.400184ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:45.9075Z","caller":"traceutil/trace.go:171","msg":"trace[2128723487] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"168.904288ms","start":"2026-02-17T23:06:45.738575Z","end":"2026-02-17T23:06:45.907479Z","steps":["trace[2128723487] 'process raft request' (duration: 168.846117ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:45.907973Z","caller":"traceutil/trace.go:171","msg":"trace[1119696956] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"253.797277ms","start":"2026-02-17T23:06:45.654159Z","end":"2026-02-17T23:06:45.907956Z","steps":["trace[1119696956] 'process raft request' (duration: 248.113935ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:45.90817Z","caller":"traceutil/trace.go:171","msg":"trace[1753801696] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"253.961151ms","start":"2026-02-17T23:06:45.654196Z","end":"2026-02-17T23:06:45.908157Z","steps":["trace[1753801696] 'process raft request' (duration: 253.054301ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:45.908387Z","caller":"traceutil/trace.go:171","msg":"trace[9734469] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"254.128173ms","start":"2026-02-17T23:06:45.654249Z","end":"2026-02-17T23:06:45.908377Z","steps":["trace[9734469] 'process raft request' (duration: 253.08983ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:46.058916Z","caller":"traceutil/trace.go:171","msg":"trace[134642218] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"137.096691ms","start":"2026-02-17T23:06:45.921795Z","end":"2026-02-17T23:06:46.058892Z","steps":["trace[134642218] 'read index received' (duration: 85.453301ms)","trace[134642218] 'applied index is now lower than readState.Index' (duration: 51.64249ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:46.05895Z","caller":"traceutil/trace.go:171","msg":"trace[270927646] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"137.51646ms","start":"2026-02-17T23:06:45.921403Z","end":"2026-02-17T23:06:46.058919Z","steps":["trace[270927646] 'process raft request' (duration: 85.906192ms)","trace[270927646] 'compare' (duration: 51.455955ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:46.059299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.478169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs7j\" ","response":"range_response_count:1 size:17329"} {"level":"info","ts":"2026-02-17T23:06:46.059332Z","caller":"traceutil/trace.go:171","msg":"trace[1754201010] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs7j; range_end:; response_count:1; response_revision:589; }","duration":"137.549071ms","start":"2026-02-17T23:06:45.921773Z","end":"2026-02-17T23:06:46.059322Z","steps":["trace[1754201010] 'agreement among raft nodes before linearized reading' (duration: 137.376287ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:47.30484Z","caller":"traceutil/trace.go:171","msg":"trace[1136684432] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"419.547569ms","start":"2026-02-17T23:06:46.885271Z","end":"2026-02-17T23:06:47.304819Z","steps":["trace[1136684432] 'process raft request' (duration: 419.431597ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:47.304949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:46.88526Z","time spent":"419.639161ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":749,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:47.531418Z","caller":"traceutil/trace.go:171","msg":"trace[1871193577] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"644.827766ms","start":"2026-02-17T23:06:46.886574Z","end":"2026-02-17T23:06:47.531401Z","steps":["trace[1871193577] 'process raft request' (duration: 634.44402ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:47.531529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:46.886566Z","time spent":"644.912687ms","remote":"127.0.0.1:46982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17651,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:47.531879Z","caller":"traceutil/trace.go:171","msg":"trace[1365321927] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"328.645686ms","start":"2026-02-17T23:06:47.203224Z","end":"2026-02-17T23:06:47.53187Z","steps":["trace[1365321927] 'process raft request' (duration: 327.672133ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:47.531922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.203203Z","time spent":"328.692878ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:47.617944Z","caller":"traceutil/trace.go:171","msg":"trace[2138432123] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"616.158889ms","start":"2026-02-17T23:06:47.001771Z","end":"2026-02-17T23:06:47.61793Z","steps":["trace[2138432123] 'read index received' (duration: 303.477196ms)","trace[2138432123] 'applied index is now lower than readState.Index' (duration: 312.681083ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:47.618152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.378085ms","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-02-17T23:06:47.618171Z","caller":"traceutil/trace.go:171","msg":"trace[2132132451] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:616; }","duration":"616.494798ms","start":"2026-02-17T23:06:47.001669Z","end":"2026-02-17T23:06:47.618164Z","steps":["trace[2132132451] 'agreement among raft nodes before linearized reading' (duration: 616.453498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:47.61819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.001648Z","time spent":"616.53591ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-17T23:06:47.618256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.081585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:47.618347Z","caller":"traceutil/trace.go:171","msg":"trace[1305388066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"546.174347ms","start":"2026-02-17T23:06:47.072154Z","end":"2026-02-17T23:06:47.618328Z","steps":["trace[1305388066] 'agreement among raft nodes before linearized reading' (duration: 546.034074ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:47.618383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.072099Z","time spent":"546.275669ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:06:47.618587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.266133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:47.618619Z","caller":"traceutil/trace.go:171","msg":"trace[141807940] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:617; }","duration":"216.334975ms","start":"2026-02-17T23:06:47.402279Z","end":"2026-02-17T23:06:47.618614Z","steps":["trace[141807940] 'agreement among raft nodes before linearized reading' (duration: 216.294434ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.212224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.118922ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:48.212372Z","caller":"traceutil/trace.go:171","msg":"trace[1858837061] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"207.690513ms","start":"2026-02-17T23:06:48.004669Z","end":"2026-02-17T23:06:48.21236Z","steps":["trace[1858837061] 'process raft request' (duration: 207.625071ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:48.212456Z","caller":"traceutil/trace.go:171","msg":"trace[563860766] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"487.100955ms","start":"2026-02-17T23:06:47.725335Z","end":"2026-02-17T23:06:48.212436Z","steps":["trace[563860766] 'process raft request' (duration: 299.709596ms)","trace[563860766] 'compare' (duration: 187.041741ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:48.212547Z","caller":"traceutil/trace.go:171","msg":"trace[175367595] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"466.042359ms","start":"2026-02-17T23:06:47.746495Z","end":"2026-02-17T23:06:48.212538Z","steps":["trace[175367595] 'read index received' (duration: 278.558358ms)","trace[175367595] 'applied index is now lower than readState.Index' (duration: 187.483421ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:48.212559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.725294Z","time spent":"487.199527ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:48.212716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.217913ms","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-02-17T23:06:48.212738Z","caller":"traceutil/trace.go:171","msg":"trace[843678862] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"466.267913ms","start":"2026-02-17T23:06:47.746463Z","end":"2026-02-17T23:06:48.212731Z","steps":["trace[843678862] 'agreement among raft nodes before linearized reading' (duration: 466.180401ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.212757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.746437Z","time spent":"466.314614ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T23:06:48.268027Z","caller":"traceutil/trace.go:171","msg":"trace[1283485285] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"169.085309ms","start":"2026-02-17T23:06:48.098919Z","end":"2026-02-17T23:06:48.268004Z","steps":["trace[1283485285] 'process raft request' (duration: 168.795121ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.268117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.903483ms","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-02-17T23:06:48.268171Z","caller":"traceutil/trace.go:171","msg":"trace[394799610] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:625; }","duration":"466.012916ms","start":"2026-02-17T23:06:47.802143Z","end":"2026-02-17T23:06:48.268156Z","steps":["trace[394799610] 'agreement among raft nodes before linearized reading' (duration: 465.861883ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.268221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.802126Z","time spent":"466.089677ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T23:06:48.268607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.075485ms","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-02-17T23:06:48.268626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.4333ms","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-02-17T23:06:48.268645Z","caller":"traceutil/trace.go:171","msg":"trace[1257000164] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"339.481182ms","start":"2026-02-17T23:06:47.929158Z","end":"2026-02-17T23:06:48.26864Z","steps":["trace[1257000164] 'agreement among raft nodes before linearized reading' (duration: 339.443921ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.268658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.929151Z","time spent":"339.503372ms","remote":"127.0.0.1:47068","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-02-17T23:06:48.268649Z","caller":"traceutil/trace.go:171","msg":"trace[2069392211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"340.150827ms","start":"2026-02-17T23:06:47.928486Z","end":"2026-02-17T23:06:48.268637Z","steps":["trace[2069392211] 'agreement among raft nodes before linearized reading' (duration: 339.971984ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.268683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:47.928472Z","time spent":"340.202578ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:06:48.37422Z","caller":"traceutil/trace.go:171","msg":"trace[1734095419] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"151.966604ms","start":"2026-02-17T23:06:48.222235Z","end":"2026-02-17T23:06:48.374201Z","steps":["trace[1734095419] 'process raft request' (duration: 151.880382ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:48.374723Z","caller":"traceutil/trace.go:171","msg":"trace[800079930] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"152.554308ms","start":"2026-02-17T23:06:48.222155Z","end":"2026-02-17T23:06:48.374709Z","steps":["trace[800079930] 'process raft request' (duration: 115.733372ms)","trace[800079930] 'compare' (duration: 36.13083ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:48.551228Z","caller":"traceutil/trace.go:171","msg":"trace[1095316916] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"276.772312ms","start":"2026-02-17T23:06:48.27444Z","end":"2026-02-17T23:06:48.551213Z","steps":["trace[1095316916] 'process raft request' (duration: 276.743701ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:48.551511Z","caller":"traceutil/trace.go:171","msg":"trace[1035354885] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"279.605845ms","start":"2026-02-17T23:06:48.2719Z","end":"2026-02-17T23:06:48.551506Z","steps":["trace[1035354885] 'process raft request' (duration: 274.588403ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:48.634655Z","caller":"traceutil/trace.go:171","msg":"trace[1673695448] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:647; }","duration":"230.622927ms","start":"2026-02-17T23:06:48.404015Z","end":"2026-02-17T23:06:48.634638Z","steps":["trace[1673695448] 'read index received' (duration: 142.481113ms)","trace[1673695448] 'applied index is now lower than readState.Index' (duration: 88.141044ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:48.634873Z","caller":"traceutil/trace.go:171","msg":"trace[1770473664] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"250.804189ms","start":"2026-02-17T23:06:48.384057Z","end":"2026-02-17T23:06:48.634861Z","steps":["trace[1770473664] 'process raft request' (duration: 250.453801ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.635092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.062458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-17T23:06:48.635118Z","caller":"traceutil/trace.go:171","msg":"trace[3920866] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:630; }","duration":"231.124819ms","start":"2026-02-17T23:06:48.403986Z","end":"2026-02-17T23:06:48.635111Z","steps":["trace[3920866] 'agreement among raft nodes before linearized reading' (duration: 231.019047ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.635264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.087896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T23:06:48.635282Z","caller":"traceutil/trace.go:171","msg":"trace[1848791452] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:630; }","duration":"180.128436ms","start":"2026-02-17T23:06:48.455148Z","end":"2026-02-17T23:06:48.635277Z","steps":["trace[1848791452] 'agreement among raft nodes before linearized reading' (duration: 180.051464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:48.862928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.101074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:48.863413Z","caller":"traceutil/trace.go:171","msg":"trace[554719224] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"211.781865ms","start":"2026-02-17T23:06:48.651612Z","end":"2026-02-17T23:06:48.863394Z","steps":["trace[554719224] 'process raft request' (duration: 52.144759ms)","trace[554719224] 'compare' (duration: 158.935581ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:49.367295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.164206ms","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-02-17T23:06:49.367408Z","caller":"traceutil/trace.go:171","msg":"trace[523974405] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:632; }","duration":"147.285568ms","start":"2026-02-17T23:06:49.220106Z","end":"2026-02-17T23:06:49.367392Z","steps":["trace[523974405] 'range keys from in-memory index tree' (duration: 147.151176ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:49.36775Z","caller":"traceutil/trace.go:171","msg":"trace[1846037437] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"255.720474ms","start":"2026-02-17T23:06:49.112014Z","end":"2026-02-17T23:06:49.367734Z","steps":["trace[1846037437] 'process raft request' (duration: 173.95655ms)","trace[1846037437] 'compare' (duration: 81.019118ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:49.428664Z","caller":"traceutil/trace.go:171","msg":"trace[1171989247] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"225.565815ms","start":"2026-02-17T23:06:49.203079Z","end":"2026-02-17T23:06:49.428644Z","steps":["trace[1171989247] 'process raft request' (duration: 225.482724ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:49.630494Z","caller":"traceutil/trace.go:171","msg":"trace[832242074] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"223.435257ms","start":"2026-02-17T23:06:49.407038Z","end":"2026-02-17T23:06:49.630473Z","steps":["trace[832242074] 'process raft request' (duration: 203.561997ms)","trace[832242074] 'compare' (duration: 19.637155ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:49.635215Z","caller":"traceutil/trace.go:171","msg":"trace[774462903] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"203.22486ms","start":"2026-02-17T23:06:49.431976Z","end":"2026-02-17T23:06:49.635201Z","steps":["trace[774462903] 'process raft request' (duration: 203.139408ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:49.825788Z","caller":"traceutil/trace.go:171","msg":"trace[1252297819] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"172.940638ms","start":"2026-02-17T23:06:49.65283Z","end":"2026-02-17T23:06:49.825771Z","steps":["trace[1252297819] 'process raft request' (duration: 95.194332ms)","trace[1252297819] 'compare' (duration: 77.601283ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:49.826881Z","caller":"traceutil/trace.go:171","msg":"trace[1976588588] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"160.918411ms","start":"2026-02-17T23:06:49.665941Z","end":"2026-02-17T23:06:49.826859Z","steps":["trace[1976588588] 'process raft request' (duration: 160.655895ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:49.827332Z","caller":"traceutil/trace.go:171","msg":"trace[485505804] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"139.536797ms","start":"2026-02-17T23:06:49.68778Z","end":"2026-02-17T23:06:49.827317Z","steps":["trace[485505804] 'process raft request' (duration: 138.953544ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:50.362244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.772592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:50.362302Z","caller":"traceutil/trace.go:171","msg":"trace[751431655] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"478.229954ms","start":"2026-02-17T23:06:49.884061Z","end":"2026-02-17T23:06:50.362291Z","steps":["trace[751431655] 'process raft request' (duration: 277.3712ms)","trace[751431655] 'compare' (duration: 200.544017ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:50.362328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:49.884045Z","time spent":"478.273175ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:50.375306Z","caller":"traceutil/trace.go:171","msg":"trace[2014662276] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:660; }","duration":"300.665297ms","start":"2026-02-17T23:06:50.074627Z","end":"2026-02-17T23:06:50.375292Z","steps":["trace[2014662276] 'read index received' (duration: 86.760136ms)","trace[2014662276] 'applied index is now lower than readState.Index' (duration: 213.904251ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:50.375808Z","caller":"traceutil/trace.go:171","msg":"trace[2137661839] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"465.664632ms","start":"2026-02-17T23:06:49.910103Z","end":"2026-02-17T23:06:50.375767Z","steps":["trace[2137661839] 'process raft request' (duration: 464.818663ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:50.375942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:49.910086Z","time spent":"465.796624ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:50.376168Z","caller":"traceutil/trace.go:171","msg":"trace[474855434] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"406.917928ms","start":"2026-02-17T23:06:49.969232Z","end":"2026-02-17T23:06:50.37615Z","steps":["trace[474855434] 'process raft request' (duration: 405.828364ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:50.376245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:49.969195Z","time spent":"406.99177ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:50.376419Z","caller":"traceutil/trace.go:171","msg":"trace[1339022023] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"341.382463ms","start":"2026-02-17T23:06:50.035029Z","end":"2026-02-17T23:06:50.376411Z","steps":["trace[1339022023] 'process raft request' (duration: 340.147326ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:50.376505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.035011Z","time spent":"341.448344ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T23:06:50.37666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.038537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:06:50.376681Z","caller":"traceutil/trace.go:171","msg":"trace[1865873676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:644; }","duration":"302.101698ms","start":"2026-02-17T23:06:50.074573Z","end":"2026-02-17T23:06:50.376675Z","steps":["trace[1865873676] 'agreement among raft nodes before linearized reading' (duration: 302.016117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:50.376729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.074559Z","time spent":"302.164069ms","remote":"127.0.0.1:46774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-17T23:06:50.378002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.784033ms","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-02-17T23:06:50.378053Z","caller":"traceutil/trace.go:171","msg":"trace[557377572] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:644; }","duration":"175.875775ms","start":"2026-02-17T23:06:50.202163Z","end":"2026-02-17T23:06:50.378039Z","steps":["trace[557377572] 'agreement among raft nodes before linearized reading' (duration: 175.705001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.104773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.213076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:51.104893Z","caller":"traceutil/trace.go:171","msg":"trace[496034900] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"700.134003ms","start":"2026-02-17T23:06:50.404748Z","end":"2026-02-17T23:06:51.104882Z","steps":["trace[496034900] 'process raft request' (duration: 700.093963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.104925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.404738Z","time spent":"700.173874ms","remote":"127.0.0.1:46872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T23:06:51.105097Z","caller":"traceutil/trace.go:171","msg":"trace[1744157940] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"701.510773ms","start":"2026-02-17T23:06:50.403579Z","end":"2026-02-17T23:06:51.10509Z","steps":["trace[1744157940] 'process raft request' (duration: 141.922909ms)","trace[1744157940] 'compare' (duration: 558.94549ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:51.105127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.403561Z","time spent":"701.549173ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:51.105184Z","caller":"traceutil/trace.go:171","msg":"trace[989591849] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"700.515112ms","start":"2026-02-17T23:06:50.404664Z","end":"2026-02-17T23:06:51.105179Z","steps":["trace[989591849] 'read index received' (duration: 140.845996ms)","trace[989591849] 'applied index is now lower than readState.Index' (duration: 559.668676ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:51.105284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.619214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-17T23:06:51.105299Z","caller":"traceutil/trace.go:171","msg":"trace[1838071278] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:646; }","duration":"700.666114ms","start":"2026-02-17T23:06:50.404627Z","end":"2026-02-17T23:06:51.105293Z","steps":["trace[1838071278] 'agreement among raft nodes before linearized reading' (duration: 700.601293ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.105312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.404598Z","time spent":"700.711626ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4357,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-02-17T23:06:51.110022Z","caller":"traceutil/trace.go:171","msg":"trace[407802896] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"515.707059ms","start":"2026-02-17T23:06:50.594304Z","end":"2026-02-17T23:06:51.110011Z","steps":["trace[407802896] 'process raft request' (duration: 515.155517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.110137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.594289Z","time spent":"515.773261ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188471,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:51.11062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.653219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:06:51.110686Z","caller":"traceutil/trace.go:171","msg":"trace[1624212648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"536.717651ms","start":"2026-02-17T23:06:50.57394Z","end":"2026-02-17T23:06:51.110658Z","steps":["trace[1624212648] 'agreement among raft nodes before linearized reading' (duration: 536.575538ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.110806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.573927Z","time spent":"536.774932ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-17T23:06:51.111017Z","caller":"traceutil/trace.go:171","msg":"trace[811326795] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"500.738379ms","start":"2026-02-17T23:06:50.610254Z","end":"2026-02-17T23:06:51.110992Z","steps":["trace[811326795] 'process raft request' (duration: 499.536573ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.111115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.610233Z","time spent":"500.802461ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T23:06:51.111861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.551607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-17T23:06:51.111883Z","caller":"traceutil/trace.go:171","msg":"trace[4523534] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:648; }","duration":"242.589388ms","start":"2026-02-17T23:06:50.869288Z","end":"2026-02-17T23:06:51.111877Z","steps":["trace[4523534] 'agreement among raft nodes before linearized reading' (duration: 242.516916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.112171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.07961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-17T23:06:51.112201Z","caller":"traceutil/trace.go:171","msg":"trace[520479420] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:648; }","duration":"310.135272ms","start":"2026-02-17T23:06:50.802058Z","end":"2026-02-17T23:06:51.112194Z","steps":["trace[520479420] 'agreement among raft nodes before linearized reading' (duration: 310.018889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.113499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.802045Z","time spent":"310.165972ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":188276,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-17T23:06:51.114018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.263536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-17T23:06:51.11567Z","caller":"traceutil/trace.go:171","msg":"trace[1833228541] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:648; }","duration":"510.905952ms","start":"2026-02-17T23:06:50.604707Z","end":"2026-02-17T23:06:51.115613Z","steps":["trace[1833228541] 'agreement among raft nodes before linearized reading' (duration: 509.163674ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.115801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.604695Z","time spent":"511.087677ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24268,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-17T23:06:51.114241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.253199ms","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-02-17T23:06:51.115982Z","caller":"traceutil/trace.go:171","msg":"trace[1280230625] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"541.919944ms","start":"2026-02-17T23:06:50.573974Z","end":"2026-02-17T23:06:51.115894Z","steps":["trace[1280230625] 'agreement among raft nodes before linearized reading' (duration: 540.213938ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.116025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:50.57397Z","time spent":"542.045917ms","remote":"127.0.0.1:47068","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-02-17T23:06:51.559484Z","caller":"traceutil/trace.go:171","msg":"trace[240074901] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"149.35158ms","start":"2026-02-17T23:06:51.410119Z","end":"2026-02-17T23:06:51.55947Z","steps":["trace[240074901] 'read index received' (duration: 149.198696ms)","trace[240074901] 'applied index is now lower than readState.Index' (duration: 152.464µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:51.559542Z","caller":"traceutil/trace.go:171","msg":"trace[735047054] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"149.607306ms","start":"2026-02-17T23:06:51.40993Z","end":"2026-02-17T23:06:51.559537Z","steps":["trace[735047054] 'process raft request' (duration: 149.419561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.55976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.621646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs7j\" ","response":"range_response_count:1 size:17914"} {"level":"info","ts":"2026-02-17T23:06:51.559815Z","caller":"traceutil/trace.go:171","msg":"trace[1028318301] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs7j; range_end:; response_count:1; response_revision:652; }","duration":"149.703469ms","start":"2026-02-17T23:06:51.4101Z","end":"2026-02-17T23:06:51.559803Z","steps":["trace[1028318301] 'agreement among raft nodes before linearized reading' (duration: 149.513955ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:51.798005Z","caller":"traceutil/trace.go:171","msg":"trace[1736566569] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"227.671666ms","start":"2026-02-17T23:06:51.570318Z","end":"2026-02-17T23:06:51.797989Z","steps":["trace[1736566569] 'process raft request' (duration: 227.627565ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:51.798386Z","caller":"traceutil/trace.go:171","msg":"trace[987922998] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"378.500727ms","start":"2026-02-17T23:06:51.419877Z","end":"2026-02-17T23:06:51.798378Z","steps":["trace[987922998] 'process raft request' (duration: 307.311557ms)","trace[987922998] 'compare' (duration: 70.524366ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:51.798459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:51.419861Z","time spent":"378.547649ms","remote":"127.0.0.1:46848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:06:51.798542Z","caller":"traceutil/trace.go:171","msg":"trace[705170528] linearizableReadLoop","detail":"{readStateIndex:673; appliedIndex:672; }","duration":"239.009841ms","start":"2026-02-17T23:06:51.559525Z","end":"2026-02-17T23:06:51.798534Z","steps":["trace[705170528] 'read index received' (duration: 167.671628ms)","trace[705170528] 'applied index is now lower than readState.Index' (duration: 71.337653ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:51.798586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.087427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.89\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-17T23:06:51.79861Z","caller":"traceutil/trace.go:171","msg":"trace[770646627] range","detail":"{range_begin:/registry/masterleases/199.204.45.89; range_end:; response_count:1; response_revision:654; }","duration":"377.144009ms","start":"2026-02-17T23:06:51.421458Z","end":"2026-02-17T23:06:51.798602Z","steps":["trace[770646627] 'agreement among raft nodes before linearized reading' (duration: 377.101268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:51.798631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:06:51.42145Z","time spent":"377.177279ms","remote":"127.0.0.1:46824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.89\" "} {"level":"warn","ts":"2026-02-17T23:06:51.799165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.742689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188495"} {"level":"info","ts":"2026-02-17T23:06:51.799191Z","caller":"traceutil/trace.go:171","msg":"trace[1564409019] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:654; }","duration":"279.82418ms","start":"2026-02-17T23:06:51.51936Z","end":"2026-02-17T23:06:51.799185Z","steps":["trace[1564409019] 'agreement among raft nodes before linearized reading' (duration: 279.767289ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:52.062892Z","caller":"traceutil/trace.go:171","msg":"trace[1633947395] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"186.852434ms","start":"2026-02-17T23:06:51.876024Z","end":"2026-02-17T23:06:52.062876Z","steps":["trace[1633947395] 'read index received' (duration: 169.331167ms)","trace[1633947395] 'applied index is now lower than readState.Index' (duration: 17.520647ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:52.063018Z","caller":"traceutil/trace.go:171","msg":"trace[1444414551] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"187.575549ms","start":"2026-02-17T23:06:51.875434Z","end":"2026-02-17T23:06:52.06301Z","steps":["trace[1444414551] 'process raft request' (duration: 169.96779ms)","trace[1444414551] 'compare' (duration: 17.379234ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:52.063242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.202042ms","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-02-17T23:06:52.063269Z","caller":"traceutil/trace.go:171","msg":"trace[1697946927] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:656; }","duration":"187.248883ms","start":"2026-02-17T23:06:51.876014Z","end":"2026-02-17T23:06:52.063262Z","steps":["trace[1697946927] 'agreement among raft nodes before linearized reading' (duration: 187.13467ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:56.678369Z","caller":"traceutil/trace.go:171","msg":"trace[1948756624] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"111.087726ms","start":"2026-02-17T23:06:56.567262Z","end":"2026-02-17T23:06:56.67835Z","steps":["trace[1948756624] 'process raft request' (duration: 110.952513ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:56.947665Z","caller":"traceutil/trace.go:171","msg":"trace[464680187] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"139.326833ms","start":"2026-02-17T23:06:56.808321Z","end":"2026-02-17T23:06:56.947648Z","steps":["trace[464680187] 'process raft request' (duration: 135.273498ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.17807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.711924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T23:06:57.17817Z","caller":"traceutil/trace.go:171","msg":"trace[301908695] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:714; }","duration":"180.35225ms","start":"2026-02-17T23:06:56.997809Z","end":"2026-02-17T23:06:57.178162Z","steps":["trace[301908695] 'read index received' (duration: 58.532034ms)","trace[301908695] 'applied index is now lower than readState.Index' (duration: 121.819766ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:57.178273Z","caller":"traceutil/trace.go:171","msg":"trace[1247972770] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"222.002015ms","start":"2026-02-17T23:06:56.956264Z","end":"2026-02-17T23:06:57.178266Z","steps":["trace[1247972770] 'process raft request' (duration: 100.049467ms)","trace[1247972770] 'compare' (duration: 121.659062ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:06:57.178348Z","caller":"traceutil/trace.go:171","msg":"trace[1918126061] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"221.265659ms","start":"2026-02-17T23:06:56.957078Z","end":"2026-02-17T23:06:57.178344Z","steps":["trace[1918126061] 'process raft request' (duration: 221.059055ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.178421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.610965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T23:06:57.178434Z","caller":"traceutil/trace.go:171","msg":"trace[1989114054] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:693; }","duration":"180.646276ms","start":"2026-02-17T23:06:56.997784Z","end":"2026-02-17T23:06:57.17843Z","steps":["trace[1989114054] 'agreement among raft nodes before linearized reading' (duration: 180.618355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.178522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.401861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T23:06:57.178535Z","caller":"traceutil/trace.go:171","msg":"trace[1564253666] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:693; }","duration":"179.422351ms","start":"2026-02-17T23:06:56.999108Z","end":"2026-02-17T23:06:57.178531Z","steps":["trace[1564253666] 'agreement among raft nodes before linearized reading' (duration: 179.400981ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.178799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.610624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-02-17T23:06:57.178815Z","caller":"traceutil/trace.go:171","msg":"trace[1963697285] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:693; }","duration":"179.631435ms","start":"2026-02-17T23:06:56.999177Z","end":"2026-02-17T23:06:57.178808Z","steps":["trace[1963697285] 'agreement among raft nodes before linearized reading' (duration: 179.606234ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.178877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.740727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/coredns\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-02-17T23:06:57.178888Z","caller":"traceutil/trace.go:171","msg":"trace[1223139608] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/coredns; range_end:; response_count:1; response_revision:693; }","duration":"179.758037ms","start":"2026-02-17T23:06:56.999127Z","end":"2026-02-17T23:06:57.178885Z","steps":["trace[1223139608] 'agreement among raft nodes before linearized reading' (duration: 179.737897ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.352264Z","caller":"traceutil/trace.go:171","msg":"trace[1841678963] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"160.856649ms","start":"2026-02-17T23:06:57.191398Z","end":"2026-02-17T23:06:57.352255Z","steps":["trace[1841678963] 'process raft request' (duration: 160.591463ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.352435Z","caller":"traceutil/trace.go:171","msg":"trace[161109241] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"141.561711ms","start":"2026-02-17T23:06:57.210869Z","end":"2026-02-17T23:06:57.352431Z","steps":["trace[161109241] 'process raft request' (duration: 141.210824ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.352564Z","caller":"traceutil/trace.go:171","msg":"trace[958539605] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:717; }","duration":"141.448009ms","start":"2026-02-17T23:06:57.210663Z","end":"2026-02-17T23:06:57.352111Z","steps":["trace[958539605] 'read index received' (duration: 52.652833ms)","trace[958539605] 'applied index is now lower than readState.Index' (duration: 88.794626ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:06:57.352678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.00237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-vmckj\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-17T23:06:57.352698Z","caller":"traceutil/trace.go:171","msg":"trace[1972191684] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-vmckj; range_end:; response_count:1; response_revision:696; }","duration":"142.048182ms","start":"2026-02-17T23:06:57.210645Z","end":"2026-02-17T23:06:57.352693Z","steps":["trace[1972191684] 'agreement among raft nodes before linearized reading' (duration: 141.96825ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.352846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.911469ms","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-02-17T23:06:57.352881Z","caller":"traceutil/trace.go:171","msg":"trace[649673203] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:696; }","duration":"141.95571ms","start":"2026-02-17T23:06:57.210921Z","end":"2026-02-17T23:06:57.352877Z","steps":["trace[649673203] 'agreement among raft nodes before linearized reading' (duration: 141.895549ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:06:57.352964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.706644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-17T23:06:57.352981Z","caller":"traceutil/trace.go:171","msg":"trace[1642067559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:696; }","duration":"138.733114ms","start":"2026-02-17T23:06:57.214244Z","end":"2026-02-17T23:06:57.352977Z","steps":["trace[1642067559] 'agreement among raft nodes before linearized reading' (duration: 138.692533ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.495721Z","caller":"traceutil/trace.go:171","msg":"trace[1088855786] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"133.358183ms","start":"2026-02-17T23:06:57.362348Z","end":"2026-02-17T23:06:57.495706Z","steps":["trace[1088855786] 'process raft request' (duration: 132.851532ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.939591Z","caller":"traceutil/trace.go:171","msg":"trace[342952705] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"113.555206ms","start":"2026-02-17T23:06:57.826022Z","end":"2026-02-17T23:06:57.939578Z","steps":["trace[342952705] 'process raft request' (duration: 113.535566ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:57.939843Z","caller":"traceutil/trace.go:171","msg":"trace[1488970663] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"158.167403ms","start":"2026-02-17T23:06:57.78167Z","end":"2026-02-17T23:06:57.939838Z","steps":["trace[1488970663] 'process raft request' (duration: 156.459897ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:58.343602Z","caller":"traceutil/trace.go:171","msg":"trace[1198236147] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"140.305619ms","start":"2026-02-17T23:06:58.203281Z","end":"2026-02-17T23:06:58.343587Z","steps":["trace[1198236147] 'process raft request' (duration: 140.237168ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:59.382919Z","caller":"traceutil/trace.go:171","msg":"trace[1850150353] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"115.075014ms","start":"2026-02-17T23:06:59.267823Z","end":"2026-02-17T23:06:59.382898Z","steps":["trace[1850150353] 'process raft request' (duration: 114.800338ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:59.659272Z","caller":"traceutil/trace.go:171","msg":"trace[1009506577] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"118.565205ms","start":"2026-02-17T23:06:59.540687Z","end":"2026-02-17T23:06:59.659253Z","steps":["trace[1009506577] 'process raft request' (duration: 118.436752ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:06:59.712159Z","caller":"traceutil/trace.go:171","msg":"trace[431815673] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"167.755818ms","start":"2026-02-17T23:06:59.54431Z","end":"2026-02-17T23:06:59.712066Z","steps":["trace[431815673] 'process raft request' (duration: 167.588815ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.511621Z","caller":"traceutil/trace.go:171","msg":"trace[1434614454] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:741; }","duration":"125.721984ms","start":"2026-02-17T23:07:01.385879Z","end":"2026-02-17T23:07:01.511601Z","steps":["trace[1434614454] 'read index received' (duration: 125.578881ms)","trace[1434614454] 'applied index is now lower than readState.Index' (duration: 142.043µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:07:01.511982Z","caller":"traceutil/trace.go:171","msg":"trace[29533005] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"153.745049ms","start":"2026-02-17T23:07:01.358221Z","end":"2026-02-17T23:07:01.511967Z","steps":["trace[29533005] 'process raft request' (duration: 153.28457ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:01.512185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.286285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-17T23:07:01.514532Z","caller":"traceutil/trace.go:171","msg":"trace[2062702597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:718; }","duration":"128.666152ms","start":"2026-02-17T23:07:01.385851Z","end":"2026-02-17T23:07:01.514517Z","steps":["trace[2062702597] 'agreement among raft nodes before linearized reading' (duration: 126.171602ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:01.512495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.060712ms","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-02-17T23:07:01.517026Z","caller":"traceutil/trace.go:171","msg":"trace[1475791169] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:718; }","duration":"119.602332ms","start":"2026-02-17T23:07:01.397409Z","end":"2026-02-17T23:07:01.517011Z","steps":["trace[1475791169] 'agreement among raft nodes before linearized reading' (duration: 115.013371ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.689833Z","caller":"traceutil/trace.go:171","msg":"trace[199448539] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"166.8726ms","start":"2026-02-17T23:07:01.522941Z","end":"2026-02-17T23:07:01.689814Z","steps":["trace[199448539] 'process raft request' (duration: 141.804083ms)","trace[199448539] 'compare' (duration: 24.789672ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:07:01.690224Z","caller":"traceutil/trace.go:171","msg":"trace[205392996] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"167.227507ms","start":"2026-02-17T23:07:01.522988Z","end":"2026-02-17T23:07:01.690216Z","steps":["trace[205392996] 'process raft request' (duration: 166.655786ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.691339Z","caller":"traceutil/trace.go:171","msg":"trace[1435293299] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"163.34543ms","start":"2026-02-17T23:07:01.527973Z","end":"2026-02-17T23:07:01.691319Z","steps":["trace[1435293299] 'process raft request' (duration: 163.289909ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.691382Z","caller":"traceutil/trace.go:171","msg":"trace[572152150] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"168.350269ms","start":"2026-02-17T23:07:01.523024Z","end":"2026-02-17T23:07:01.691374Z","steps":["trace[572152150] 'process raft request' (duration: 166.712047ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.71957Z","caller":"traceutil/trace.go:171","msg":"trace[670116751] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"170.412541ms","start":"2026-02-17T23:07:01.549138Z","end":"2026-02-17T23:07:01.719551Z","steps":["trace[670116751] 'process raft request' (duration: 170.252648ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.849835Z","caller":"traceutil/trace.go:171","msg":"trace[415166091] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:748; }","duration":"124.49945ms","start":"2026-02-17T23:07:01.725321Z","end":"2026-02-17T23:07:01.849821Z","steps":["trace[415166091] 'read index received' (duration: 118.799627ms)","trace[415166091] 'applied index is now lower than readState.Index' (duration: 5.699353ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:07:01.849902Z","caller":"traceutil/trace.go:171","msg":"trace[1569452971] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"149.21537ms","start":"2026-02-17T23:07:01.700682Z","end":"2026-02-17T23:07:01.849897Z","steps":["trace[1569452971] 'process raft request' (duration: 143.430995ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.85011Z","caller":"traceutil/trace.go:171","msg":"trace[27341450] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"148.21304ms","start":"2026-02-17T23:07:01.701892Z","end":"2026-02-17T23:07:01.850105Z","steps":["trace[27341450] 'process raft request' (duration: 147.844912ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.850218Z","caller":"traceutil/trace.go:171","msg":"trace[369957706] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"147.900014ms","start":"2026-02-17T23:07:01.702314Z","end":"2026-02-17T23:07:01.850214Z","steps":["trace[369957706] 'process raft request' (duration: 147.482076ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:01.85034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.160663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-17T23:07:01.850357Z","caller":"traceutil/trace.go:171","msg":"trace[1687109237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:726; }","duration":"125.214093ms","start":"2026-02-17T23:07:01.725138Z","end":"2026-02-17T23:07:01.850352Z","steps":["trace[1687109237] 'agreement among raft nodes before linearized reading' (duration: 125.136162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:01.850446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.089737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-ccphs\" ","response":"range_response_count:1 size:4986"} {"level":"info","ts":"2026-02-17T23:07:01.850469Z","caller":"traceutil/trace.go:171","msg":"trace[1244061683] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-ccphs; range_end:; response_count:1; response_revision:726; }","duration":"150.133859ms","start":"2026-02-17T23:07:01.70033Z","end":"2026-02-17T23:07:01.850464Z","steps":["trace[1244061683] 'agreement among raft nodes before linearized reading' (duration: 150.086798ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:01.875978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.732539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-17T23:07:01.876029Z","caller":"traceutil/trace.go:171","msg":"trace[1400831456] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:727; }","duration":"149.808621ms","start":"2026-02-17T23:07:01.726207Z","end":"2026-02-17T23:07:01.876015Z","steps":["trace[1400831456] 'agreement among raft nodes before linearized reading' (duration: 149.701039ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:01.876246Z","caller":"traceutil/trace.go:171","msg":"trace[791871237] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"148.842032ms","start":"2026-02-17T23:07:01.727397Z","end":"2026-02-17T23:07:01.876239Z","steps":["trace[791871237] 'process raft request' (duration: 148.435364ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:02.078638Z","caller":"traceutil/trace.go:171","msg":"trace[32239218] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"222.508409ms","start":"2026-02-17T23:07:01.856122Z","end":"2026-02-17T23:07:02.07863Z","steps":["trace[32239218] 'process raft request' (duration: 214.223857ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:02.079407Z","caller":"traceutil/trace.go:171","msg":"trace[72031367] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"209.958151ms","start":"2026-02-17T23:07:01.869441Z","end":"2026-02-17T23:07:02.079399Z","steps":["trace[72031367] 'process raft request' (duration: 208.9331ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:02.078529Z","caller":"traceutil/trace.go:171","msg":"trace[476353421] linearizableReadLoop","detail":"{readStateIndex:754; appliedIndex:752; }","duration":"200.732277ms","start":"2026-02-17T23:07:01.877782Z","end":"2026-02-17T23:07:02.078514Z","steps":["trace[476353421] 'read index received' (duration: 192.488426ms)","trace[476353421] 'applied index is now lower than readState.Index' (duration: 8.243231ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:07:02.079685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.88835ms","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-02-17T23:07:02.079706Z","caller":"traceutil/trace.go:171","msg":"trace[1906214269] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:729; }","duration":"201.951071ms","start":"2026-02-17T23:07:01.877748Z","end":"2026-02-17T23:07:02.079699Z","steps":["trace[1906214269] 'agreement among raft nodes before linearized reading' (duration: 201.838689ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:02.446688Z","caller":"traceutil/trace.go:171","msg":"trace[1723206196] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"359.070128ms","start":"2026-02-17T23:07:02.087603Z","end":"2026-02-17T23:07:02.446673Z","steps":["trace[1723206196] 'process raft request' (duration: 359.019727ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:02.446782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:02.087598Z","time spent":"359.136609ms","remote":"127.0.0.1:46960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":782,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:07:02.446982Z","caller":"traceutil/trace.go:171","msg":"trace[1044338326] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"359.618549ms","start":"2026-02-17T23:07:02.087354Z","end":"2026-02-17T23:07:02.446973Z","steps":["trace[1044338326] 'process raft request' (duration: 312.930451ms)","trace[1044338326] 'compare' (duration: 46.132787ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:07:02.447018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:02.087348Z","time spent":"359.65179ms","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1291,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:07:02.496741Z","caller":"traceutil/trace.go:171","msg":"trace[821113402] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:755; }","duration":"166.741158ms","start":"2026-02-17T23:07:02.329979Z","end":"2026-02-17T23:07:02.49672Z","steps":["trace[821113402] 'read index received' (duration: 70.373803ms)","trace[821113402] 'applied index is now lower than readState.Index' (duration: 96.366245ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:07:02.497261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.261108ms","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-02-17T23:07:02.497396Z","caller":"traceutil/trace.go:171","msg":"trace[1922829657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:733; }","duration":"167.431941ms","start":"2026-02-17T23:07:02.329951Z","end":"2026-02-17T23:07:02.497383Z","steps":["trace[1922829657] 'agreement among raft nodes before linearized reading' (duration: 167.168706ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:02.498367Z","caller":"traceutil/trace.go:171","msg":"trace[435896685] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"335.971175ms","start":"2026-02-17T23:07:02.162379Z","end":"2026-02-17T23:07:02.49835Z","steps":["trace[435896685] 'process raft request' (duration: 334.17456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:07:02.498812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:07:02.162364Z","time spent":"336.386012ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4191,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:07:03.816901Z","caller":"traceutil/trace.go:171","msg":"trace[1761726117] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"112.637255ms","start":"2026-02-17T23:07:03.704246Z","end":"2026-02-17T23:07:03.816884Z","steps":["trace[1761726117] 'process raft request' (duration: 61.684462ms)","trace[1761726117] 'compare' (duration: 50.686568ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:07:32.219612Z","caller":"traceutil/trace.go:171","msg":"trace[1108218877] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"121.987747ms","start":"2026-02-17T23:07:32.097601Z","end":"2026-02-17T23:07:32.219589Z","steps":["trace[1108218877] 'process raft request' (duration: 97.978466ms)","trace[1108218877] 'compare' (duration: 23.786598ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T23:07:38.038709Z","caller":"traceutil/trace.go:171","msg":"trace[366750810] transaction","detail":"{read_only:false; response_revision:871; number_of_response:1; }","duration":"118.121991ms","start":"2026-02-17T23:07:37.920567Z","end":"2026-02-17T23:07:38.038689Z","steps":["trace[366750810] 'process raft request' (duration: 117.990799ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:52.946024Z","caller":"traceutil/trace.go:171","msg":"trace[381034418] linearizableReadLoop","detail":"{readStateIndex:949; appliedIndex:948; }","duration":"104.872686ms","start":"2026-02-17T23:07:52.841133Z","end":"2026-02-17T23:07:52.946006Z","steps":["trace[381034418] 'read index received' (duration: 104.762494ms)","trace[381034418] 'applied index is now lower than readState.Index' (duration: 109.582µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:07:52.946131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.979157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:07:52.946156Z","caller":"traceutil/trace.go:171","msg":"trace[1427023918] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:914; }","duration":"105.026758ms","start":"2026-02-17T23:07:52.841121Z","end":"2026-02-17T23:07:52.946147Z","steps":["trace[1427023918] 'agreement among raft nodes before linearized reading' (duration: 104.972657ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:07:52.946185Z","caller":"traceutil/trace.go:171","msg":"trace[1209406855] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"112.725073ms","start":"2026-02-17T23:07:52.83345Z","end":"2026-02-17T23:07:52.946175Z","steps":["trace[1209406855] 'process raft request' (duration: 112.457599ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:05.253279Z","caller":"traceutil/trace.go:171","msg":"trace[1489686393] linearizableReadLoop","detail":"{readStateIndex:1018; appliedIndex:1017; }","duration":"181.585278ms","start":"2026-02-17T23:08:05.071674Z","end":"2026-02-17T23:08:05.253259Z","steps":["trace[1489686393] 'read index received' (duration: 181.424406ms)","trace[1489686393] 'applied index is now lower than readState.Index' (duration: 160.052µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T23:08:05.25343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.73621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T23:08:05.25346Z","caller":"traceutil/trace.go:171","msg":"trace[151501551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:980; }","duration":"181.81729ms","start":"2026-02-17T23:08:05.071633Z","end":"2026-02-17T23:08:05.25345Z","steps":["trace[151501551] 'agreement among raft nodes before linearized reading' (duration: 181.730399ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:05.253794Z","caller":"traceutil/trace.go:171","msg":"trace[201619817] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"247.811255ms","start":"2026-02-17T23:08:05.005971Z","end":"2026-02-17T23:08:05.253782Z","steps":["trace[201619817] 'process raft request' (duration: 247.181708ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T23:08:13.25179Z","caller":"traceutil/trace.go:171","msg":"trace[1984524637] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"528.194661ms","start":"2026-02-17T23:08:12.723573Z","end":"2026-02-17T23:08:13.251768Z","steps":["trace[1984524637] 'process raft request' (duration: 528.068229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:13.251929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:12.72356Z","time spent":"528.293932ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T23:08:13.265518Z","caller":"traceutil/trace.go:171","msg":"trace[1563593665] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"541.2621ms","start":"2026-02-17T23:08:12.724238Z","end":"2026-02-17T23:08:13.2655Z","steps":["trace[1563593665] 'process raft request' (duration: 540.201257ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T23:08:13.265762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T23:08:12.724231Z","time spent":"541.340771ms","remote":"127.0.0.1:47068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}