{"level":"warn","ts":"2026-02-22T05:07:17.342738Z","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-22T05:07:17.342825Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.195: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://162.253.55.195:2380","--initial-cluster=instance=https://162.253.55.195:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.195:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.195: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-22T05:07:17.344665Z","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-22T05:07:17.344694Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-22T05:07:17.34472Z","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-22T05:07:17.345398Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"]} {"level":"info","ts":"2026-02-22T05:07:17.345476Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.195: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-22T05:07:17.350275Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.589907ms"} {"level":"info","ts":"2026-02-22T05:07:17.357457Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b66d12fd59101739","cluster-id":"a64a525934ce8379"} {"level":"info","ts":"2026-02-22T05:07:17.357512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=()"} {"level":"info","ts":"2026-02-22T05:07:17.357529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 0"} {"level":"info","ts":"2026-02-22T05:07:17.357539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b66d12fd59101739 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-22T05:07:17.357545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became follower at term 1"} {"level":"info","ts":"2026-02-22T05:07:17.357574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"warn","ts":"2026-02-22T05:07:17.369688Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-22T05:07:17.371714Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-22T05:07:17.374743Z","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-22T05:07:17.378991Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b66d12fd59101739","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-22T05:07:17.379165Z","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-22T05:07:17.379278Z","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-22T05:07:17.379327Z","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-22T05:07:17.379364Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b66d12fd59101739","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-22T05:07:17.381688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 switched to configuration voters=(13145183766694598457)"} {"level":"info","ts":"2026-02-22T05:07:17.382124Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","added-peer-id":"b66d12fd59101739","added-peer-peer-urls":["https://162.253.55.195:2380"]} {"level":"info","ts":"2026-02-22T05:07:17.387056Z","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-22T05:07:17.387143Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-22T05:07:17.387231Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.195:2380"} {"level":"info","ts":"2026-02-22T05:07:17.387288Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b66d12fd59101739","initial-advertise-peer-urls":["https://162.253.55.195:2380"],"listen-peer-urls":["https://162.253.55.195:2380"],"advertise-client-urls":["https://162.253.55.195:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.195:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-22T05:07:17.387319Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-22T05:07:17.9602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 is starting a new election at term 1"} {"level":"info","ts":"2026-02-22T05:07:17.960267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-22T05:07:17.960294Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgPreVoteResp from b66d12fd59101739 at term 1"} {"level":"info","ts":"2026-02-22T05:07:17.960307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became candidate at term 2"} {"level":"info","ts":"2026-02-22T05:07:17.960313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 received MsgVoteResp from b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-22T05:07:17.960341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b66d12fd59101739 became leader at term 2"} {"level":"info","ts":"2026-02-22T05:07:17.960356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b66d12fd59101739 elected leader b66d12fd59101739 at term 2"} {"level":"info","ts":"2026-02-22T05:07:17.964251Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b66d12fd59101739","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.195:2379]}","request-path":"/0/members/b66d12fd59101739/attributes","cluster-id":"a64a525934ce8379","publish-timeout":"7s"} {"level":"info","ts":"2026-02-22T05:07:17.964258Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-22T05:07:17.964292Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-22T05:07:17.96432Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-22T05:07:17.964463Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-22T05:07:17.964519Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-22T05:07:17.965196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a64a525934ce8379","local-member-id":"b66d12fd59101739","cluster-version":"3.5"} {"level":"info","ts":"2026-02-22T05:07:17.96533Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-22T05:07:17.965413Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-22T05:07:17.966163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.195:2379"} {"level":"info","ts":"2026-02-22T05:07:17.96858Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-22T05:07:31.928832Z","caller":"traceutil/trace.go:171","msg":"trace[805157828] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"214.543755ms","start":"2026-02-22T05:07:31.714261Z","end":"2026-02-22T05:07:31.928805Z","steps":["trace[805157828] 'process raft request' (duration: 214.362751ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:32.462824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.895235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-02-22T05:07:32.462811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.089909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:07:32.462914Z","caller":"traceutil/trace.go:171","msg":"trace[1704973980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:403; }","duration":"254.044418ms","start":"2026-02-22T05:07:32.208855Z","end":"2026-02-22T05:07:32.462899Z","steps":["trace[1704973980] 'range keys from in-memory index tree' (duration: 253.793093ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:07:32.462947Z","caller":"traceutil/trace.go:171","msg":"trace[553713679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:403; }","duration":"187.299834ms","start":"2026-02-22T05:07:32.275622Z","end":"2026-02-22T05:07:32.462922Z","steps":["trace[553713679] 'range keys from in-memory index tree' (duration: 187.024136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:32.463094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.269064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-22T05:07:32.463217Z","caller":"traceutil/trace.go:171","msg":"trace[938585493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:403; }","duration":"458.466168ms","start":"2026-02-22T05:07:32.004724Z","end":"2026-02-22T05:07:32.46319Z","steps":["trace[938585493] 'range keys from in-memory index tree' (duration: 457.924496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:32.463276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.004706Z","time spent":"458.55672ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-22T05:07:32.634646Z","caller":"traceutil/trace.go:171","msg":"trace[1386717317] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"165.935149ms","start":"2026-02-22T05:07:32.468679Z","end":"2026-02-22T05:07:32.634614Z","steps":["trace[1386717317] 'process raft request' (duration: 165.705514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:33.085942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.939508ms","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-22T05:07:33.086058Z","caller":"traceutil/trace.go:171","msg":"trace[29178673] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:404; }","duration":"379.078781ms","start":"2026-02-22T05:07:32.706964Z","end":"2026-02-22T05:07:33.086043Z","steps":["trace[29178673] 'range keys from in-memory index tree' (duration: 378.922788ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:07:33.130778Z","caller":"traceutil/trace.go:171","msg":"trace[1651367269] linearizableReadLoop","detail":"{readStateIndex:417; appliedIndex:415; }","duration":"479.689939ms","start":"2026-02-22T05:07:32.651063Z","end":"2026-02-22T05:07:33.130753Z","steps":["trace[1651367269] 'read index received' (duration: 479.502045ms)","trace[1651367269] 'applied index is now lower than readState.Index' (duration: 187.014µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:07:33.130821Z","caller":"traceutil/trace.go:171","msg":"trace[482278605] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"662.006717ms","start":"2026-02-22T05:07:32.468779Z","end":"2026-02-22T05:07:33.130786Z","steps":["trace[482278605] 'process raft request' (duration: 661.773042ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:07:33.130868Z","caller":"traceutil/trace.go:171","msg":"trace[35843662] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"658.003655ms","start":"2026-02-22T05:07:32.472843Z","end":"2026-02-22T05:07:33.130846Z","steps":["trace[35843662] 'process raft request' (duration: 657.858861ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:33.130949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.864273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:07:33.131111Z","caller":"traceutil/trace.go:171","msg":"trace[2075010813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:406; }","duration":"480.067038ms","start":"2026-02-22T05:07:32.651021Z","end":"2026-02-22T05:07:33.131088Z","steps":["trace[2075010813] 'agreement among raft nodes before linearized reading' (duration: 479.867504ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:33.131172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.651005Z","time spent":"480.15446ms","remote":"127.0.0.1:49520","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-22T05:07:33.131439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.468736Z","time spent":"662.153421ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:07:33.131578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.472825Z","time spent":"658.088227ms","remote":"127.0.0.1:49704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7222,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:07:33.288671Z","caller":"traceutil/trace.go:171","msg":"trace[427790598] linearizableReadLoop","detail":"{readStateIndex:418; appliedIndex:417; }","duration":"157.7827ms","start":"2026-02-22T05:07:33.130859Z","end":"2026-02-22T05:07:33.288641Z","steps":["trace[427790598] 'read index received' (duration: 148.984397ms)","trace[427790598] 'applied index is now lower than readState.Index' (duration: 8.796763ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:07:33.288678Z","caller":"traceutil/trace.go:171","msg":"trace[812461699] transaction","detail":"{read_only:false; response_revision:407; number_of_response:1; }","duration":"386.516113ms","start":"2026-02-22T05:07:32.902132Z","end":"2026-02-22T05:07:33.288648Z","steps":["trace[812461699] 'process raft request' (duration: 377.649898ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:33.288833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.046137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4071"} {"level":"info","ts":"2026-02-22T05:07:33.288884Z","caller":"traceutil/trace.go:171","msg":"trace[1177917297] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:407; }","duration":"566.159969ms","start":"2026-02-22T05:07:32.722714Z","end":"2026-02-22T05:07:33.288874Z","steps":["trace[1177917297] 'agreement among raft nodes before linearized reading' (duration: 566.027146ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:33.28892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.722692Z","time spent":"566.219901ms","remote":"127.0.0.1:49694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4095,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-22T05:07:33.288962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.955777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"warn","ts":"2026-02-22T05:07:33.289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:32.902104Z","time spent":"386.709367ms","remote":"127.0.0.1:49806","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-22T05:07:33.289041Z","caller":"traceutil/trace.go:171","msg":"trace[1262159149] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:407; }","duration":"149.08502ms","start":"2026-02-22T05:07:33.139935Z","end":"2026-02-22T05:07:33.28902Z","steps":["trace[1262159149] 'agreement among raft nodes before linearized reading' (duration: 148.921346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:50.424688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.233714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-22T05:07:50.424741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.094903ms","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-22T05:07:50.424834Z","caller":"traceutil/trace.go:171","msg":"trace[251886394] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"414.439729ms","start":"2026-02-22T05:07:50.010366Z","end":"2026-02-22T05:07:50.424805Z","steps":["trace[251886394] 'range keys from in-memory index tree' (duration: 414.10343ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:07:50.424855Z","caller":"traceutil/trace.go:171","msg":"trace[1857795463] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:512; }","duration":"362.258928ms","start":"2026-02-22T05:07:50.062568Z","end":"2026-02-22T05:07:50.424827Z","steps":["trace[1857795463] 'range keys from in-memory index tree' (duration: 361.924739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:50.424896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.01035Z","time spent":"414.533571ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-22T05:07:50.424903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.062545Z","time spent":"362.34889ms","remote":"127.0.0.1:49806","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-22T05:07:50.946894Z","caller":"traceutil/trace.go:171","msg":"trace[1194707912] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"701.971061ms","start":"2026-02-22T05:07:50.244882Z","end":"2026-02-22T05:07:50.946853Z","steps":["trace[1194707912] 'process raft request' (duration: 701.667653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:50.947111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.244853Z","time spent":"702.142696ms","remote":"127.0.0.1:49806","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-22T05:07:51.029994Z","caller":"traceutil/trace.go:171","msg":"trace[682139139] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"601.436956ms","start":"2026-02-22T05:07:50.428531Z","end":"2026-02-22T05:07:51.029968Z","steps":["trace[682139139] 'process raft request' (duration: 598.995365ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:51.030162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.428505Z","time spent":"601.57422ms","remote":"127.0.0.1:49806","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-22T05:07:51.030178Z","caller":"traceutil/trace.go:171","msg":"trace[1089821487] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:526; }","duration":"312.682693ms","start":"2026-02-22T05:07:50.717461Z","end":"2026-02-22T05:07:51.030144Z","steps":["trace[1089821487] 'read index received' (duration: 229.174944ms)","trace[1089821487] 'applied index is now lower than readState.Index' (duration: 83.505949ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:07:51.030238Z","caller":"traceutil/trace.go:171","msg":"trace[745503298] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"601.396976ms","start":"2026-02-22T05:07:50.428795Z","end":"2026-02-22T05:07:51.030192Z","steps":["trace[745503298] 'process raft request' (duration: 601.116289ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:51.030317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.808906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:07:51.030411Z","caller":"traceutil/trace.go:171","msg":"trace[311128664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:515; }","duration":"312.962651ms","start":"2026-02-22T05:07:50.71742Z","end":"2026-02-22T05:07:51.030382Z","steps":["trace[311128664] 'agreement among raft nodes before linearized reading' (duration: 312.804136ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:51.03045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.428765Z","time spent":"601.57238ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:07:51.030471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:50.717402Z","time spent":"313.060754ms","remote":"127.0.0.1:49508","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-22T05:07:51.030495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.858192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-22T05:07:51.03055Z","caller":"traceutil/trace.go:171","msg":"trace[2049910479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:515; }","duration":"289.985935ms","start":"2026-02-22T05:07:50.740534Z","end":"2026-02-22T05:07:51.03052Z","steps":["trace[2049910479] 'agreement among raft nodes before linearized reading' (duration: 289.753789ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:07:57.451498Z","caller":"traceutil/trace.go:171","msg":"trace[1464952120] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"138.02971ms","start":"2026-02-22T05:07:57.313439Z","end":"2026-02-22T05:07:57.451468Z","steps":["trace[1464952120] 'process raft request' (duration: 137.834135ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:59.961808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.347173ms","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-22T05:07:59.961902Z","caller":"traceutil/trace.go:171","msg":"trace[1143748290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:538; }","duration":"506.504126ms","start":"2026-02-22T05:07:59.455377Z","end":"2026-02-22T05:07:59.961881Z","steps":["trace[1143748290] 'range keys from in-memory index tree' (duration: 506.030375ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:07:59.961958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:07:59.45535Z","time spent":"506.599009ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-22T05:08:02.383124Z","caller":"traceutil/trace.go:171","msg":"trace[781479240] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"499.291682ms","start":"2026-02-22T05:08:01.883798Z","end":"2026-02-22T05:08:02.383089Z","steps":["trace[781479240] 'process raft request' (duration: 462.529975ms)","trace[781479240] 'compare' (duration: 36.617144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:02.384044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:01.883784Z","time spent":"499.444496ms","remote":"127.0.0.1:49550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:08:02.390342Z","caller":"traceutil/trace.go:171","msg":"trace[1740236427] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"502.093675ms","start":"2026-02-22T05:08:01.88822Z","end":"2026-02-22T05:08:02.390314Z","steps":["trace[1740236427] 'process raft request' (duration: 501.87893ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:02.390568Z","caller":"traceutil/trace.go:171","msg":"trace[173221706] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"379.217141ms","start":"2026-02-22T05:08:02.011308Z","end":"2026-02-22T05:08:02.390525Z","steps":["trace[173221706] 'read index received' (duration: 335.065335ms)","trace[173221706] 'applied index is now lower than readState.Index' (duration: 44.148466ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:02.390684Z","caller":"traceutil/trace.go:171","msg":"trace[727708656] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"350.897238ms","start":"2026-02-22T05:08:02.039761Z","end":"2026-02-22T05:08:02.390658Z","steps":["trace[727708656] 'process raft request' (duration: 350.500368ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:02.39087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.278688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-22T05:08:02.390919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.58751ms","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-22T05:08:02.390952Z","caller":"traceutil/trace.go:171","msg":"trace[1004599667] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:571; }","duration":"153.409002ms","start":"2026-02-22T05:08:02.237529Z","end":"2026-02-22T05:08:02.390938Z","steps":["trace[1004599667] 'agreement among raft nodes before linearized reading' (duration: 153.252708ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:02.390969Z","caller":"traceutil/trace.go:171","msg":"trace[578418355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:571; }","duration":"379.698243ms","start":"2026-02-22T05:08:02.011255Z","end":"2026-02-22T05:08:02.390953Z","steps":["trace[578418355] 'agreement among raft nodes before linearized reading' (duration: 379.469067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:02.39101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:02.011232Z","time spent":"379.770324ms","remote":"127.0.0.1:49806","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-22T05:08:02.390901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:02.039732Z","time spent":"351.079013ms","remote":"127.0.0.1:49550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-22T05:08:02.391476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:01.888209Z","time spent":"502.225558ms","remote":"127.0.0.1:49550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:08:18.690222Z","caller":"traceutil/trace.go:171","msg":"trace[1262586841] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"137.480326ms","start":"2026-02-22T05:08:18.552712Z","end":"2026-02-22T05:08:18.690192Z","steps":["trace[1262586841] 'read index received' (duration: 137.318962ms)","trace[1262586841] 'applied index is now lower than readState.Index' (duration: 160.464µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:18.690344Z","caller":"traceutil/trace.go:171","msg":"trace[352892299] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"741.233691ms","start":"2026-02-22T05:08:17.949076Z","end":"2026-02-22T05:08:18.69031Z","steps":["trace[352892299] 'process raft request' (duration: 740.970465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:18.690435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.710382ms","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-22T05:08:18.690481Z","caller":"traceutil/trace.go:171","msg":"trace[1100723115] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:727; }","duration":"137.806774ms","start":"2026-02-22T05:08:18.55266Z","end":"2026-02-22T05:08:18.690467Z","steps":["trace[1100723115] 'agreement among raft nodes before linearized reading' (duration: 137.64518ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:18.690623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:17.949039Z","time spent":"741.392926ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:08:19.773005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.972129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:08:19.773107Z","caller":"traceutil/trace.go:171","msg":"trace[1341531464] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:749; }","duration":"1.056923644s","start":"2026-02-22T05:08:18.716167Z","end":"2026-02-22T05:08:19.77309Z","steps":["trace[1341531464] 'read index received' (duration: 358.609475ms)","trace[1341531464] 'applied index is now lower than readState.Index' (duration: 698.313059ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:19.773317Z","caller":"traceutil/trace.go:171","msg":"trace[1652339939] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"1.07837739s","start":"2026-02-22T05:08:18.694928Z","end":"2026-02-22T05:08:19.773306Z","steps":["trace[1652339939] 'process raft request' (duration: 379.864657ms)","trace[1652339939] 'compare' (duration: 697.777135ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:19.773373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:18.694904Z","time spent":"1.078440041s","remote":"127.0.0.1:49806","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-22T05:08:19.773535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057370145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:19.773562Z","caller":"traceutil/trace.go:171","msg":"trace[219342009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"1.057424396s","start":"2026-02-22T05:08:18.716129Z","end":"2026-02-22T05:08:19.773553Z","steps":["trace[219342009] 'agreement among raft nodes before linearized reading' (duration: 1.057379495s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:19.773587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:18.716115Z","time spent":"1.057467477s","remote":"127.0.0.1:49508","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-22T05:08:19.773716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.056837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:08:19.773741Z","caller":"traceutil/trace.go:171","msg":"trace[1717669001] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:728; }","duration":"701.115259ms","start":"2026-02-22T05:08:19.072618Z","end":"2026-02-22T05:08:19.773733Z","steps":["trace[1717669001] 'agreement among raft nodes before linearized reading' (duration: 701.073108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:19.773765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.072598Z","time spent":"701.160529ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:08:19.773979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.881547ms","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-22T05:08:19.774005Z","caller":"traceutil/trace.go:171","msg":"trace[1552043112] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:728; }","duration":"499.906177ms","start":"2026-02-22T05:08:19.274091Z","end":"2026-02-22T05:08:19.773997Z","steps":["trace[1552043112] 'agreement among raft nodes before linearized reading' (duration: 499.808805ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:19.774028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.274032Z","time spent":"499.99117ms","remote":"127.0.0.1:49806","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-22T05:08:19.77416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.534886ms","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-22T05:08:19.774183Z","caller":"traceutil/trace.go:171","msg":"trace[1405053480] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:728; }","duration":"504.570777ms","start":"2026-02-22T05:08:19.269606Z","end":"2026-02-22T05:08:19.774176Z","steps":["trace[1405053480] 'agreement among raft nodes before linearized reading' (duration: 504.503115ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:19.774207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.269599Z","time spent":"504.602928ms","remote":"127.0.0.1:49806","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-22T05:08:19.774335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.567582ms","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-22T05:08:19.774358Z","caller":"traceutil/trace.go:171","msg":"trace[1640977091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:728; }","duration":"523.618932ms","start":"2026-02-22T05:08:19.250731Z","end":"2026-02-22T05:08:19.77435Z","steps":["trace[1640977091] 'agreement among raft nodes before linearized reading' (duration: 523.556751ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:19.774383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.250712Z","time spent":"523.666324ms","remote":"127.0.0.1:49806","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-22T05:08:20.632897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.192767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:08:20.633129Z","caller":"traceutil/trace.go:171","msg":"trace[1323151186] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:750; }","duration":"848.744984ms","start":"2026-02-22T05:08:19.784361Z","end":"2026-02-22T05:08:20.633106Z","steps":["trace[1323151186] 'read index received' (duration: 97.254789ms)","trace[1323151186] 'applied index is now lower than readState.Index' (duration: 751.489245ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:20.633151Z","caller":"traceutil/trace.go:171","msg":"trace[1086134675] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"851.162166ms","start":"2026-02-22T05:08:19.781932Z","end":"2026-02-22T05:08:20.633094Z","steps":["trace[1086134675] 'process raft request' (duration: 99.661481ms)","trace[1086134675] 'compare' (duration: 751.066564ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:20.633316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.781922Z","time spent":"851.313719ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:08:20.63343Z","caller":"traceutil/trace.go:171","msg":"trace[1945845188] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"851.094154ms","start":"2026-02-22T05:08:19.782318Z","end":"2026-02-22T05:08:20.633412Z","steps":["trace[1945845188] 'process raft request' (duration: 850.692714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:20.63351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.7823Z","time spent":"851.170366ms","remote":"127.0.0.1:49806","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-22T05:08:20.633648Z","caller":"traceutil/trace.go:171","msg":"trace[912858991] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"850.641812ms","start":"2026-02-22T05:08:19.782994Z","end":"2026-02-22T05:08:20.633636Z","steps":["trace[912858991] 'process raft request' (duration: 850.069118ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:20.633648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.596758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-02-22T05:08:20.633706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.782979Z","time spent":"850.696604ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:08:20.633745Z","caller":"traceutil/trace.go:171","msg":"trace[1118916338] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:731; }","duration":"266.719201ms","start":"2026-02-22T05:08:20.367003Z","end":"2026-02-22T05:08:20.633722Z","steps":["trace[1118916338] 'agreement among raft nodes before linearized reading' (duration: 266.504586ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:20.633758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"849.37367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:20.633879Z","caller":"traceutil/trace.go:171","msg":"trace[2101938359] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:731; }","duration":"849.526004ms","start":"2026-02-22T05:08:19.78433Z","end":"2026-02-22T05:08:20.633856Z","steps":["trace[2101938359] 'agreement among raft nodes before linearized reading' (duration: 849.323699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:20.633921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:19.78432Z","time spent":"849.592635ms","remote":"127.0.0.1:49508","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-22T05:08:20.902714Z","caller":"traceutil/trace.go:171","msg":"trace[1274988687] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"201.333804ms","start":"2026-02-22T05:08:20.701356Z","end":"2026-02-22T05:08:20.90269Z","steps":["trace[1274988687] 'process raft request' (duration: 116.83002ms)","trace[1274988687] 'compare' (duration: 84.392461ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:22.211759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.491316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:22.211844Z","caller":"traceutil/trace.go:171","msg":"trace[658417777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:732; }","duration":"495.625389ms","start":"2026-02-22T05:08:21.7162Z","end":"2026-02-22T05:08:22.211825Z","steps":["trace[658417777] 'range keys from in-memory index tree' (duration: 495.418893ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.211886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:21.716182Z","time spent":"495.691441ms","remote":"127.0.0.1:49508","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-22T05:08:22.212036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.18977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-22T05:08:22.212029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.156286796s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-22T05:08:22.212103Z","caller":"traceutil/trace.go:171","msg":"trace[190757636] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:732; }","duration":"430.332724ms","start":"2026-02-22T05:08:21.781753Z","end":"2026-02-22T05:08:22.212086Z","steps":["trace[190757636] 'range keys from in-memory index tree' (duration: 430.044867ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:22.212117Z","caller":"traceutil/trace.go:171","msg":"trace[2028625439] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:732; }","duration":"1.156429809s","start":"2026-02-22T05:08:21.055666Z","end":"2026-02-22T05:08:22.212096Z","steps":["trace[2028625439] 'range keys from in-memory index tree' (duration: 1.15606955s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.212141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:21.781732Z","time spent":"430.395015ms","remote":"127.0.0.1:49806","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-22T05:08:22.212159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:21.055636Z","time spent":"1.156514632s","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.195\" "} {"level":"warn","ts":"2026-02-22T05:08:22.212704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060840722s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:08:22.212794Z","caller":"traceutil/trace.go:171","msg":"trace[300008389] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:732; }","duration":"1.060987646s","start":"2026-02-22T05:08:21.151782Z","end":"2026-02-22T05:08:22.21277Z","steps":["trace[300008389] 'count revisions from in-memory index tree' (duration: 1.06073345s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.212859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:21.151761Z","time spent":"1.061087789s","remote":"127.0.0.1:49972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-22T05:08:22.578711Z","caller":"traceutil/trace.go:171","msg":"trace[1000032841] linearizableReadLoop","detail":"{readStateIndex:755; appliedIndex:754; }","duration":"365.804118ms","start":"2026-02-22T05:08:22.212813Z","end":"2026-02-22T05:08:22.578617Z","steps":["trace[1000032841] 'read index received' (duration: 365.651294ms)","trace[1000032841] 'applied index is now lower than readState.Index' (duration: 152.034µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:22.578699Z","caller":"traceutil/trace.go:171","msg":"trace[638739143] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"739.792485ms","start":"2026-02-22T05:08:21.838872Z","end":"2026-02-22T05:08:22.578664Z","steps":["trace[638739143] 'process raft request' (duration: 739.60013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.578893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:21.83884Z","time spent":"739.9655ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:08:22.578999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.163527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:22.579095Z","caller":"traceutil/trace.go:171","msg":"trace[968525005] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:733; }","duration":"366.302531ms","start":"2026-02-22T05:08:22.212782Z","end":"2026-02-22T05:08:22.579084Z","steps":["trace[968525005] 'agreement among raft nodes before linearized reading' (duration: 366.000753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.579173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:22.212767Z","time spent":"366.396983ms","remote":"127.0.0.1:49520","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-22T05:08:22.579645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:22.213008Z","time spent":"366.63574ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-22T05:08:22.579661Z","caller":"traceutil/trace.go:171","msg":"trace[1696377907] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"364.230258ms","start":"2026-02-22T05:08:22.21541Z","end":"2026-02-22T05:08:22.57964Z","steps":["trace[1696377907] 'process raft request' (duration: 364.108505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:22.579787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:22.215398Z","time spent":"364.327351ms","remote":"127.0.0.1:49806","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-22T05:08:23.007979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.997926ms","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-22T05:08:23.008054Z","caller":"traceutil/trace.go:171","msg":"trace[1397746529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:738; }","duration":"101.12213ms","start":"2026-02-22T05:08:22.906915Z","end":"2026-02-22T05:08:23.008037Z","steps":["trace[1397746529] 'range keys from in-memory index tree' (duration: 100.853442ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:43.217274Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504395,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-22T05:08:43.372268Z","caller":"traceutil/trace.go:171","msg":"trace[836099406] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"702.150516ms","start":"2026-02-22T05:08:42.670082Z","end":"2026-02-22T05:08:43.372233Z","steps":["trace[836099406] 'process raft request' (duration: 701.991232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:43.372414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:42.670041Z","time spent":"702.29909ms","remote":"127.0.0.1:49806","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-22T05:08:44.421205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.085512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:08:44.421418Z","caller":"traceutil/trace.go:171","msg":"trace[315817571] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"1.704486736s","start":"2026-02-22T05:08:42.716914Z","end":"2026-02-22T05:08:44.421401Z","steps":["trace[315817571] 'read index received' (duration: 655.341403ms)","trace[315817571] 'applied index is now lower than readState.Index' (duration: 1.049144023s)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:44.421659Z","caller":"traceutil/trace.go:171","msg":"trace[1483003568] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"1.357986959s","start":"2026-02-22T05:08:43.063655Z","end":"2026-02-22T05:08:44.421642Z","steps":["trace[1483003568] 'process raft request' (duration: 1.137300642s)","trace[1483003568] 'compare' (duration: 219.99091ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:44.422304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.684697582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-02-22T05:08:44.422146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705205495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:44.422387Z","caller":"traceutil/trace.go:171","msg":"trace[95424159] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"1.684813035s","start":"2026-02-22T05:08:42.737556Z","end":"2026-02-22T05:08:44.422369Z","steps":["trace[95424159] 'agreement among raft nodes before linearized reading' (duration: 1.684571829s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:44.422429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:42.737545Z","time spent":"1.684877017s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-22T05:08:44.422433Z","caller":"traceutil/trace.go:171","msg":"trace[1481600388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"1.705516283s","start":"2026-02-22T05:08:42.716897Z","end":"2026-02-22T05:08:44.422413Z","steps":["trace[1481600388] 'agreement among raft nodes before linearized reading' (duration: 1.705175414s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:44.422424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252174891s","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":"warn","ts":"2026-02-22T05:08:44.422482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:42.71689Z","time spent":"1.705579944s","remote":"127.0.0.1:49508","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-22T05:08:44.422182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.692526702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-22T05:08:44.42252Z","caller":"traceutil/trace.go:171","msg":"trace[774727418] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"1.692885301s","start":"2026-02-22T05:08:42.729626Z","end":"2026-02-22T05:08:44.422511Z","steps":["trace[774727418] 'agreement among raft nodes before linearized reading' (duration: 1.69243035s)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:44.4225Z","caller":"traceutil/trace.go:171","msg":"trace[684035700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:797; }","duration":"1.252302654s","start":"2026-02-22T05:08:43.170181Z","end":"2026-02-22T05:08:44.422484Z","steps":["trace[684035700] 'agreement among raft nodes before linearized reading' (duration: 1.251877184s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:44.42255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:42.72962Z","time spent":"1.692921972s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-22T05:08:44.422565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:43.170159Z","time spent":"1.252393137s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:08:44.422255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.666369274s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-22T05:08:44.42264Z","caller":"traceutil/trace.go:171","msg":"trace[1364306477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:797; }","duration":"1.666799415s","start":"2026-02-22T05:08:42.755832Z","end":"2026-02-22T05:08:44.422631Z","steps":["trace[1364306477] 'agreement among raft nodes before linearized reading' (duration: 1.666272702s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:44.422672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:42.75581Z","time spent":"1.666854416s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-22T05:08:44.422751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:43.063629Z","time spent":"1.358709438s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:08:44.644001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.721188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:08:44.644213Z","caller":"traceutil/trace.go:171","msg":"trace[316500079] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:826; }","duration":"213.186976ms","start":"2026-02-22T05:08:44.431006Z","end":"2026-02-22T05:08:44.644193Z","steps":["trace[316500079] 'read index received' (duration: 39.110797ms)","trace[316500079] 'applied index is now lower than readState.Index' (duration: 174.075139ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:44.644298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.29571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:44.644329Z","caller":"traceutil/trace.go:171","msg":"trace[1301613159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"213.34713ms","start":"2026-02-22T05:08:44.430973Z","end":"2026-02-22T05:08:44.64432Z","steps":["trace[1301613159] 'agreement among raft nodes before linearized reading' (duration: 213.278349ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:44.644365Z","caller":"traceutil/trace.go:171","msg":"trace[1212384051] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"215.342642ms","start":"2026-02-22T05:08:44.428997Z","end":"2026-02-22T05:08:44.64434Z","steps":["trace[1212384051] 'process raft request' (duration: 107.196124ms)","trace[1212384051] 'compare' (duration: 107.589594ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:44.644543Z","caller":"traceutil/trace.go:171","msg":"trace[1426168534] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"215.443994ms","start":"2026-02-22T05:08:44.429049Z","end":"2026-02-22T05:08:44.644493Z","steps":["trace[1426168534] 'process raft request' (duration: 215.050124ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:44.64458Z","caller":"traceutil/trace.go:171","msg":"trace[2081522192] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"214.996743ms","start":"2026-02-22T05:08:44.429573Z","end":"2026-02-22T05:08:44.64457Z","steps":["trace[2081522192] 'process raft request' (duration: 214.574652ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:46.026071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.154749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:46.026185Z","caller":"traceutil/trace.go:171","msg":"trace[1053489827] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:803; }","duration":"308.354624ms","start":"2026-02-22T05:08:45.717803Z","end":"2026-02-22T05:08:46.026158Z","steps":["trace[1053489827] 'range keys from in-memory index tree' (duration: 308.034195ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:46.026242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:45.717782Z","time spent":"308.446266ms","remote":"127.0.0.1:49508","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-22T05:08:46.651302Z","caller":"traceutil/trace.go:171","msg":"trace[2060685535] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"175.110115ms","start":"2026-02-22T05:08:46.47617Z","end":"2026-02-22T05:08:46.651281Z","steps":["trace[2060685535] 'process raft request' (duration: 174.833178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.941727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.784311ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-22T05:08:47.941845Z","caller":"traceutil/trace.go:171","msg":"trace[160567093] linearizableReadLoop","detail":"{readStateIndex:833; appliedIndex:831; }","duration":"1.292661282s","start":"2026-02-22T05:08:46.649162Z","end":"2026-02-22T05:08:47.941823Z","steps":["trace[160567093] 'read index received' (duration: 1.914068ms)","trace[160567093] 'applied index is now lower than readState.Index' (duration: 1.290745684s)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:08:47.94208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.467245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-22T05:08:47.942122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29295124s","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-22T05:08:47.942145Z","caller":"traceutil/trace.go:171","msg":"trace[1832966352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:804; }","duration":"508.574968ms","start":"2026-02-22T05:08:47.433553Z","end":"2026-02-22T05:08:47.942128Z","steps":["trace[1832966352] 'agreement among raft nodes before linearized reading' (duration: 508.406173ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.061755164s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:08:47.942164Z","caller":"traceutil/trace.go:171","msg":"trace[695251093] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"1.293037492s","start":"2026-02-22T05:08:46.649116Z","end":"2026-02-22T05:08:47.942154Z","steps":["trace[695251093] 'agreement among raft nodes before linearized reading' (duration: 1.292788746s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292526439s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-22T05:08:47.942233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:47.942235Z","caller":"traceutil/trace.go:171","msg":"trace[1499000339] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:804; }","duration":"1.061862107s","start":"2026-02-22T05:08:46.880354Z","end":"2026-02-22T05:08:47.942216Z","steps":["trace[1499000339] 'agreement among raft nodes before linearized reading' (duration: 1.061770195s)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:47.94225Z","caller":"traceutil/trace.go:171","msg":"trace[302522466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:804; }","duration":"1.29258604s","start":"2026-02-22T05:08:46.649645Z","end":"2026-02-22T05:08:47.942231Z","steps":["trace[302522466] 'agreement among raft nodes before linearized reading' (duration: 1.292481328s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:46.649096Z","time spent":"1.293130344s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-22T05:08:47.942269Z","caller":"traceutil/trace.go:171","msg":"trace[339872405] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:804; }","duration":"385.607862ms","start":"2026-02-22T05:08:47.55665Z","end":"2026-02-22T05:08:47.942258Z","steps":["trace[339872405] 'agreement among raft nodes before linearized reading' (duration: 385.557051ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:46.88033Z","time spent":"1.061944709s","remote":"127.0.0.1:49916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:08:47.942289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:46.649636Z","time spent":"1.292646412s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-22T05:08:47.942297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:47.556626Z","time spent":"385.664584ms","remote":"127.0.0.1:49954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:08:47.942183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:47.433532Z","time spent":"508.64283ms","remote":"127.0.0.1:49806","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-22T05:08:47.942061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.107774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:08:47.942461Z","caller":"traceutil/trace.go:171","msg":"trace[1182510908] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:804; }","duration":"224.576806ms","start":"2026-02-22T05:08:47.717875Z","end":"2026-02-22T05:08:47.942451Z","steps":["trace[1182510908] 'agreement among raft nodes before linearized reading' (duration: 224.093184ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.292834737s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-22T05:08:47.942535Z","caller":"traceutil/trace.go:171","msg":"trace[5837540] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:804; }","duration":"1.29334538s","start":"2026-02-22T05:08:46.649178Z","end":"2026-02-22T05:08:47.942523Z","steps":["trace[5837540] 'agreement among raft nodes before linearized reading' (duration: 1.292746225s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:08:47.942575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:46.649157Z","time spent":"1.293407672s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-22T05:08:48.192489Z","caller":"traceutil/trace.go:171","msg":"trace[569491415] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"245.259834ms","start":"2026-02-22T05:08:47.947207Z","end":"2026-02-22T05:08:48.192467Z","steps":["trace[569491415] 'process raft request' (duration: 245.181292ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:48.192655Z","caller":"traceutil/trace.go:171","msg":"trace[1605380637] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"245.726346ms","start":"2026-02-22T05:08:47.94692Z","end":"2026-02-22T05:08:48.192646Z","steps":["trace[1605380637] 'process raft request' (duration: 245.333195ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:58.15746Z","caller":"traceutil/trace.go:171","msg":"trace[1205186640] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"134.164005ms","start":"2026-02-22T05:08:58.023245Z","end":"2026-02-22T05:08:58.157409Z","steps":["trace[1205186640] 'process raft request' (duration: 101.226777ms)","trace[1205186640] 'compare' (duration: 32.727133ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:08:58.459062Z","caller":"traceutil/trace.go:171","msg":"trace[1826037626] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"212.614645ms","start":"2026-02-22T05:08:58.246426Z","end":"2026-02-22T05:08:58.459041Z","steps":["trace[1826037626] 'process raft request' (duration: 208.639277ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:08:58.459651Z","caller":"traceutil/trace.go:171","msg":"trace[160028943] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"212.543704ms","start":"2026-02-22T05:08:58.247066Z","end":"2026-02-22T05:08:58.45961Z","steps":["trace[160028943] 'process raft request' (duration: 212.339038ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:00.599058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.465993ms","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-22T05:09:00.599131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.832327ms","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-22T05:09:00.599146Z","caller":"traceutil/trace.go:171","msg":"trace[938414511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:888; }","duration":"134.600636ms","start":"2026-02-22T05:09:00.464524Z","end":"2026-02-22T05:09:00.599124Z","steps":["trace[938414511] 'range keys from in-memory index tree' (duration: 134.147325ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:00.599192Z","caller":"traceutil/trace.go:171","msg":"trace[756168014] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:888; }","duration":"133.93857ms","start":"2026-02-22T05:09:00.465235Z","end":"2026-02-22T05:09:00.599174Z","steps":["trace[756168014] 'range keys from in-memory index tree' (duration: 133.671432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:00.599242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.380533ms","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":"warn","ts":"2026-02-22T05:09:00.599246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.071914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:00.599484Z","caller":"traceutil/trace.go:171","msg":"trace[55656611] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:888; }","duration":"437.66339ms","start":"2026-02-22T05:09:00.161805Z","end":"2026-02-22T05:09:00.599469Z","steps":["trace[55656611] 'range keys from in-memory index tree' (duration: 437.22384ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:00.599491Z","caller":"traceutil/trace.go:171","msg":"trace[379172882] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:888; }","duration":"881.36675ms","start":"2026-02-22T05:08:59.718107Z","end":"2026-02-22T05:09:00.599473Z","steps":["trace[379172882] 'range keys from in-memory index tree' (duration: 881.003881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:00.599523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.161787Z","time spent":"437.728132ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:00.599529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:08:59.718088Z","time spent":"881.434292ms","remote":"127.0.0.1:49508","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-22T05:09:00.599552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.52175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-22T05:09:00.599601Z","caller":"traceutil/trace.go:171","msg":"trace[591618574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:888; }","duration":"557.604852ms","start":"2026-02-22T05:09:00.041983Z","end":"2026-02-22T05:09:00.599588Z","steps":["trace[591618574] 'range keys from in-memory index tree' (duration: 557.389667ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:00.599644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.04196Z","time spent":"557.667464ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:01.212943Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-22T05:09:01.713083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504607,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-22T05:09:02.101474Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.495315885s","expected-duration":"1s"} {"level":"info","ts":"2026-02-22T05:09:02.101932Z","caller":"traceutil/trace.go:171","msg":"trace[364351238] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"1.495838169s","start":"2026-02-22T05:09:00.606066Z","end":"2026-02-22T05:09:02.101904Z","steps":["trace[364351238] 'process raft request' (duration: 1.495676225s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.102152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.606046Z","time spent":"1.496010412s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:09:02.102881Z","caller":"traceutil/trace.go:171","msg":"trace[739362861] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:921; }","duration":"1.390732425s","start":"2026-02-22T05:09:00.712126Z","end":"2026-02-22T05:09:02.102859Z","steps":["trace[739362861] 'read index received' (duration: 1.38969369s)","trace[739362861] 'applied index is now lower than readState.Index' (duration: 1.037835ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:02.102977Z","caller":"traceutil/trace.go:171","msg":"trace[6359380] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"1.494950157s","start":"2026-02-22T05:09:00.60802Z","end":"2026-02-22T05:09:02.10297Z","steps":["trace[6359380] 'process raft request' (duration: 1.494814294s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.103066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.607993Z","time spent":"1.495007318s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:09:02.103027Z","caller":"traceutil/trace.go:171","msg":"trace[1181722058] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"1.496540616s","start":"2026-02-22T05:09:00.606453Z","end":"2026-02-22T05:09:02.102994Z","steps":["trace[1181722058] 'process raft request' (duration: 1.496348291s)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:02.103047Z","caller":"traceutil/trace.go:171","msg":"trace[2115779009] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"1.496581867s","start":"2026-02-22T05:09:00.60642Z","end":"2026-02-22T05:09:02.103002Z","steps":["trace[2115779009] 'process raft request' (duration: 1.496287149s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.103176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.391057523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-02-22T05:09:02.103247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.169215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:02.103275Z","caller":"traceutil/trace.go:171","msg":"trace[78302696] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:892; }","duration":"385.243497ms","start":"2026-02-22T05:09:01.718025Z","end":"2026-02-22T05:09:02.103268Z","steps":["trace[78302696] 'agreement among raft nodes before linearized reading' (duration: 385.192926ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.103253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.606442Z","time spent":"1.496673749s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:02.1033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:01.718002Z","time spent":"385.293848ms","remote":"127.0.0.1:49508","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-22T05:09:02.10321Z","caller":"traceutil/trace.go:171","msg":"trace[1093122889] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:892; }","duration":"1.391131535s","start":"2026-02-22T05:09:00.71207Z","end":"2026-02-22T05:09:02.103202Z","steps":["trace[1093122889] 'agreement among raft nodes before linearized reading' (duration: 1.391037152s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.103375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.606389Z","time spent":"1.496826763s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:02.103348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.044853976s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.195\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-22T05:09:02.103503Z","caller":"traceutil/trace.go:171","msg":"trace[615481725] range","detail":"{range_begin:/registry/masterleases/162.253.55.195; range_end:; response_count:1; response_revision:892; }","duration":"1.045077492s","start":"2026-02-22T05:09:01.058416Z","end":"2026-02-22T05:09:02.103494Z","steps":["trace[615481725] 'agreement among raft nodes before linearized reading' (duration: 1.044649101s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:02.103476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:00.712045Z","time spent":"1.391375711s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-22T05:09:02.103534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:01.058384Z","time spent":"1.045143273s","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/162.253.55.195\" "} {"level":"info","ts":"2026-02-22T05:09:19.966236Z","caller":"traceutil/trace.go:171","msg":"trace[504418452] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"101.309219ms","start":"2026-02-22T05:09:19.864892Z","end":"2026-02-22T05:09:19.966201Z","steps":["trace[504418452] 'process raft request' (duration: 75.909728ms)","trace[504418452] 'compare' (duration: 25.245277ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:21.263374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.54876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:09:21.263507Z","caller":"traceutil/trace.go:171","msg":"trace[947214745] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"172.635142ms","start":"2026-02-22T05:09:21.09085Z","end":"2026-02-22T05:09:21.263485Z","steps":["trace[947214745] 'process raft request' (duration: 34.865977ms)","trace[947214745] 'compare' (duration: 137.379156ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:22.757611Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504796,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-22T05:09:22.884493Z","caller":"traceutil/trace.go:171","msg":"trace[521482952] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1003; }","duration":"627.590812ms","start":"2026-02-22T05:09:22.256869Z","end":"2026-02-22T05:09:22.88446Z","steps":["trace[521482952] 'read index received' (duration: 627.302215ms)","trace[521482952] 'applied index is now lower than readState.Index' (duration: 286.857µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:22.884537Z","caller":"traceutil/trace.go:171","msg":"trace[1241840960] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"643.081736ms","start":"2026-02-22T05:09:22.241419Z","end":"2026-02-22T05:09:22.884501Z","steps":["trace[1241840960] 'process raft request' (duration: 642.788339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:22.884768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.241399Z","time spent":"643.2293ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:22.884847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.322026ms","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-22T05:09:22.884908Z","caller":"traceutil/trace.go:171","msg":"trace[1268447699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:966; }","duration":"623.42876ms","start":"2026-02-22T05:09:22.261465Z","end":"2026-02-22T05:09:22.884894Z","steps":["trace[1268447699] 'agreement among raft nodes before linearized reading' (duration: 623.244124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:22.88492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.662731ms","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":"warn","ts":"2026-02-22T05:09:22.884921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.515206ms","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-22T05:09:22.885Z","caller":"traceutil/trace.go:171","msg":"trace[1779273365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:966; }","duration":"620.818854ms","start":"2026-02-22T05:09:22.264165Z","end":"2026-02-22T05:09:22.884984Z","steps":["trace[1779273365] 'agreement among raft nodes before linearized reading' (duration: 620.596039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:22.885056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.414708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:22.885067Z","caller":"traceutil/trace.go:171","msg":"trace[1702490738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:966; }","duration":"618.685921ms","start":"2026-02-22T05:09:22.266346Z","end":"2026-02-22T05:09:22.885032Z","steps":["trace[1702490738] 'agreement among raft nodes before linearized reading' (duration: 618.381354ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:22.885105Z","caller":"traceutil/trace.go:171","msg":"trace[1504704763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:966; }","duration":"166.49423ms","start":"2026-02-22T05:09:22.718596Z","end":"2026-02-22T05:09:22.88509Z","steps":["trace[1504704763] 'agreement among raft nodes before linearized reading' (duration: 166.437288ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:22.885128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.266338Z","time spent":"618.780883ms","remote":"127.0.0.1:49806","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-22T05:09:22.885057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.264143Z","time spent":"620.905197ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:22.88498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.261444Z","time spent":"623.526992ms","remote":"127.0.0.1:49806","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-22T05:09:22.885398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.555637ms","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-22T05:09:22.885473Z","caller":"traceutil/trace.go:171","msg":"trace[512255809] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:966; }","duration":"628.662499ms","start":"2026-02-22T05:09:22.256767Z","end":"2026-02-22T05:09:22.885429Z","steps":["trace[512255809] 'agreement among raft nodes before linearized reading' (duration: 627.816427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:22.885519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.256743Z","time spent":"628.768642ms","remote":"127.0.0.1:49806","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-22T05:09:23.82087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.928634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:09:23.820998Z","caller":"traceutil/trace.go:171","msg":"trace[293689421] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"931.610741ms","start":"2026-02-22T05:09:22.889365Z","end":"2026-02-22T05:09:23.820976Z","steps":["trace[293689421] 'process raft request' (duration: 654.469111ms)","trace[293689421] 'compare' (duration: 276.522184ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:23.821057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.889344Z","time spent":"931.692563ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:24.136021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.664353ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:09:24.136262Z","caller":"traceutil/trace.go:171","msg":"trace[1895168645] linearizableReadLoop","detail":"{readStateIndex:1008; appliedIndex:1004; }","duration":"949.388913ms","start":"2026-02-22T05:09:23.186853Z","end":"2026-02-22T05:09:24.136242Z","steps":["trace[1895168645] 'read index received' (duration: 356.949265ms)","trace[1895168645] 'applied index is now lower than readState.Index' (duration: 592.438418ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:24.136594Z","caller":"traceutil/trace.go:171","msg":"trace[724724592] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"1.246310334s","start":"2026-02-22T05:09:22.89027Z","end":"2026-02-22T05:09:24.136581Z","steps":["trace[724724592] 'process raft request' (duration: 1.074926104s)","trace[724724592] 'compare' (duration: 170.54723ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:24.136672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.890264Z","time spent":"1.246369675s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:24.136815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.915835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:24.136944Z","caller":"traceutil/trace.go:171","msg":"trace[885086481] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:970; }","duration":"950.11492ms","start":"2026-02-22T05:09:23.186799Z","end":"2026-02-22T05:09:24.136914Z","steps":["trace[885086481] 'agreement among raft nodes before linearized reading' (duration: 949.853534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:24.136976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.593323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:09:24.137095Z","caller":"traceutil/trace.go:171","msg":"trace[1512476629] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:970; }","duration":"907.775168ms","start":"2026-02-22T05:09:23.229294Z","end":"2026-02-22T05:09:24.13707Z","steps":["trace[1512476629] 'agreement among raft nodes before linearized reading' (duration: 907.50154ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:24.137101Z","caller":"traceutil/trace.go:171","msg":"trace[723590132] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"1.246761616s","start":"2026-02-22T05:09:22.890312Z","end":"2026-02-22T05:09:24.137074Z","steps":["trace[723590132] 'process raft request' (duration: 1.245819842s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:24.137168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:23.229269Z","time spent":"907.881442ms","remote":"127.0.0.1:49818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":31,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:09:24.137023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:23.186776Z","time spent":"950.230145ms","remote":"127.0.0.1:49638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-02-22T05:09:24.137145Z","caller":"traceutil/trace.go:171","msg":"trace[2129883559] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"1.246709434s","start":"2026-02-22T05:09:22.890397Z","end":"2026-02-22T05:09:24.137107Z","steps":["trace[2129883559] 'process raft request' (duration: 1.24578764s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:24.137179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.204725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:09:24.137246Z","caller":"traceutil/trace.go:171","msg":"trace[98441113] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:970; }","duration":"430.326149ms","start":"2026-02-22T05:09:23.706905Z","end":"2026-02-22T05:09:24.137231Z","steps":["trace[98441113] 'agreement among raft nodes before linearized reading' (duration: 430.197596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:24.137253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.890308Z","time spent":"1.246844638s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:24.137302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:23.706882Z","time spent":"430.407551ms","remote":"127.0.0.1:49880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:09:24.137353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:22.890379Z","time spent":"1.246858587s","remote":"127.0.0.1:49806","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-22T05:09:24.636731Z","caller":"traceutil/trace.go:171","msg":"trace[579331778] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"285.398385ms","start":"2026-02-22T05:09:24.351304Z","end":"2026-02-22T05:09:24.636703Z","steps":["trace[579331778] 'process raft request' (duration: 285.236631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:24.869701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.884471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:24.869811Z","caller":"traceutil/trace.go:171","msg":"trace[1185925286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"151.082916ms","start":"2026-02-22T05:09:24.718706Z","end":"2026-02-22T05:09:24.869789Z","steps":["trace[1185925286] 'range keys from in-memory index tree' (duration: 150.734138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:26.219414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504810,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-22T05:09:26.225777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.15093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:09:26.225891Z","caller":"traceutil/trace.go:171","msg":"trace[1721370616] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"913.943751ms","start":"2026-02-22T05:09:25.311923Z","end":"2026-02-22T05:09:26.225867Z","steps":["trace[1721370616] 'process raft request' (duration: 276.593816ms)","trace[1721370616] 'compare' (duration: 636.982626ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:26.225987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:25.311892Z","time spent":"914.049204ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:26.720407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504810,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-22T05:09:26.963051Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.33944304s","expected-duration":"1s"} {"level":"info","ts":"2026-02-22T05:09:27.01997Z","caller":"traceutil/trace.go:171","msg":"trace[2128472047] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"1.414574248s","start":"2026-02-22T05:09:25.605363Z","end":"2026-02-22T05:09:27.019938Z","steps":["trace[2128472047] 'process raft request' (duration: 1.357945509s)","trace[2128472047] 'compare' (duration: 56.351482ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:27.020139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:25.60533Z","time spent":"1.414716442s","remote":"127.0.0.1:49694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5264,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-22T05:09:27.360265Z","caller":"traceutil/trace.go:171","msg":"trace[1010972676] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"1.566120235s","start":"2026-02-22T05:09:25.794106Z","end":"2026-02-22T05:09:27.360226Z","steps":["trace[1010972676] 'process raft request' (duration: 1.537043553s)","trace[1010972676] 'compare' (duration: 28.755124ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:27.360503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:25.794082Z","time spent":"1.566279139s","remote":"127.0.0.1:49806","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-22T05:09:27.401535Z","caller":"traceutil/trace.go:171","msg":"trace[636631117] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1011; }","duration":"1.682304144s","start":"2026-02-22T05:09:25.719167Z","end":"2026-02-22T05:09:27.401471Z","steps":["trace[636631117] 'read index received' (duration: 1.244113979s)","trace[636631117] 'applied index is now lower than readState.Index' (duration: 438.188615ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:27.401631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.682455999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:27.401692Z","caller":"traceutil/trace.go:171","msg":"trace[121252139] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:975; }","duration":"1.682572141s","start":"2026-02-22T05:09:25.719104Z","end":"2026-02-22T05:09:27.401676Z","steps":["trace[121252139] 'agreement among raft nodes before linearized reading' (duration: 1.682480639s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.401727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:25.719077Z","time spent":"1.682643323s","remote":"127.0.0.1:49508","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-22T05:09:27.419196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276130446s","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-22T05:09:27.419242Z","caller":"traceutil/trace.go:171","msg":"trace[503014125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:976; }","duration":"1.276196867s","start":"2026-02-22T05:09:26.143035Z","end":"2026-02-22T05:09:27.419232Z","steps":["trace[503014125] 'agreement among raft nodes before linearized reading' (duration: 1.276020863s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.419269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:26.143028Z","time spent":"1.276234058s","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:27.419307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276080164s","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-22T05:09:27.419374Z","caller":"traceutil/trace.go:171","msg":"trace[576201837] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:976; }","duration":"1.276220387s","start":"2026-02-22T05:09:26.143139Z","end":"2026-02-22T05:09:27.419359Z","steps":["trace[576201837] 'agreement among raft nodes before linearized reading' (duration: 1.275893219s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.419413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:26.143114Z","time spent":"1.276290049s","remote":"127.0.0.1:49806","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-22T05:09:27.419441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276435943s","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-22T05:09:27.419463Z","caller":"traceutil/trace.go:171","msg":"trace[1330883737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"1.276498154s","start":"2026-02-22T05:09:26.142956Z","end":"2026-02-22T05:09:27.419454Z","steps":["trace[1330883737] 'agreement among raft nodes before linearized reading' (duration: 1.276442033s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.41948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:26.142933Z","time spent":"1.276542525s","remote":"127.0.0.1:49806","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-22T05:09:27.419488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.75976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-22T05:09:27.419534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322914538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-22T05:09:27.419537Z","caller":"traceutil/trace.go:171","msg":"trace[843182205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:976; }","duration":"490.891154ms","start":"2026-02-22T05:09:26.928633Z","end":"2026-02-22T05:09:27.419525Z","steps":["trace[843182205] 'agreement among raft nodes before linearized reading' (duration: 490.680319ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.419554Z","caller":"traceutil/trace.go:171","msg":"trace[756413171] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:976; }","duration":"1.32297257s","start":"2026-02-22T05:09:26.096576Z","end":"2026-02-22T05:09:27.419549Z","steps":["trace[756413171] 'agreement among raft nodes before linearized reading' (duration: 1.322938589s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.419571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:26.096564Z","time spent":"1.32300359s","remote":"127.0.0.1:49710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-02-22T05:09:27.419571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:26.928604Z","time spent":"490.959845ms","remote":"127.0.0.1:49806","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-22T05:09:27.4197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.595086054s","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-22T05:09:27.419724Z","caller":"traceutil/trace.go:171","msg":"trace[1581581795] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:976; }","duration":"1.595141876s","start":"2026-02-22T05:09:25.824576Z","end":"2026-02-22T05:09:27.419718Z","steps":["trace[1581581795] 'agreement among raft nodes before linearized reading' (duration: 1.595087395s)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:27.419742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:25.824563Z","time spent":"1.595172437s","remote":"127.0.0.1:49806","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-22T05:09:27.538502Z","caller":"traceutil/trace.go:171","msg":"trace[1340683040] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"112.690842ms","start":"2026-02-22T05:09:27.425746Z","end":"2026-02-22T05:09:27.538437Z","steps":["trace[1340683040] 'process raft request' (duration: 112.2012ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.538994Z","caller":"traceutil/trace.go:171","msg":"trace[253922001] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"113.04241ms","start":"2026-02-22T05:09:27.42591Z","end":"2026-02-22T05:09:27.538953Z","steps":["trace[253922001] 'process raft request' (duration: 112.417614ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.539233Z","caller":"traceutil/trace.go:171","msg":"trace[1271101171] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"113.169623ms","start":"2026-02-22T05:09:27.425994Z","end":"2026-02-22T05:09:27.539163Z","steps":["trace[1271101171] 'process raft request' (duration: 112.902036ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.539001Z","caller":"traceutil/trace.go:171","msg":"trace[1593079713] linearizableReadLoop","detail":"{readStateIndex:1020; appliedIndex:1015; }","duration":"107.636707ms","start":"2026-02-22T05:09:27.431324Z","end":"2026-02-22T05:09:27.538961Z","steps":["trace[1593079713] 'read index received' (duration: 3.775765ms)","trace[1593079713] 'applied index is now lower than readState.Index' (duration: 103.859372ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:27.539179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.825021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-22T05:09:27.540006Z","caller":"traceutil/trace.go:171","msg":"trace[1400124304] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:981; }","duration":"108.749524ms","start":"2026-02-22T05:09:27.431227Z","end":"2026-02-22T05:09:27.539977Z","steps":["trace[1400124304] 'agreement among raft nodes before linearized reading' (duration: 107.850812ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.539278Z","caller":"traceutil/trace.go:171","msg":"trace[1647958739] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"113.253385ms","start":"2026-02-22T05:09:27.425987Z","end":"2026-02-22T05:09:27.53924Z","steps":["trace[1647958739] 'process raft request' (duration: 112.766963ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:27.72094Z","caller":"traceutil/trace.go:171","msg":"trace[290873250] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"139.58015ms","start":"2026-02-22T05:09:27.581319Z","end":"2026-02-22T05:09:27.720899Z","steps":["trace[290873250] 'process raft request' (duration: 56.238538ms)","trace[290873250] 'compare' (duration: 83.160858ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:29.889803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.776607ms","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-22T05:09:29.88989Z","caller":"traceutil/trace.go:171","msg":"trace[972336468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:987; }","duration":"343.91585ms","start":"2026-02-22T05:09:29.545956Z","end":"2026-02-22T05:09:29.889872Z","steps":["trace[972336468] 'range keys from in-memory index tree' (duration: 343.601213ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:29.88984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.439653ms","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":"warn","ts":"2026-02-22T05:09:29.889927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:29.545938Z","time spent":"343.979712ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-22T05:09:29.889954Z","caller":"traceutil/trace.go:171","msg":"trace[743834170] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:987; }","duration":"342.644819ms","start":"2026-02-22T05:09:29.547288Z","end":"2026-02-22T05:09:29.889933Z","steps":["trace[743834170] 'range keys from in-memory index tree' (duration: 342.143886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:29.890013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:29.547265Z","time spent":"342.7372ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:29.890029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.649648ms","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-22T05:09:29.890107Z","caller":"traceutil/trace.go:171","msg":"trace[974514868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:987; }","duration":"342.737621ms","start":"2026-02-22T05:09:29.54733Z","end":"2026-02-22T05:09:29.890067Z","steps":["trace[974514868] 'range keys from in-memory index tree' (duration: 342.441493ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:29.89014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:29.547276Z","time spent":"342.856363ms","remote":"127.0.0.1:49806","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-22T05:09:29.890183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.809372ms","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-22T05:09:29.890283Z","caller":"traceutil/trace.go:171","msg":"trace[1936297497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:987; }","duration":"342.983827ms","start":"2026-02-22T05:09:29.547276Z","end":"2026-02-22T05:09:29.89026Z","steps":["trace[1936297497] 'range keys from in-memory index tree' (duration: 342.503865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:29.890328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:29.547248Z","time spent":"343.069809ms","remote":"127.0.0.1:49806","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-22T05:09:30.058697Z","caller":"traceutil/trace.go:171","msg":"trace[675329001] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"163.30956ms","start":"2026-02-22T05:09:29.895354Z","end":"2026-02-22T05:09:30.058664Z","steps":["trace[675329001] 'process raft request' (duration: 163.262069ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:30.05898Z","caller":"traceutil/trace.go:171","msg":"trace[1092757873] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"163.672198ms","start":"2026-02-22T05:09:29.89528Z","end":"2026-02-22T05:09:30.058952Z","steps":["trace[1092757873] 'process raft request' (duration: 162.878839ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:30.059066Z","caller":"traceutil/trace.go:171","msg":"trace[225112235] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"163.729901ms","start":"2026-02-22T05:09:29.895324Z","end":"2026-02-22T05:09:30.059054Z","steps":["trace[225112235] 'process raft request' (duration: 163.245408ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:31.617755Z","caller":"traceutil/trace.go:171","msg":"trace[720812142] linearizableReadLoop","detail":"{readStateIndex:1031; appliedIndex:1030; }","duration":"157.988909ms","start":"2026-02-22T05:09:31.459737Z","end":"2026-02-22T05:09:31.617726Z","steps":["trace[720812142] 'read index received' (duration: 157.865016ms)","trace[720812142] 'applied index is now lower than readState.Index' (duration: 122.343µs)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:31.617772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:31.060561Z","time spent":"557.200843ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-22T05:09:31.618092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.328287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-22T05:09:31.618138Z","caller":"traceutil/trace.go:171","msg":"trace[1884973516] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:991; }","duration":"158.455809ms","start":"2026-02-22T05:09:31.459669Z","end":"2026-02-22T05:09:31.618125Z","steps":["trace[1884973516] 'agreement among raft nodes before linearized reading' (duration: 158.174393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:32.218668Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1673540826198504856,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-22T05:09:32.415837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.811969ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-22T05:09:32.416109Z","caller":"traceutil/trace.go:171","msg":"trace[778219467] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1031; }","duration":"697.782787ms","start":"2026-02-22T05:09:31.718306Z","end":"2026-02-22T05:09:32.416089Z","steps":["trace[778219467] 'read index received' (duration: 538.61903ms)","trace[778219467] 'applied index is now lower than readState.Index' (duration: 159.162587ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:32.416202Z","caller":"traceutil/trace.go:171","msg":"trace[1892496158] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"796.732197ms","start":"2026-02-22T05:09:31.619458Z","end":"2026-02-22T05:09:32.41619Z","steps":["trace[1892496158] 'process raft request' (duration: 637.447047ms)","trace[1892496158] 'compare' (duration: 158.599133ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:09:32.416262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:31.619425Z","time spent":"796.802229ms","remote":"127.0.0.1:49542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:32.416692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.164549ms","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-22T05:09:32.416731Z","caller":"traceutil/trace.go:171","msg":"trace[773535075] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"501.260942ms","start":"2026-02-22T05:09:31.91546Z","end":"2026-02-22T05:09:32.416721Z","steps":["trace[773535075] 'agreement among raft nodes before linearized reading' (duration: 501.070497ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:32.416767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:31.915448Z","time spent":"501.312073ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:32.417022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.302753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-22T05:09:32.417095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.122673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-22T05:09:32.417196Z","caller":"traceutil/trace.go:171","msg":"trace[988206562] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"793.22997ms","start":"2026-02-22T05:09:31.62395Z","end":"2026-02-22T05:09:32.41718Z","steps":["trace[988206562] 'process raft request' (duration: 792.01917ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:32.417241Z","caller":"traceutil/trace.go:171","msg":"trace[1206782928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"354.330168ms","start":"2026-02-22T05:09:32.062889Z","end":"2026-02-22T05:09:32.417219Z","steps":["trace[1206782928] 'agreement among raft nodes before linearized reading' (duration: 354.01808ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:32.417198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.217018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-22T05:09:32.417269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:31.62393Z","time spent":"793.303461ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:32.417297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:32.062865Z","time spent":"354.422151ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-22T05:09:32.417138Z","caller":"traceutil/trace.go:171","msg":"trace[1746385975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:993; }","duration":"353.491377ms","start":"2026-02-22T05:09:32.063622Z","end":"2026-02-22T05:09:32.417113Z","steps":["trace[1746385975] 'agreement among raft nodes before linearized reading' (duration: 353.139459ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:32.417361Z","caller":"traceutil/trace.go:171","msg":"trace[2005896468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"699.040348ms","start":"2026-02-22T05:09:31.718256Z","end":"2026-02-22T05:09:32.417296Z","steps":["trace[2005896468] 'agreement among raft nodes before linearized reading' (duration: 698.141366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:32.417376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:32.063595Z","time spent":"353.766555ms","remote":"127.0.0.1:49806","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-22T05:09:32.417451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.557279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-22T05:09:32.41742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:31.71824Z","time spent":"699.167841ms","remote":"127.0.0.1:49508","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-22T05:09:32.417493Z","caller":"traceutil/trace.go:171","msg":"trace[422787138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"353.953189ms","start":"2026-02-22T05:09:32.063526Z","end":"2026-02-22T05:09:32.417479Z","steps":["trace[422787138] 'agreement among raft nodes before linearized reading' (duration: 353.452787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:32.417675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:32.063515Z","time spent":"354.126613ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-22T05:09:37.869299Z","caller":"traceutil/trace.go:171","msg":"trace[1189812315] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"104.781655ms","start":"2026-02-22T05:09:37.764483Z","end":"2026-02-22T05:09:37.869265Z","steps":["trace[1189812315] 'process raft request' (duration: 104.520348ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:38.705295Z","caller":"traceutil/trace.go:171","msg":"trace[283158870] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"242.396557ms","start":"2026-02-22T05:09:38.462871Z","end":"2026-02-22T05:09:38.705268Z","steps":["trace[283158870] 'read index received' (duration: 242.10448ms)","trace[283158870] 'applied index is now lower than readState.Index' (duration: 290.977µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:38.7054Z","caller":"traceutil/trace.go:171","msg":"trace[1517634027] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"257.281387ms","start":"2026-02-22T05:09:38.448089Z","end":"2026-02-22T05:09:38.705371Z","steps":["trace[1517634027] 'process raft request' (duration: 257.01372ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:38.705615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.044412ms","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-22T05:09:38.705675Z","caller":"traceutil/trace.go:171","msg":"trace[610242747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"181.165394ms","start":"2026-02-22T05:09:38.524499Z","end":"2026-02-22T05:09:38.705665Z","steps":["trace[610242747] 'agreement among raft nodes before linearized reading' (duration: 180.952709ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:38.705657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.755095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-22T05:09:38.705755Z","caller":"traceutil/trace.go:171","msg":"trace[1011952566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"242.936341ms","start":"2026-02-22T05:09:38.462797Z","end":"2026-02-22T05:09:38.705734Z","steps":["trace[1011952566] 'agreement among raft nodes before linearized reading' (duration: 242.586532ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:38.705793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.685277ms","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-22T05:09:38.705846Z","caller":"traceutil/trace.go:171","msg":"trace[1367932037] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1026; }","duration":"179.777949ms","start":"2026-02-22T05:09:38.526057Z","end":"2026-02-22T05:09:38.705835Z","steps":["trace[1367932037] 'agreement among raft nodes before linearized reading' (duration: 179.644056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:38.705869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.79206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-22T05:09:38.70596Z","caller":"traceutil/trace.go:171","msg":"trace[1698837066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1026; }","duration":"179.905033ms","start":"2026-02-22T05:09:38.526043Z","end":"2026-02-22T05:09:38.705948Z","steps":["trace[1698837066] 'agreement among raft nodes before linearized reading' (duration: 179.760959ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:55.199981Z","caller":"traceutil/trace.go:171","msg":"trace[1603453144] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"404.856456ms","start":"2026-02-22T05:09:54.795043Z","end":"2026-02-22T05:09:55.199899Z","steps":["trace[1603453144] 'read index received' (duration: 404.59418ms)","trace[1603453144] 'applied index is now lower than readState.Index' (duration: 261.056µs)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:09:55.200059Z","caller":"traceutil/trace.go:171","msg":"trace[1232970349] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"406.617519ms","start":"2026-02-22T05:09:54.793399Z","end":"2026-02-22T05:09:55.200017Z","steps":["trace[1232970349] 'process raft request' (duration: 406.331292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:55.200276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:54.793364Z","time spent":"406.792673ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-22T05:09:55.200374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.28204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-22T05:09:55.200398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.122461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-22T05:09:55.200457Z","caller":"traceutil/trace.go:171","msg":"trace[75286862] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1109; }","duration":"402.373003ms","start":"2026-02-22T05:09:54.798051Z","end":"2026-02-22T05:09:55.200424Z","steps":["trace[75286862] 'agreement among raft nodes before linearized reading' (duration: 402.138007ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:55.200488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:54.798044Z","time spent":"402.439184ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-22T05:09:55.200494Z","caller":"traceutil/trace.go:171","msg":"trace[915958747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1109; }","duration":"405.292986ms","start":"2026-02-22T05:09:54.795181Z","end":"2026-02-22T05:09:55.200474Z","steps":["trace[915958747] 'agreement among raft nodes before linearized reading' (duration: 405.003759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:55.200536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:54.79515Z","time spent":"405.378378ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-22T05:09:55.201063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.726417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-02-22T05:09:55.201113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.063515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-22T05:09:55.201163Z","caller":"traceutil/trace.go:171","msg":"trace[883530398] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1109; }","duration":"403.88905ms","start":"2026-02-22T05:09:54.797251Z","end":"2026-02-22T05:09:55.20114Z","steps":["trace[883530398] 'agreement among raft nodes before linearized reading' (duration: 403.370498ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:09:55.201168Z","caller":"traceutil/trace.go:171","msg":"trace[504951522] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1109; }","duration":"406.143067ms","start":"2026-02-22T05:09:54.795008Z","end":"2026-02-22T05:09:55.201151Z","steps":["trace[504951522] 'agreement among raft nodes before linearized reading' (duration: 405.136112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:09:55.201209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:54.794996Z","time spent":"406.204569ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-22T05:09:55.201349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-22T05:09:54.797238Z","time spent":"404.094326ms","remote":"127.0.0.1:49806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-22T05:12:44.286637Z","caller":"traceutil/trace.go:171","msg":"trace[669595626] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"190.221343ms","start":"2026-02-22T05:12:44.096387Z","end":"2026-02-22T05:12:44.286609Z","steps":["trace[669595626] 'process raft request' (duration: 190.066639ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:12:44.359433Z","caller":"traceutil/trace.go:171","msg":"trace[152983794] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1909; }","duration":"255.789055ms","start":"2026-02-22T05:12:44.103611Z","end":"2026-02-22T05:12:44.3594Z","steps":["trace[152983794] 'read index received' (duration: 182.833698ms)","trace[152983794] 'applied index is now lower than readState.Index' (duration: 72.953987ms)"],"step_count":2} {"level":"info","ts":"2026-02-22T05:12:44.359559Z","caller":"traceutil/trace.go:171","msg":"trace[1573761900] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"262.371389ms","start":"2026-02-22T05:12:44.097175Z","end":"2026-02-22T05:12:44.359546Z","steps":["trace[1573761900] 'process raft request' (duration: 224.83508ms)","trace[1573761900] 'compare' (duration: 37.317784ms)"],"step_count":2} {"level":"warn","ts":"2026-02-22T05:12:44.359857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.217135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-02-22T05:12:44.359903Z","caller":"traceutil/trace.go:171","msg":"trace[1195236386] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1832; }","duration":"256.334118ms","start":"2026-02-22T05:12:44.103558Z","end":"2026-02-22T05:12:44.359892Z","steps":["trace[1195236386] 'agreement among raft nodes before linearized reading' (duration: 256.164354ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:12:44.360253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.463682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-02-22T05:12:44.360329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.97851ms","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-22T05:12:44.360364Z","caller":"traceutil/trace.go:171","msg":"trace[1316811198] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1832; }","duration":"250.647497ms","start":"2026-02-22T05:12:44.10969Z","end":"2026-02-22T05:12:44.360337Z","steps":["trace[1316811198] 'agreement among raft nodes before linearized reading' (duration: 250.35164ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:12:44.360364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.116349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-22T05:12:44.360417Z","caller":"traceutil/trace.go:171","msg":"trace[1831511658] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1832; }","duration":"252.086722ms","start":"2026-02-22T05:12:44.10831Z","end":"2026-02-22T05:12:44.360397Z","steps":["trace[1831511658] 'agreement among raft nodes before linearized reading' (duration: 251.802255ms)"],"step_count":1} {"level":"info","ts":"2026-02-22T05:12:44.360478Z","caller":"traceutil/trace.go:171","msg":"trace[376586707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1832; }","duration":"253.250892ms","start":"2026-02-22T05:12:44.107206Z","end":"2026-02-22T05:12:44.360457Z","steps":["trace[376586707] 'agreement among raft nodes before linearized reading' (duration: 252.963465ms)"],"step_count":1} {"level":"warn","ts":"2026-02-22T05:12:44.360875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.258582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-22T05:12:44.361049Z","caller":"traceutil/trace.go:171","msg":"trace[1913624510] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1832; }","duration":"255.451496ms","start":"2026-02-22T05:12:44.105577Z","end":"2026-02-22T05:12:44.361028Z","steps":["trace[1913624510] 'agreement among raft nodes before linearized reading' (duration: 254.275946ms)"],"step_count":1}