{"level":"warn","ts":"2026-02-09T13:42:01.179886Z","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-09T13:42:01.180163Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-09T13:42:01.18023Z","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-09T13:42:01.180239Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-02-09T13:42:01.180258Z","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-09T13:42:01.181985Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-02-09T13:42:01.18211Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-09T13:42:01.188471Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.476393ms"} {"level":"info","ts":"2026-02-09T13:42:01.198734Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-02-09T13:42:01.198995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-02-09T13:42:01.199101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-02-09T13:42:01.19915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-09T13:42:01.199209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-02-09T13:42:01.199307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-02-09T13:42:01.218489Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-09T13:42:01.225196Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-09T13:42:01.230504Z","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-09T13:42:01.232794Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-09T13:42:01.233323Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-09T13:42:01.233781Z","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-09T13:42:01.233889Z","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-09T13:42:01.233932Z","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-09T13:42:01.236455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-02-09T13:42:01.236583Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-02-09T13:42:01.241173Z","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-09T13:42:01.241244Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-02-09T13:42:01.241446Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-02-09T13:42:01.24268Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-09T13:42:01.242779Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-09T13:42:01.401422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-02-09T13:42:01.401501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-02-09T13:42:01.401572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-02-09T13:42:01.401585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-02-09T13:42:01.401592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-02-09T13:42:01.4016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-02-09T13:42:01.401608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-02-09T13:42:01.403065Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-02-09T13:42:01.403192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T13:42:01.403499Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-09T13:42:01.403874Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T13:42:01.406298Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-09T13:42:01.407552Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-09T13:42:01.411459Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-09T13:42:01.411926Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T13:42:01.412072Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T13:42:01.412095Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-09T13:42:01.412553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-02-09T13:42:22.807458Z","caller":"traceutil/trace.go:171","msg":"trace[511473739] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"311.562231ms","start":"2026-02-09T13:42:22.495872Z","end":"2026-02-09T13:42:22.807434Z","steps":["trace[511473739] 'process raft request' (duration: 311.394517ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:22.80803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:22.49586Z","time spent":"311.684063ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:42:34.577917Z","caller":"traceutil/trace.go:171","msg":"trace[1897189287] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"168.906345ms","start":"2026-02-09T13:42:34.408995Z","end":"2026-02-09T13:42:34.577901Z","steps":["trace[1897189287] 'process raft request' (duration: 162.494593ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:42:34.961612Z","caller":"traceutil/trace.go:171","msg":"trace[516493915] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"103.195615ms","start":"2026-02-09T13:42:34.858402Z","end":"2026-02-09T13:42:34.961598Z","steps":["trace[516493915] 'process raft request' (duration: 103.110833ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:42:36.14046Z","caller":"traceutil/trace.go:171","msg":"trace[1955918072] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"191.796919ms","start":"2026-02-09T13:42:35.948648Z","end":"2026-02-09T13:42:36.140445Z","steps":["trace[1955918072] 'process raft request' (duration: 191.713178ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:38.756358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.394994ms","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-09T13:42:38.756416Z","caller":"traceutil/trace.go:171","msg":"trace[366228698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:525; }","duration":"305.517168ms","start":"2026-02-09T13:42:38.450886Z","end":"2026-02-09T13:42:38.756403Z","steps":["trace[366228698] 'range keys from in-memory index tree' (duration: 305.318263ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:38.756443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:38.450868Z","time spent":"305.569848ms","remote":"127.0.0.1:38276","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-09T13:42:38.756725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.910818ms","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-09T13:42:38.756745Z","caller":"traceutil/trace.go:171","msg":"trace[165785286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:525; }","duration":"150.957649ms","start":"2026-02-09T13:42:38.605781Z","end":"2026-02-09T13:42:38.756739Z","steps":["trace[165785286] 'range keys from in-memory index tree' (duration: 150.838956ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:39.162519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.556733ms","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-09T13:42:39.162578Z","caller":"traceutil/trace.go:171","msg":"trace[879075945] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:527; }","duration":"190.656875ms","start":"2026-02-09T13:42:38.97191Z","end":"2026-02-09T13:42:39.162567Z","steps":["trace[879075945] 'range keys from in-memory index tree' (duration: 190.46802ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:42:39.416683Z","caller":"traceutil/trace.go:171","msg":"trace[1007874790] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"250.991825ms","start":"2026-02-09T13:42:39.165673Z","end":"2026-02-09T13:42:39.416665Z","steps":["trace[1007874790] 'process raft request' (duration: 250.891513ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:42.159276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.18814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-09T13:42:42.159329Z","caller":"traceutil/trace.go:171","msg":"trace[1906591232] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:534; }","duration":"373.282802ms","start":"2026-02-09T13:42:41.786035Z","end":"2026-02-09T13:42:42.159318Z","steps":["trace[1906591232] 'range keys from in-memory index tree' (duration: 373.071668ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:42.159354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:41.786019Z","time spent":"373.330113ms","remote":"127.0.0.1:53748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-09T13:42:56.50918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.643698ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T13:42:56.509321Z","caller":"traceutil/trace.go:171","msg":"trace[1789975835] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:716; }","duration":"350.756965ms","start":"2026-02-09T13:42:56.158552Z","end":"2026-02-09T13:42:56.509309Z","steps":["trace[1789975835] 'read index received' (duration: 319.082157ms)","trace[1789975835] 'applied index is now lower than readState.Index' (duration: 31.674148ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:42:56.509382Z","caller":"traceutil/trace.go:171","msg":"trace[848583404] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"652.010788ms","start":"2026-02-09T13:42:55.857363Z","end":"2026-02-09T13:42:56.509374Z","steps":["trace[848583404] 'process raft request' (duration: 651.901875ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:42:56.509381Z","caller":"traceutil/trace.go:171","msg":"trace[1909669674] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"851.296243ms","start":"2026-02-09T13:42:55.658063Z","end":"2026-02-09T13:42:56.509359Z","steps":["trace[1909669674] 'process raft request' (duration: 390.308378ms)","trace[1909669674] 'compare' (duration: 460.498245ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:42:56.509419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:55.85734Z","time spent":"652.058899ms","remote":"127.0.0.1:53664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T13:42:56.509499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:55.658046Z","time spent":"851.393786ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T13:42:56.509588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.042051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:42:56.509615Z","caller":"traceutil/trace.go:171","msg":"trace[512488126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:697; }","duration":"351.259986ms","start":"2026-02-09T13:42:56.158348Z","end":"2026-02-09T13:42:56.509608Z","steps":["trace[512488126] 'agreement among raft nodes before linearized reading' (duration: 351.200225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:56.509652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:56.158334Z","time spent":"351.313907ms","remote":"127.0.0.1:53638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-09T13:42:56.509762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.712963ms","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-09T13:42:56.509787Z","caller":"traceutil/trace.go:171","msg":"trace[866586146] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:697; }","duration":"267.772435ms","start":"2026-02-09T13:42:56.242007Z","end":"2026-02-09T13:42:56.509779Z","steps":["trace[866586146] 'agreement among raft nodes before linearized reading' (duration: 267.684733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:56.509905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.392493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-5dd5756b68-px4fq\" ","response":"range_response_count:1 size:4999"} {"level":"info","ts":"2026-02-09T13:42:56.509922Z","caller":"traceutil/trace.go:171","msg":"trace[744134791] range","detail":"{range_begin:/registry/pods/kube-system/coredns-5dd5756b68-px4fq; range_end:; response_count:1; response_revision:697; }","duration":"226.449474ms","start":"2026-02-09T13:42:56.283468Z","end":"2026-02-09T13:42:56.509917Z","steps":["trace[744134791] 'agreement among raft nodes before linearized reading' (duration: 226.396942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.340962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.449408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T13:42:57.341021Z","caller":"traceutil/trace.go:171","msg":"trace[1580698266] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"820.514755ms","start":"2026-02-09T13:42:56.520497Z","end":"2026-02-09T13:42:57.341011Z","steps":["trace[1580698266] 'process raft request' (duration: 352.78149ms)","trace[1580698266] 'compare' (duration: 467.199023ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:42:57.341089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:56.520487Z","time spent":"820.565436ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:42:57.428211Z","caller":"traceutil/trace.go:171","msg":"trace[1823307353] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"901.674994ms","start":"2026-02-09T13:42:56.526519Z","end":"2026-02-09T13:42:57.428194Z","steps":["trace[1823307353] 'process raft request' (duration: 901.523351ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.428305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:56.526462Z","time spent":"901.794447ms","remote":"127.0.0.1:38192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4806,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:42:57.428867Z","caller":"traceutil/trace.go:171","msg":"trace[96029340] linearizableReadLoop","detail":"{readStateIndex:720; appliedIndex:720; }","duration":"428.749235ms","start":"2026-02-09T13:42:57.000095Z","end":"2026-02-09T13:42:57.428844Z","steps":["trace[96029340] 'read index received' (duration: 428.739275ms)","trace[96029340] 'applied index is now lower than readState.Index' (duration: 8.5µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:42:57.429066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.94972ms","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-09T13:42:57.429091Z","caller":"traceutil/trace.go:171","msg":"trace[195982976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:699; }","duration":"429.01534ms","start":"2026-02-09T13:42:57.000068Z","end":"2026-02-09T13:42:57.429084Z","steps":["trace[195982976] 'agreement among raft nodes before linearized reading' (duration: 428.876877ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.429115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:57.000055Z","time spent":"429.055122ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T13:42:57.430623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.622024ms","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-09T13:42:57.430652Z","caller":"traceutil/trace.go:171","msg":"trace[1755681649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:700; }","duration":"429.663164ms","start":"2026-02-09T13:42:57.000983Z","end":"2026-02-09T13:42:57.430646Z","steps":["trace[1755681649] 'agreement among raft nodes before linearized reading' (duration: 429.563882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.430669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:57.000978Z","time spent":"429.687556ms","remote":"127.0.0.1:38276","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":"info","ts":"2026-02-09T13:42:57.430748Z","caller":"traceutil/trace.go:171","msg":"trace[1588445312] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"130.681681ms","start":"2026-02-09T13:42:57.300062Z","end":"2026-02-09T13:42:57.430744Z","steps":["trace[1588445312] 'process raft request' (duration: 130.447406ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.430823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.195641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:42:57.430841Z","caller":"traceutil/trace.go:171","msg":"trace[579443697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:700; }","duration":"271.230081ms","start":"2026-02-09T13:42:57.159601Z","end":"2026-02-09T13:42:57.430831Z","steps":["trace[579443697] 'agreement among raft nodes before linearized reading' (duration: 271.208451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.430927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.555312ms","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-09T13:42:57.43094Z","caller":"traceutil/trace.go:171","msg":"trace[2087912770] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:700; }","duration":"341.587983ms","start":"2026-02-09T13:42:57.089348Z","end":"2026-02-09T13:42:57.430936Z","steps":["trace[2087912770] 'agreement among raft nodes before linearized reading' (duration: 341.551122ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:42:57.430951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:42:57.089327Z","time spent":"341.621574ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-09T13:43:03.969955Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600032829797882,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-09T13:43:04.131597Z","caller":"traceutil/trace.go:171","msg":"trace[1678260782] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:748; }","duration":"661.946337ms","start":"2026-02-09T13:43:03.469623Z","end":"2026-02-09T13:43:04.131569Z","steps":["trace[1678260782] 'read index received' (duration: 661.834585ms)","trace[1678260782] 'applied index is now lower than readState.Index' (duration: 111.012µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:04.131671Z","caller":"traceutil/trace.go:171","msg":"trace[201808266] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"769.176282ms","start":"2026-02-09T13:43:03.362491Z","end":"2026-02-09T13:43:04.131667Z","steps":["trace[201808266] 'process raft request' (duration: 768.978138ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:04.13177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:03.362479Z","time spent":"769.206743ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T13:43:04.131892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.465187ms","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-09T13:43:04.131915Z","caller":"traceutil/trace.go:171","msg":"trace[1072305637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:727; }","duration":"661.497937ms","start":"2026-02-09T13:43:03.47041Z","end":"2026-02-09T13:43:04.131908Z","steps":["trace[1072305637] 'agreement among raft nodes before linearized reading' (duration: 661.399665ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:04.131943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:03.470405Z","time spent":"661.534148ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-09T13:43:04.132006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.388607ms","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-09T13:43:04.132017Z","caller":"traceutil/trace.go:171","msg":"trace[795575921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:727; }","duration":"662.423018ms","start":"2026-02-09T13:43:03.46959Z","end":"2026-02-09T13:43:04.132013Z","steps":["trace[795575921] 'agreement among raft nodes before linearized reading' (duration: 662.388387ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:04.132037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:03.469562Z","time spent":"662.463159ms","remote":"127.0.0.1:38276","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-09T13:43:04.132079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.717579ms","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-09T13:43:04.132096Z","caller":"traceutil/trace.go:171","msg":"trace[1104511257] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:727; }","duration":"484.76015ms","start":"2026-02-09T13:43:03.647331Z","end":"2026-02-09T13:43:04.132092Z","steps":["trace[1104511257] 'agreement among raft nodes before linearized reading' (duration: 484.714979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:04.132111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:03.647318Z","time spent":"484.790031ms","remote":"127.0.0.1:38276","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-09T13:43:04.132146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.635224ms","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-09T13:43:04.132174Z","caller":"traceutil/trace.go:171","msg":"trace[2070552424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:727; }","duration":"658.659005ms","start":"2026-02-09T13:43:03.473497Z","end":"2026-02-09T13:43:04.132156Z","steps":["trace[2070552424] 'agreement among raft nodes before linearized reading' (duration: 658.611604ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:04.132187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:03.473492Z","time spent":"658.691585ms","remote":"127.0.0.1:38276","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":"info","ts":"2026-02-09T13:43:04.321113Z","caller":"traceutil/trace.go:171","msg":"trace[1756828734] linearizableReadLoop","detail":"{readStateIndex:753; appliedIndex:750; }","duration":"165.06144ms","start":"2026-02-09T13:43:04.156031Z","end":"2026-02-09T13:43:04.321092Z","steps":["trace[1756828734] 'read index received' (duration: 22.989676ms)","trace[1756828734] 'applied index is now lower than readState.Index' (duration: 142.070654ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:04.321246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.196943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:43:04.321275Z","caller":"traceutil/trace.go:171","msg":"trace[1924929303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:731; }","duration":"165.260235ms","start":"2026-02-09T13:43:04.156006Z","end":"2026-02-09T13:43:04.321266Z","steps":["trace[1924929303] 'agreement among raft nodes before linearized reading' (duration: 165.185473ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:04.32154Z","caller":"traceutil/trace.go:171","msg":"trace[2100053240] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"183.544567ms","start":"2026-02-09T13:43:04.137984Z","end":"2026-02-09T13:43:04.321529Z","steps":["trace[2100053240] 'process raft request' (duration: 134.182508ms)","trace[2100053240] 'compare' (duration: 48.542972ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:04.321651Z","caller":"traceutil/trace.go:171","msg":"trace[509633683] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"183.135468ms","start":"2026-02-09T13:43:04.138508Z","end":"2026-02-09T13:43:04.321643Z","steps":["trace[509633683] 'process raft request' (duration: 182.443583ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:04.321748Z","caller":"traceutil/trace.go:171","msg":"trace[1191631174] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"182.038195ms","start":"2026-02-09T13:43:04.139703Z","end":"2026-02-09T13:43:04.321741Z","steps":["trace[1191631174] 'process raft request' (duration: 181.35321ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:08.355936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.532293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T13:43:08.356366Z","caller":"traceutil/trace.go:171","msg":"trace[1520849690] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"165.257314ms","start":"2026-02-09T13:43:08.191087Z","end":"2026-02-09T13:43:08.356345Z","steps":["trace[1520849690] 'process raft request' (duration: 32.256472ms)","trace[1520849690] 'compare' (duration: 132.46511ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:10.403448Z","caller":"traceutil/trace.go:171","msg":"trace[1142755419] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"224.643814ms","start":"2026-02-09T13:43:10.178791Z","end":"2026-02-09T13:43:10.403435Z","steps":["trace[1142755419] 'process raft request' (duration: 224.568283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:23.099713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.431338ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-09T13:43:23.09986Z","caller":"traceutil/trace.go:171","msg":"trace[1792195204] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"506.888046ms","start":"2026-02-09T13:43:22.592962Z","end":"2026-02-09T13:43:23.09985Z","steps":["trace[1792195204] 'process raft request' (duration: 506.816355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:23.099894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:22.592952Z","time spent":"506.926927ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:23.100263Z","caller":"traceutil/trace.go:171","msg":"trace[842151518] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"575.43064ms","start":"2026-02-09T13:43:22.524826Z","end":"2026-02-09T13:43:23.100257Z","steps":["trace[842151518] 'process raft request' (duration: 436.408379ms)","trace[842151518] 'compare' (duration: 138.326336ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:23.100298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:22.524815Z","time spent":"575.467971ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:23.10047Z","caller":"traceutil/trace.go:171","msg":"trace[384245056] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"511.10711ms","start":"2026-02-09T13:43:22.589357Z","end":"2026-02-09T13:43:23.100464Z","steps":["trace[384245056] 'read index received' (duration: 371.884313ms)","trace[384245056] 'applied index is now lower than readState.Index' (duration: 139.222097ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:23.100671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.074805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:43:23.100692Z","caller":"traceutil/trace.go:171","msg":"trace[2132800146] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:786; }","duration":"519.122705ms","start":"2026-02-09T13:43:22.581564Z","end":"2026-02-09T13:43:23.100686Z","steps":["trace[2132800146] 'agreement among raft nodes before linearized reading' (duration: 519.085595ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:23.100818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:22.581548Z","time spent":"519.170516ms","remote":"127.0.0.1:38148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-02-09T13:43:23.101012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.318776ms","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-09T13:43:23.101034Z","caller":"traceutil/trace.go:171","msg":"trace[258325418] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:786; }","duration":"574.354207ms","start":"2026-02-09T13:43:22.526672Z","end":"2026-02-09T13:43:23.101026Z","steps":["trace[258325418] 'agreement among raft nodes before linearized reading' (duration: 574.285195ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:23.101048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:22.526664Z","time spent":"574.380638ms","remote":"127.0.0.1:38276","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-09T13:43:23.101203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.410544ms","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-09T13:43:23.101221Z","caller":"traceutil/trace.go:171","msg":"trace[26173656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"577.445845ms","start":"2026-02-09T13:43:22.523771Z","end":"2026-02-09T13:43:23.101217Z","steps":["trace[26173656] 'agreement among raft nodes before linearized reading' (duration: 577.399144ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:23.101347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:22.523759Z","time spent":"577.471935ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-09T13:43:35.503563Z","caller":"traceutil/trace.go:171","msg":"trace[107924260] transaction","detail":"{read_only:false; response_revision:869; number_of_response:1; }","duration":"272.232645ms","start":"2026-02-09T13:43:35.231311Z","end":"2026-02-09T13:43:35.503544Z","steps":["trace[107924260] 'process raft request' (duration: 271.99244ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:35.50492Z","caller":"traceutil/trace.go:171","msg":"trace[1175760276] linearizableReadLoop","detail":"{readStateIndex:901; appliedIndex:899; }","duration":"268.882441ms","start":"2026-02-09T13:43:35.236026Z","end":"2026-02-09T13:43:35.504909Z","steps":["trace[1175760276] 'read index received' (duration: 267.216514ms)","trace[1175760276] 'applied index is now lower than readState.Index' (duration: 1.665527ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:35.50557Z","caller":"traceutil/trace.go:171","msg":"trace[548263764] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"272.935821ms","start":"2026-02-09T13:43:35.232624Z","end":"2026-02-09T13:43:35.50556Z","steps":["trace[548263764] 'process raft request' (duration: 272.244537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:35.505707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.666459ms","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-09T13:43:35.505728Z","caller":"traceutil/trace.go:171","msg":"trace[2088241474] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:870; }","duration":"269.71254ms","start":"2026-02-09T13:43:35.236009Z","end":"2026-02-09T13:43:35.505722Z","steps":["trace[2088241474] 'agreement among raft nodes before linearized reading' (duration: 269.623968ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:35.505807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.863786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T13:43:35.505822Z","caller":"traceutil/trace.go:171","msg":"trace[1922387049] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:870; }","duration":"260.896976ms","start":"2026-02-09T13:43:35.24492Z","end":"2026-02-09T13:43:35.505817Z","steps":["trace[1922387049] 'agreement among raft nodes before linearized reading' (duration: 260.852945ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:37.24088Z","caller":"traceutil/trace.go:171","msg":"trace[719773998] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"541.263491ms","start":"2026-02-09T13:43:36.699602Z","end":"2026-02-09T13:43:37.240866Z","steps":["trace[719773998] 'process raft request' (duration: 540.886353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:37.240955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:36.699591Z","time spent":"541.324372ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T13:43:38.019478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9997600032829798254,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-09T13:43:38.04853Z","caller":"traceutil/trace.go:171","msg":"trace[177284715] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:906; }","duration":"529.844021ms","start":"2026-02-09T13:43:37.51867Z","end":"2026-02-09T13:43:38.048514Z","steps":["trace[177284715] 'read index received' (duration: 529.718927ms)","trace[177284715] 'applied index is now lower than readState.Index' (duration: 124.254µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:38.048611Z","caller":"traceutil/trace.go:171","msg":"trace[1557728113] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"720.029564ms","start":"2026-02-09T13:43:37.328576Z","end":"2026-02-09T13:43:38.048605Z","steps":["trace[1557728113] 'process raft request' (duration: 719.834689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:38.048678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:37.328561Z","time spent":"720.066295ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-09T13:43:38.04885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.137807ms","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-09T13:43:38.048892Z","caller":"traceutil/trace.go:171","msg":"trace[769801074] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:875; }","duration":"530.193499ms","start":"2026-02-09T13:43:37.518688Z","end":"2026-02-09T13:43:38.048881Z","steps":["trace[769801074] 'agreement among raft nodes before linearized reading' (duration: 530.079376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:38.048916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:37.518685Z","time spent":"530.225139ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-09T13:43:38.049017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.342383ms","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-09T13:43:38.049049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.344221ms","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-09T13:43:38.049069Z","caller":"traceutil/trace.go:171","msg":"trace[716123171] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:875; }","duration":"530.464384ms","start":"2026-02-09T13:43:37.518598Z","end":"2026-02-09T13:43:38.049063Z","steps":["trace[716123171] 'agreement among raft nodes before linearized reading' (duration: 530.416503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:38.049081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:37.518585Z","time spent":"530.493465ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-09T13:43:38.049093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.423723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T13:43:38.049112Z","caller":"traceutil/trace.go:171","msg":"trace[1283115849] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:875; }","duration":"530.451633ms","start":"2026-02-09T13:43:37.518653Z","end":"2026-02-09T13:43:38.049104Z","steps":["trace[1283115849] 'agreement among raft nodes before linearized reading' (duration: 530.408483ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:38.049127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:37.51865Z","time spent":"530.473924ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-09T13:43:38.049051Z","caller":"traceutil/trace.go:171","msg":"trace[1661031192] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:875; }","duration":"526.375664ms","start":"2026-02-09T13:43:37.522658Z","end":"2026-02-09T13:43:38.049033Z","steps":["trace[1661031192] 'agreement among raft nodes before linearized reading' (duration: 526.291982ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:38.049175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:37.522653Z","time spent":"526.518807ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-02-09T13:43:46.291773Z","caller":"traceutil/trace.go:171","msg":"trace[1705431569] linearizableReadLoop","detail":"{readStateIndex:932; appliedIndex:931; }","duration":"143.52175ms","start":"2026-02-09T13:43:46.148237Z","end":"2026-02-09T13:43:46.291758Z","steps":["trace[1705431569] 'read index received' (duration: 143.401357ms)","trace[1705431569] 'applied index is now lower than readState.Index' (duration: 119.853µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:46.292005Z","caller":"traceutil/trace.go:171","msg":"trace[45014435] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"183.453686ms","start":"2026-02-09T13:43:46.108545Z","end":"2026-02-09T13:43:46.291999Z","steps":["trace[45014435] 'process raft request' (duration: 183.134029ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:46.292129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.908347ms","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-09T13:43:46.292173Z","caller":"traceutil/trace.go:171","msg":"trace[293479325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:898; }","duration":"137.971699ms","start":"2026-02-09T13:43:46.15419Z","end":"2026-02-09T13:43:46.292162Z","steps":["trace[293479325] 'agreement among raft nodes before linearized reading' (duration: 137.842646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:46.292207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.965849ms","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-09T13:43:46.292226Z","caller":"traceutil/trace.go:171","msg":"trace[1012294297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:898; }","duration":"144.021111ms","start":"2026-02-09T13:43:46.1482Z","end":"2026-02-09T13:43:46.292221Z","steps":["trace[1012294297] 'agreement among raft nodes before linearized reading' (duration: 143.943279ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:46.29229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.686652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T13:43:46.2923Z","caller":"traceutil/trace.go:171","msg":"trace[877961270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:898; }","duration":"137.705523ms","start":"2026-02-09T13:43:46.154591Z","end":"2026-02-09T13:43:46.292297Z","steps":["trace[877961270] 'agreement among raft nodes before linearized reading' (duration: 137.670622ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:48.524241Z","caller":"traceutil/trace.go:171","msg":"trace[987321791] linearizableReadLoop","detail":"{readStateIndex:938; appliedIndex:937; }","duration":"202.394502ms","start":"2026-02-09T13:43:48.321832Z","end":"2026-02-09T13:43:48.524226Z","steps":["trace[987321791] 'read index received' (duration: 202.283429ms)","trace[987321791] 'applied index is now lower than readState.Index' (duration: 110.363µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:48.524518Z","caller":"traceutil/trace.go:171","msg":"trace[1684266832] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"226.607604ms","start":"2026-02-09T13:43:48.297905Z","end":"2026-02-09T13:43:48.524513Z","steps":["trace[1684266832] 'process raft request' (duration: 226.213036ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:48.524898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.965825ms","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-09T13:43:48.524959Z","caller":"traceutil/trace.go:171","msg":"trace[1398932500] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:904; }","duration":"203.058796ms","start":"2026-02-09T13:43:48.321883Z","end":"2026-02-09T13:43:48.524942Z","steps":["trace[1398932500] 'agreement among raft nodes before linearized reading' (duration: 202.901783ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:48.525205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.853612ms","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-09T13:43:48.525235Z","caller":"traceutil/trace.go:171","msg":"trace[969571157] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:904; }","duration":"202.891733ms","start":"2026-02-09T13:43:48.322335Z","end":"2026-02-09T13:43:48.525226Z","steps":["trace[969571157] 'agreement among raft nodes before linearized reading' (duration: 202.75169ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:48.526354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.508808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-09T13:43:48.526398Z","caller":"traceutil/trace.go:171","msg":"trace[689741831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:904; }","duration":"204.578441ms","start":"2026-02-09T13:43:48.321812Z","end":"2026-02-09T13:43:48.526391Z","steps":["trace[689741831] 'agreement among raft nodes before linearized reading' (duration: 202.785921ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:48.661452Z","caller":"traceutil/trace.go:171","msg":"trace[1407078070] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"132.793455ms","start":"2026-02-09T13:43:48.528642Z","end":"2026-02-09T13:43:48.661435Z","steps":["trace[1407078070] 'process raft request' (duration: 127.072089ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:48.682428Z","caller":"traceutil/trace.go:171","msg":"trace[771274094] transaction","detail":"{read_only:false; response_revision:906; number_of_response:1; }","duration":"150.755479ms","start":"2026-02-09T13:43:48.531656Z","end":"2026-02-09T13:43:48.682412Z","steps":["trace[771274094] 'process raft request' (duration: 150.626936ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:48.682578Z","caller":"traceutil/trace.go:171","msg":"trace[1129998829] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"148.087551ms","start":"2026-02-09T13:43:48.534475Z","end":"2026-02-09T13:43:48.682563Z","steps":["trace[1129998829] 'process raft request' (duration: 147.913346ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:49.673347Z","caller":"traceutil/trace.go:171","msg":"trace[1484294966] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"339.287607ms","start":"2026-02-09T13:43:49.334034Z","end":"2026-02-09T13:43:49.673321Z","steps":["trace[1484294966] 'process raft request' (duration: 339.068662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:49.67352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:49.334025Z","time spent":"339.41488ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:50.027572Z","caller":"traceutil/trace.go:171","msg":"trace[1888417562] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"304.015023ms","start":"2026-02-09T13:43:49.723538Z","end":"2026-02-09T13:43:50.027553Z","steps":["trace[1888417562] 'process raft request' (duration: 294.059344ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:50.027667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:49.723517Z","time spent":"304.099726ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:50.813252Z","caller":"traceutil/trace.go:171","msg":"trace[1343573467] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:943; }","duration":"165.094833ms","start":"2026-02-09T13:43:50.648142Z","end":"2026-02-09T13:43:50.813236Z","steps":["trace[1343573467] 'read index received' (duration: 164.988651ms)","trace[1343573467] 'applied index is now lower than readState.Index' (duration: 105.542µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:50.813345Z","caller":"traceutil/trace.go:171","msg":"trace[907983782] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"268.569454ms","start":"2026-02-09T13:43:50.54477Z","end":"2026-02-09T13:43:50.813339Z","steps":["trace[907983782] 'process raft request' (duration: 268.374449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:50.813464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.45649ms","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-09T13:43:50.813506Z","caller":"traceutil/trace.go:171","msg":"trace[1879213584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:910; }","duration":"149.519692ms","start":"2026-02-09T13:43:50.663976Z","end":"2026-02-09T13:43:50.813495Z","steps":["trace[1879213584] 'agreement among raft nodes before linearized reading' (duration: 149.406029ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:50.813589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.55677ms","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-09T13:43:50.813612Z","caller":"traceutil/trace.go:171","msg":"trace[1360100852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:910; }","duration":"127.5919ms","start":"2026-02-09T13:43:50.686013Z","end":"2026-02-09T13:43:50.813604Z","steps":["trace[1360100852] 'agreement among raft nodes before linearized reading' (duration: 127.503728ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:50.813633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.138803ms","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-09T13:43:50.813647Z","caller":"traceutil/trace.go:171","msg":"trace[1732607681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:910; }","duration":"128.163593ms","start":"2026-02-09T13:43:50.685479Z","end":"2026-02-09T13:43:50.813643Z","steps":["trace[1732607681] 'agreement among raft nodes before linearized reading' (duration: 128.125182ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:50.813687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.541983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:43:50.8137Z","caller":"traceutil/trace.go:171","msg":"trace[851205598] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:910; }","duration":"165.581654ms","start":"2026-02-09T13:43:50.648115Z","end":"2026-02-09T13:43:50.813696Z","steps":["trace[851205598] 'agreement among raft nodes before linearized reading' (duration: 165.557334ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:55.102056Z","caller":"traceutil/trace.go:171","msg":"trace[624546186] linearizableReadLoop","detail":"{readStateIndex:963; appliedIndex:962; }","duration":"225.359167ms","start":"2026-02-09T13:43:54.876682Z","end":"2026-02-09T13:43:55.102041Z","steps":["trace[624546186] 'read index received' (duration: 225.244574ms)","trace[624546186] 'applied index is now lower than readState.Index' (duration: 113.843µs)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:43:55.102135Z","caller":"traceutil/trace.go:171","msg":"trace[583056716] transaction","detail":"{read_only:false; response_revision:928; number_of_response:1; }","duration":"276.579062ms","start":"2026-02-09T13:43:54.82555Z","end":"2026-02-09T13:43:55.102129Z","steps":["trace[583056716] 'process raft request' (duration: 276.376267ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.102284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.587221ms","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-09T13:43:55.102301Z","caller":"traceutil/trace.go:171","msg":"trace[1228864782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:928; }","duration":"225.650493ms","start":"2026-02-09T13:43:54.876645Z","end":"2026-02-09T13:43:55.102296Z","steps":["trace[1228864782] 'agreement among raft nodes before linearized reading' (duration: 225.564251ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.102381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.79907ms","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-09T13:43:55.102413Z","caller":"traceutil/trace.go:171","msg":"trace[992418372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:928; }","duration":"206.858171ms","start":"2026-02-09T13:43:54.895551Z","end":"2026-02-09T13:43:55.102409Z","steps":["trace[992418372] 'agreement among raft nodes before linearized reading' (duration: 206.793339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.102494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.350289ms","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-09T13:43:55.102506Z","caller":"traceutil/trace.go:171","msg":"trace[765768231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:928; }","duration":"206.37184ms","start":"2026-02-09T13:43:54.89613Z","end":"2026-02-09T13:43:55.102502Z","steps":["trace[765768231] 'agreement among raft nodes before linearized reading' (duration: 206.317029ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:43:55.552243Z","caller":"traceutil/trace.go:171","msg":"trace[1505264184] transaction","detail":"{read_only:false; response_revision:929; number_of_response:1; }","duration":"445.324484ms","start":"2026-02-09T13:43:55.106903Z","end":"2026-02-09T13:43:55.552227Z","steps":["trace[1505264184] 'process raft request' (duration: 426.221015ms)","trace[1505264184] 'compare' (duration: 18.542177ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:55.552354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:55.106884Z","time spent":"445.425607ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:55.5688Z","caller":"traceutil/trace.go:171","msg":"trace[354496274] linearizableReadLoop","detail":"{readStateIndex:966; appliedIndex:963; }","duration":"382.240811ms","start":"2026-02-09T13:43:55.186543Z","end":"2026-02-09T13:43:55.568784Z","steps":["trace[354496274] 'read index received' (duration: 346.589738ms)","trace[354496274] 'applied index is now lower than readState.Index' (duration: 35.650193ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:55.568984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.413425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-09T13:43:55.569003Z","caller":"traceutil/trace.go:171","msg":"trace[2074206771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:931; }","duration":"382.480906ms","start":"2026-02-09T13:43:55.186516Z","end":"2026-02-09T13:43:55.568997Z","steps":["trace[2074206771] 'agreement among raft nodes before linearized reading' (duration: 382.337283ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.569022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:55.186503Z","time spent":"382.515316ms","remote":"127.0.0.1:53638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-09T13:43:55.569201Z","caller":"traceutil/trace.go:171","msg":"trace[17960571] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"462.157925ms","start":"2026-02-09T13:43:55.10703Z","end":"2026-02-09T13:43:55.569188Z","steps":["trace[17960571] 'process raft request' (duration: 461.654744ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.569251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:55.107025Z","time spent":"462.188515ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:55.569311Z","caller":"traceutil/trace.go:171","msg":"trace[123065335] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"462.249666ms","start":"2026-02-09T13:43:55.107057Z","end":"2026-02-09T13:43:55.569306Z","steps":["trace[123065335] 'process raft request' (duration: 461.705235ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:55.569335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:55.107054Z","time spent":"462.267457ms","remote":"127.0.0.1:38276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-09T13:43:55.949503Z","caller":"traceutil/trace.go:171","msg":"trace[838414619] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"173.11611ms","start":"2026-02-09T13:43:55.776352Z","end":"2026-02-09T13:43:55.949468Z","steps":["trace[838414619] 'process raft request' (duration: 105.352021ms)","trace[838414619] 'compare' (duration: 67.347119ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:43:56.962683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.05058ms","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-09T13:43:56.962772Z","caller":"traceutil/trace.go:171","msg":"trace[1434969769] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:933; }","duration":"477.188444ms","start":"2026-02-09T13:43:56.485563Z","end":"2026-02-09T13:43:56.962752Z","steps":["trace[1434969769] 'count revisions from in-memory index tree' (duration: 476.985849ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:43:56.962808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-09T13:43:56.485548Z","time spent":"477.252045ms","remote":"127.0.0.1:38442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-02-09T13:44:03.813005Z","caller":"traceutil/trace.go:171","msg":"trace[1437739767] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"103.638134ms","start":"2026-02-09T13:44:03.709349Z","end":"2026-02-09T13:44:03.812987Z","steps":["trace[1437739767] 'process raft request' (duration: 99.952563ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:44:09.423009Z","caller":"traceutil/trace.go:171","msg":"trace[885240197] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"217.724079ms","start":"2026-02-09T13:44:09.20526Z","end":"2026-02-09T13:44:09.422985Z","steps":["trace[885240197] 'process raft request' (duration: 217.565026ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:44:09.94449Z","caller":"traceutil/trace.go:171","msg":"trace[220134476] linearizableReadLoop","detail":"{readStateIndex:1042; appliedIndex:1042; }","duration":"125.297299ms","start":"2026-02-09T13:44:09.819176Z","end":"2026-02-09T13:44:09.944473Z","steps":["trace[220134476] 'read index received' (duration: 125.292079ms)","trace[220134476] 'applied index is now lower than readState.Index' (duration: 4.33µs)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:44:09.944657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.477073ms","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-09T13:44:09.944677Z","caller":"traceutil/trace.go:171","msg":"trace[1064009122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1004; }","duration":"125.535874ms","start":"2026-02-09T13:44:09.819134Z","end":"2026-02-09T13:44:09.94467Z","steps":["trace[1064009122] 'agreement among raft nodes before linearized reading' (duration: 125.417072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:44:09.944859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.014226ms","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-09T13:44:09.944874Z","caller":"traceutil/trace.go:171","msg":"trace[949325202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1004; }","duration":"111.051476ms","start":"2026-02-09T13:44:09.833819Z","end":"2026-02-09T13:44:09.94487Z","steps":["trace[949325202] 'agreement among raft nodes before linearized reading' (duration: 111.011236ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:44:09.945187Z","caller":"traceutil/trace.go:171","msg":"trace[411935609] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"135.184158ms","start":"2026-02-09T13:44:09.809994Z","end":"2026-02-09T13:44:09.945178Z","steps":["trace[411935609] 'process raft request' (duration: 134.309238ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:45:12.678612Z","caller":"traceutil/trace.go:171","msg":"trace[1867709659] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"124.686026ms","start":"2026-02-09T13:45:12.553902Z","end":"2026-02-09T13:45:12.678588Z","steps":["trace[1867709659] 'process raft request' (duration: 110.426242ms)","trace[1867709659] 'compare' (duration: 14.166522ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:45:24.954446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.923803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T13:45:24.954533Z","caller":"traceutil/trace.go:171","msg":"trace[241260151] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1329; }","duration":"162.020286ms","start":"2026-02-09T13:45:24.792491Z","end":"2026-02-09T13:45:24.954511Z","steps":["trace[241260151] 'count revisions from in-memory index tree' (duration: 161.850451ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:45:26.844825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.751556ms","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-09T13:45:26.845976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.467568ms","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-09T13:45:26.847978Z","caller":"traceutil/trace.go:171","msg":"trace[1823823589] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1336; }","duration":"248.329338ms","start":"2026-02-09T13:45:26.596986Z","end":"2026-02-09T13:45:26.845315Z","steps":["trace[1823823589] 'range keys from in-memory index tree' (duration: 247.549751ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:45:26.847989Z","caller":"traceutil/trace.go:171","msg":"trace[2095920944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1336; }","duration":"113.630282ms","start":"2026-02-09T13:45:26.732427Z","end":"2026-02-09T13:45:26.846057Z","steps":["trace[2095920944] 'range keys from in-memory index tree' (duration: 113.322445ms)"],"step_count":1} {"level":"warn","ts":"2026-02-09T13:45:26.848568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.859094ms","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-09T13:45:26.848624Z","caller":"traceutil/trace.go:171","msg":"trace[135215770] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1336; }","duration":"154.978698ms","start":"2026-02-09T13:45:26.693633Z","end":"2026-02-09T13:45:26.848611Z","steps":["trace[135215770] 'range keys from in-memory index tree' (duration: 154.701021ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:46:05.408452Z","caller":"traceutil/trace.go:171","msg":"trace[1984532292] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"152.473869ms","start":"2026-02-09T13:46:05.255961Z","end":"2026-02-09T13:46:05.408435Z","steps":["trace[1984532292] 'process raft request' (duration: 152.324066ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:46:15.825477Z","caller":"traceutil/trace.go:171","msg":"trace[1116059547] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"107.117384ms","start":"2026-02-09T13:46:15.718332Z","end":"2026-02-09T13:46:15.82545Z","steps":["trace[1116059547] 'process raft request' (duration: 107.069392ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:46:15.825526Z","caller":"traceutil/trace.go:171","msg":"trace[518808521] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"135.864675ms","start":"2026-02-09T13:46:15.689645Z","end":"2026-02-09T13:46:15.825509Z","steps":["trace[518808521] 'process raft request' (duration: 68.788047ms)","trace[518808521] 'compare' (duration: 66.861093ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:46:15.82575Z","caller":"traceutil/trace.go:171","msg":"trace[371848265] linearizableReadLoop","detail":"{readStateIndex:1599; appliedIndex:1598; }","duration":"132.662721ms","start":"2026-02-09T13:46:15.693076Z","end":"2026-02-09T13:46:15.825739Z","steps":["trace[371848265] 'read index received' (duration: 24.852661ms)","trace[371848265] 'applied index is now lower than readState.Index' (duration: 107.80875ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:46:15.825904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.807785ms","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-09T13:46:15.825934Z","caller":"traceutil/trace.go:171","msg":"trace[46357868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1536; }","duration":"132.873156ms","start":"2026-02-09T13:46:15.693052Z","end":"2026-02-09T13:46:15.825925Z","steps":["trace[46357868] 'agreement among raft nodes before linearized reading' (duration: 132.724953ms)"],"step_count":1} {"level":"info","ts":"2026-02-09T13:47:34.119362Z","caller":"traceutil/trace.go:171","msg":"trace[990608730] linearizableReadLoop","detail":"{readStateIndex:1964; appliedIndex:1963; }","duration":"138.521395ms","start":"2026-02-09T13:47:33.980823Z","end":"2026-02-09T13:47:34.119344Z","steps":["trace[990608730] 'read index received' (duration: 99.885153ms)","trace[990608730] 'applied index is now lower than readState.Index' (duration: 38.635282ms)"],"step_count":2} {"level":"info","ts":"2026-02-09T13:47:34.119462Z","caller":"traceutil/trace.go:171","msg":"trace[1749394656] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"168.37364ms","start":"2026-02-09T13:47:33.951075Z","end":"2026-02-09T13:47:34.119449Z","steps":["trace[1749394656] 'process raft request' (duration: 129.649695ms)","trace[1749394656] 'compare' (duration: 38.343426ms)"],"step_count":2} {"level":"warn","ts":"2026-02-09T13:47:34.119737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.880774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-09T13:47:34.119798Z","caller":"traceutil/trace.go:171","msg":"trace[1180739727] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1884; }","duration":"138.976826ms","start":"2026-02-09T13:47:33.980799Z","end":"2026-02-09T13:47:34.119776Z","steps":["trace[1180739727] 'agreement among raft nodes before linearized reading' (duration: 138.883054ms)"],"step_count":1}