{"level":"warn","ts":"2026-02-08T22:08:59.402861Z","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-08T22:08:59.403087Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.217: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.217:2380","--initial-cluster=instance=https://162.253.55.217:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.217:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.217: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-08T22:08:59.404548Z","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-08T22:08:59.404625Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.217:2380"]}
{"level":"info","ts":"2026-02-08T22:08:59.404701Z","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-08T22:08:59.405468Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"]}
{"level":"info","ts":"2026-02-08T22:08:59.405654Z","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.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.217: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-08T22:08:59.41396Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.180908ms"}
{"level":"info","ts":"2026-02-08T22:08:59.445624Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f1e368e6818bd6f7","cluster-id":"289e52865b7eaeb1"}
{"level":"info","ts":"2026-02-08T22:08:59.445862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-08T22:08:59.445949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 0"}
{"level":"info","ts":"2026-02-08T22:08:59.446058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f1e368e6818bd6f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-08T22:08:59.446147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became follower at term 1"}
{"level":"info","ts":"2026-02-08T22:08:59.446243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"}
{"level":"warn","ts":"2026-02-08T22:08:59.471048Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-08T22:08:59.473696Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-08T22:08:59.476072Z","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-08T22:08:59.506332Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f1e368e6818bd6f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-08T22:08:59.506662Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f1e368e6818bd6f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-08T22:08:59.508118Z","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-08T22:08:59.508161Z","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-08T22:08:59.508168Z","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-08T22:08:59.513671Z","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-08T22:08:59.51391Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f1e368e6818bd6f7","initial-advertise-peer-urls":["https://162.253.55.217:2380"],"listen-peer-urls":["https://162.253.55.217:2380"],"advertise-client-urls":["https://162.253.55.217:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.217:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-08T22:08:59.513977Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-08T22:08:59.5141Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.217:2380"}
{"level":"info","ts":"2026-02-08T22:08:59.514157Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.217:2380"}
{"level":"info","ts":"2026-02-08T22:09:00.350874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 switched to configuration voters=(17429890322079143671)"}
{"level":"info","ts":"2026-02-08T22:09:00.351063Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","added-peer-id":"f1e368e6818bd6f7","added-peer-peer-urls":["https://162.253.55.217:2380"]}
{"level":"info","ts":"2026-02-08T22:09:00.946854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-08T22:09:00.946928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-08T22:09:00.946972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgPreVoteResp from f1e368e6818bd6f7 at term 1"}
{"level":"info","ts":"2026-02-08T22:09:00.946989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became candidate at term 2"}
{"level":"info","ts":"2026-02-08T22:09:00.947003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 received MsgVoteResp from f1e368e6818bd6f7 at term 2"}
{"level":"info","ts":"2026-02-08T22:09:00.947017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f1e368e6818bd6f7 became leader at term 2"}
{"level":"info","ts":"2026-02-08T22:09:00.947033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f1e368e6818bd6f7 elected leader f1e368e6818bd6f7 at term 2"}
{"level":"info","ts":"2026-02-08T22:09:01.901717Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"warn","ts":"2026-02-08T22:09:01.902088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.415803ms","expected-duration":"100ms","prefix":"","request":"ID:15490021239053497858 Method:\"PUT\" Path:\"/0/members/f1e368e6818bd6f7/attributes\" Val:\"{\\\"name\\\":\\\"instance\\\",\\\"clientURLs\\\":[\\\"https://162.253.55.217:2379\\\"]}\" ","response":""}
{"level":"info","ts":"2026-02-08T22:09:01.902131Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f1e368e6818bd6f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.217:2379]}","request-path":"/0/members/f1e368e6818bd6f7/attributes","cluster-id":"289e52865b7eaeb1","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-08T22:09:01.902253Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-08T22:09:01.902545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-08T22:09:01.904248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.217:2379"}
{"level":"info","ts":"2026-02-08T22:09:01.90568Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-08T22:09:01.907254Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-08T22:09:01.907303Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-08T22:09:01.921701Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"289e52865b7eaeb1","local-member-id":"f1e368e6818bd6f7","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T22:09:01.923691Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-08T22:09:01.924585Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"warn","ts":"2026-02-08T22:09:13.727771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.439651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-mgrjb\" ","response":"range_response_count:1 size:4421"}
{"level":"info","ts":"2026-02-08T22:09:13.727845Z","caller":"traceutil/trace.go:171","msg":"trace[1212695864] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-mgrjb; range_end:; response_count:1; response_revision:405; }","duration":"141.553502ms","start":"2026-02-08T22:09:13.586275Z","end":"2026-02-08T22:09:13.727829Z","steps":["trace[1212695864] 'range keys from in-memory index tree'  (duration: 141.33591ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:16.671106Z","caller":"traceutil/trace.go:171","msg":"trace[480796982] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"142.626238ms","start":"2026-02-08T22:09:16.528458Z","end":"2026-02-08T22:09:16.671084Z","steps":["trace[480796982] 'process raft request'  (duration: 142.488766ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:17.028342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.647583ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15490021239053498773 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:378 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5035 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T22:09:17.028455Z","caller":"traceutil/trace.go:171","msg":"trace[234512975] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"346.843584ms","start":"2026-02-08T22:09:16.681599Z","end":"2026-02-08T22:09:17.028442Z","steps":["trace[234512975] 'process raft request'  (duration: 169.698586ms)","trace[234512975] 'compare'  (duration: 176.543792ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:17.028502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:16.68159Z","time spent":"346.893194ms","remote":"127.0.0.1:55724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5083,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:378 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:5035 >> failure:<request_range:<key:\"/registry/pods/kube-system/etcd-instance\" > >"}
{"level":"info","ts":"2026-02-08T22:09:25.971456Z","caller":"traceutil/trace.go:171","msg":"trace[566365372] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"122.163614ms","start":"2026-02-08T22:09:25.849261Z","end":"2026-02-08T22:09:25.971425Z","steps":["trace[566365372] 'process raft request'  (duration: 121.951112ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:27.281847Z","caller":"traceutil/trace.go:171","msg":"trace[1710761247] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"105.768931ms","start":"2026-02-08T22:09:27.176055Z","end":"2026-02-08T22:09:27.281824Z","steps":["trace[1710761247] 'process raft request'  (duration: 105.65086ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:31.921778Z","caller":"traceutil/trace.go:171","msg":"trace[1641869695] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"175.115216ms","start":"2026-02-08T22:09:31.746641Z","end":"2026-02-08T22:09:31.921756Z","steps":["trace[1641869695] 'read index received'  (duration: 174.882544ms)","trace[1641869695] 'applied index is now lower than readState.Index'  (duration: 231.842µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:31.922192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.52981ms","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-08T22:09:31.923106Z","caller":"traceutil/trace.go:171","msg":"trace[673550114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:519; }","duration":"176.489829ms","start":"2026-02-08T22:09:31.746605Z","end":"2026-02-08T22:09:31.923095Z","steps":["trace[673550114] 'agreement among raft nodes before linearized reading'  (duration: 175.50769ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:31.922728Z","caller":"traceutil/trace.go:171","msg":"trace[1056374308] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"195.812668ms","start":"2026-02-08T22:09:31.726899Z","end":"2026-02-08T22:09:31.922712Z","steps":["trace[1056374308] 'process raft request'  (duration: 194.682427ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:31.922842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.132289ms","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-08T22:09:31.927461Z","caller":"traceutil/trace.go:171","msg":"trace[826830276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:519; }","duration":"177.817731ms","start":"2026-02-08T22:09:31.74962Z","end":"2026-02-08T22:09:31.927438Z","steps":["trace[826830276] 'agreement among raft nodes before linearized reading'  (duration: 173.15585ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:37.704894Z","caller":"traceutil/trace.go:171","msg":"trace[1164142278] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"291.51453ms","start":"2026-02-08T22:09:37.413362Z","end":"2026-02-08T22:09:37.704877Z","steps":["trace[1164142278] 'process raft request'  (duration: 291.40891ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:38.17962Z","caller":"traceutil/trace.go:171","msg":"trace[526579805] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"190.359924ms","start":"2026-02-08T22:09:37.989236Z","end":"2026-02-08T22:09:38.179596Z","steps":["trace[526579805] 'read index received'  (duration: 190.188433ms)","trace[526579805] 'applied index is now lower than readState.Index'  (duration: 170.661µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:09:38.179954Z","caller":"traceutil/trace.go:171","msg":"trace[297575552] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"190.736417ms","start":"2026-02-08T22:09:37.989204Z","end":"2026-02-08T22:09:38.17994Z","steps":["trace[297575552] 'process raft request'  (duration: 190.270933ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:38.180216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.960469ms","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-08T22:09:38.180262Z","caller":"traceutil/trace.go:171","msg":"trace[1881697404] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:559; }","duration":"191.042159ms","start":"2026-02-08T22:09:37.989197Z","end":"2026-02-08T22:09:38.18024Z","steps":["trace[1881697404] 'agreement among raft nodes before linearized reading'  (duration: 190.913258ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:38.180431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.155631ms","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-08T22:09:38.180457Z","caller":"traceutil/trace.go:171","msg":"trace[748709339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:559; }","duration":"126.207681ms","start":"2026-02-08T22:09:38.054241Z","end":"2026-02-08T22:09:38.180449Z","steps":["trace[748709339] 'agreement among raft nodes before linearized reading'  (duration: 126.1332ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:38.402561Z","caller":"traceutil/trace.go:171","msg":"trace[1089773839] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"214.852598ms","start":"2026-02-08T22:09:38.187693Z","end":"2026-02-08T22:09:38.402545Z","steps":["trace[1089773839] 'process raft request'  (duration: 214.774828ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:38.419511Z","caller":"traceutil/trace.go:171","msg":"trace[636923367] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"224.058784ms","start":"2026-02-08T22:09:38.195433Z","end":"2026-02-08T22:09:38.419491Z","steps":["trace[636923367] 'read index received'  (duration: 207.342635ms)","trace[636923367] 'applied index is now lower than readState.Index'  (duration: 16.715559ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:38.419716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.266396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T22:09:38.41974Z","caller":"traceutil/trace.go:171","msg":"trace[1612298750] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"224.314946ms","start":"2026-02-08T22:09:38.195417Z","end":"2026-02-08T22:09:38.419731Z","steps":["trace[1612298750] 'agreement among raft nodes before linearized reading'  (duration: 224.244865ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:38.420016Z","caller":"traceutil/trace.go:171","msg":"trace[1757675803] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"232.159891ms","start":"2026-02-08T22:09:38.187846Z","end":"2026-02-08T22:09:38.420006Z","steps":["trace[1757675803] 'process raft request'  (duration: 231.564666ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:39.744115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091857296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7tf6x\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-08T22:09:39.744228Z","caller":"traceutil/trace.go:171","msg":"trace[2076677555] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7tf6x; range_end:; response_count:1; response_revision:561; }","duration":"1.091996027s","start":"2026-02-08T22:09:38.652215Z","end":"2026-02-08T22:09:39.744211Z","steps":["trace[2076677555] 'range keys from in-memory index tree'  (duration: 1.091775845s)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:39.744265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:38.652202Z","time spent":"1.092053068s","remote":"127.0.0.1:55724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-7tf6x\" "}
{"level":"warn","ts":"2026-02-08T22:09:39.744634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.36904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T22:09:39.744675Z","caller":"traceutil/trace.go:171","msg":"trace[928928685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"545.41043ms","start":"2026-02-08T22:09:39.199255Z","end":"2026-02-08T22:09:39.744665Z","steps":["trace[928928685] 'range keys from in-memory index tree'  (duration: 545.32724ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:39.744704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:39.199217Z","time spent":"545.47943ms","remote":"127.0.0.1:40650","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-08T22:09:39.98952Z","caller":"traceutil/trace.go:171","msg":"trace[172525459] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"236.389784ms","start":"2026-02-08T22:09:39.753098Z","end":"2026-02-08T22:09:39.989488Z","steps":["trace[172525459] 'process raft request'  (duration: 236.285523ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:40.013607Z","caller":"traceutil/trace.go:171","msg":"trace[1631289825] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"256.777203ms","start":"2026-02-08T22:09:39.756809Z","end":"2026-02-08T22:09:40.013586Z","steps":["trace[1631289825] 'process raft request'  (duration: 256.629152ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:42.185049Z","caller":"traceutil/trace.go:171","msg":"trace[1192608157] linearizableReadLoop","detail":"{readStateIndex:612; appliedIndex:611; }","duration":"191.022924ms","start":"2026-02-08T22:09:41.993995Z","end":"2026-02-08T22:09:42.185018Z","steps":["trace[1192608157] 'read index received'  (duration: 187.462196ms)","trace[1192608157] 'applied index is now lower than readState.Index'  (duration: 3.559868ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:42.185222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.211066ms","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-08T22:09:42.18525Z","caller":"traceutil/trace.go:171","msg":"trace[696155666] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"191.272206ms","start":"2026-02-08T22:09:41.993967Z","end":"2026-02-08T22:09:42.18524Z","steps":["trace[696155666] 'agreement among raft nodes before linearized reading'  (duration: 191.127585ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:42.185372Z","caller":"traceutil/trace.go:171","msg":"trace[3177050] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"313.606455ms","start":"2026-02-08T22:09:41.871759Z","end":"2026-02-08T22:09:42.185365Z","steps":["trace[3177050] 'process raft request'  (duration: 309.502222ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:42.185435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:41.871743Z","time spent":"313.644205ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:589 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:13124 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" > >"}
{"level":"info","ts":"2026-02-08T22:09:42.192112Z","caller":"traceutil/trace.go:171","msg":"trace[800305364] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"168.168738ms","start":"2026-02-08T22:09:42.02369Z","end":"2026-02-08T22:09:42.191858Z","steps":["trace[800305364] 'process raft request'  (duration: 167.846784ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:42.593918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.319906ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15490021239053499129 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:598 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:5070 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T22:09:42.594069Z","caller":"traceutil/trace.go:171","msg":"trace[2107736401] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"170.059452ms","start":"2026-02-08T22:09:42.423994Z","end":"2026-02-08T22:09:42.594054Z","steps":["trace[2107736401] 'process raft request'  (duration: 170.013322ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:42.59454Z","caller":"traceutil/trace.go:171","msg":"trace[1379869052] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"176.278623ms","start":"2026-02-08T22:09:42.418236Z","end":"2026-02-08T22:09:42.594514Z","steps":["trace[1379869052] 'read index received'  (duration: 11.291691ms)","trace[1379869052] 'applied index is now lower than readState.Index'  (duration: 164.984482ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:09:42.594628Z","caller":"traceutil/trace.go:171","msg":"trace[1104310499] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"332.986347ms","start":"2026-02-08T22:09:42.261634Z","end":"2026-02-08T22:09:42.59462Z","steps":["trace[1104310499] 'process raft request'  (duration: 167.887524ms)","trace[1104310499] 'compare'  (duration: 164.154835ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:42.594706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.261623Z","time spent":"333.022977ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:598 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:5070 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" > >"}
{"level":"warn","ts":"2026-02-08T22:09:42.594844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.793314ms","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-08T22:09:42.597785Z","caller":"traceutil/trace.go:171","msg":"trace[668156699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"161.838544ms","start":"2026-02-08T22:09:42.433024Z","end":"2026-02-08T22:09:42.594863Z","steps":["trace[668156699] 'agreement among raft nodes before linearized reading'  (duration: 161.750684ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:42.598257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.012714ms","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-08T22:09:42.598301Z","caller":"traceutil/trace.go:171","msg":"trace[602603608] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"180.085854ms","start":"2026-02-08T22:09:42.418206Z","end":"2026-02-08T22:09:42.598292Z","steps":["trace[602603608] 'agreement among raft nodes before linearized reading'  (duration: 179.957083ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:42.90566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.629791ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15490021239053499134 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:600 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:4065 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-08T22:09:42.90584Z","caller":"traceutil/trace.go:171","msg":"trace[331455840] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"301.607751ms","start":"2026-02-08T22:09:42.604217Z","end":"2026-02-08T22:09:42.905824Z","steps":["trace[331455840] 'process raft request'  (duration: 301.54589ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:42.905899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.604209Z","time spent":"301.662531ms","remote":"127.0.0.1:55804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:566 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-08T22:09:42.906216Z","caller":"traceutil/trace.go:171","msg":"trace[2122379674] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"303.427896ms","start":"2026-02-08T22:09:42.60277Z","end":"2026-02-08T22:09:42.906198Z","steps":["trace[2122379674] 'process raft request'  (duration: 129.19351ms)","trace[2122379674] 'compare'  (duration: 173.375049ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:42.906279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.602754Z","time spent":"303.491407ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:600 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:4065 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" > >"}
{"level":"info","ts":"2026-02-08T22:09:42.915458Z","caller":"traceutil/trace.go:171","msg":"trace[12611315] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:622; }","duration":"235.643046ms","start":"2026-02-08T22:09:42.679806Z","end":"2026-02-08T22:09:42.915449Z","steps":["trace[12611315] 'read index received'  (duration: 52.096013ms)","trace[12611315] 'applied index is now lower than readState.Index'  (duration: 183.546163ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:42.915569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.757906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7tf6x\" ","response":"range_response_count:1 size:17171"}
{"level":"info","ts":"2026-02-08T22:09:42.915587Z","caller":"traceutil/trace.go:171","msg":"trace[1043126203] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7tf6x; range_end:; response_count:1; response_revision:605; }","duration":"235.803487ms","start":"2026-02-08T22:09:42.679778Z","end":"2026-02-08T22:09:42.915582Z","steps":["trace[1043126203] 'agreement among raft nodes before linearized reading'  (duration: 235.706576ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:42.915735Z","caller":"traceutil/trace.go:171","msg":"trace[1880643345] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"286.077446ms","start":"2026-02-08T22:09:42.629651Z","end":"2026-02-08T22:09:42.915729Z","steps":["trace[1880643345] 'process raft request'  (duration: 285.720913ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:42.915825Z","caller":"traceutil/trace.go:171","msg":"trace[1321179004] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"235.277752ms","start":"2026-02-08T22:09:42.680542Z","end":"2026-02-08T22:09:42.91582Z","steps":["trace[1321179004] 'process raft request'  (duration: 234.882659ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:43.279835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.760747ms","expected-duration":"100ms","prefix":"","request":"header:<ID:15490021239053499138 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-08T22:09:43.279952Z","caller":"traceutil/trace.go:171","msg":"trace[730104999] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"369.858524ms","start":"2026-02-08T22:09:42.910082Z","end":"2026-02-08T22:09:43.279941Z","steps":["trace[730104999] 'process raft request'  (duration: 369.815593ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:43.279998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.910065Z","time spent":"369.908014ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4165,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" mod_revision:602 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" value_size:4074 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" > >"}
{"level":"info","ts":"2026-02-08T22:09:43.280186Z","caller":"traceutil/trace.go:171","msg":"trace[1115214305] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"456.376237ms","start":"2026-02-08T22:09:42.823802Z","end":"2026-02-08T22:09:43.280178Z","steps":["trace[1115214305] 'process raft request'  (duration: 236.231507ms)","trace[1115214305] 'compare'  (duration: 219.602826ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:43.280217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.823779Z","time spent":"456.422258ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"info","ts":"2026-02-08T22:09:43.283637Z","caller":"traceutil/trace.go:171","msg":"trace[965196105] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"258.823702ms","start":"2026-02-08T22:09:43.024803Z","end":"2026-02-08T22:09:43.283626Z","steps":["trace[965196105] 'process raft request'  (duration: 258.801962ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:43.283716Z","caller":"traceutil/trace.go:171","msg":"trace[766187944] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"356.441725ms","start":"2026-02-08T22:09:42.927267Z","end":"2026-02-08T22:09:43.283708Z","steps":["trace[766187944] 'process raft request'  (duration: 356.257193ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:43.286108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.92725Z","time spent":"358.822994ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:604 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:24132 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" > >"}
{"level":"info","ts":"2026-02-08T22:09:43.285897Z","caller":"traceutil/trace.go:171","msg":"trace[853021891] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"319.555465ms","start":"2026-02-08T22:09:42.966332Z","end":"2026-02-08T22:09:43.285887Z","steps":["trace[853021891] 'process raft request'  (duration: 317.240986ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:43.287252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:09:42.966313Z","time spent":"320.912416ms","remote":"127.0.0.1:55724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17400,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-7tf6x\" mod_revision:582 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-7tf6x\" value_size:17351 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-7tf6x\" > >"}
{"level":"info","ts":"2026-02-08T22:09:43.441445Z","caller":"traceutil/trace.go:171","msg":"trace[519895411] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"218.601748ms","start":"2026-02-08T22:09:43.222822Z","end":"2026-02-08T22:09:43.441423Z","steps":["trace[519895411] 'process raft request'  (duration: 163.31295ms)","trace[519895411] 'compare'  (duration: 54.648122ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:09:43.441599Z","caller":"traceutil/trace.go:171","msg":"trace[170935284] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"133.221328ms","start":"2026-02-08T22:09:43.308368Z","end":"2026-02-08T22:09:43.441589Z","steps":["trace[170935284] 'process raft request'  (duration: 132.681403ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:43.441698Z","caller":"traceutil/trace.go:171","msg":"trace[1736975410] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"133.223068ms","start":"2026-02-08T22:09:43.308467Z","end":"2026-02-08T22:09:43.44169Z","steps":["trace[1736975410] 'process raft request'  (duration: 132.659342ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:43.579719Z","caller":"traceutil/trace.go:171","msg":"trace[1835057857] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"128.884202ms","start":"2026-02-08T22:09:43.450824Z","end":"2026-02-08T22:09:43.579708Z","steps":["trace[1835057857] 'process raft request'  (duration: 128.704361ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:43.579896Z","caller":"traceutil/trace.go:171","msg":"trace[633729928] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"128.705081ms","start":"2026-02-08T22:09:43.450626Z","end":"2026-02-08T22:09:43.579332Z","steps":["trace[633729928] 'process raft request'  (duration: 116.963906ms)","trace[633729928] 'compare'  (duration: 11.638304ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:43.92179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.954467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-7tf6x\" ","response":"range_response_count:1 size:17415"}
{"level":"info","ts":"2026-02-08T22:09:43.921861Z","caller":"traceutil/trace.go:171","msg":"trace[1613152424] range","detail":"{range_begin:/registry/pods/kube-system/cilium-7tf6x; range_end:; response_count:1; response_revision:620; }","duration":"231.069378ms","start":"2026-02-08T22:09:43.690776Z","end":"2026-02-08T22:09:43.921845Z","steps":["trace[1613152424] 'range keys from in-memory index tree'  (duration: 230.854077ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:43.922063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.914019ms","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-08T22:09:43.922093Z","caller":"traceutil/trace.go:171","msg":"trace[367717253] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:620; }","duration":"213.969919ms","start":"2026-02-08T22:09:43.708113Z","end":"2026-02-08T22:09:43.922083Z","steps":["trace[367717253] 'range keys from in-memory index tree'  (duration: 213.822388ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:09:49.113847Z","caller":"traceutil/trace.go:171","msg":"trace[224222565] linearizableReadLoop","detail":"{readStateIndex:687; appliedIndex:686; }","duration":"102.860896ms","start":"2026-02-08T22:09:49.010969Z","end":"2026-02-08T22:09:49.11383Z","steps":["trace[224222565] 'read index received'  (duration: 86.72019ms)","trace[224222565] 'applied index is now lower than readState.Index'  (duration: 16.140166ms)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:09:49.114044Z","caller":"traceutil/trace.go:171","msg":"trace[1696677987] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"108.749393ms","start":"2026-02-08T22:09:49.005289Z","end":"2026-02-08T22:09:49.114038Z","steps":["trace[1696677987] 'process raft request'  (duration: 92.445775ms)","trace[1696677987] 'compare'  (duration: 16.015265ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-08T22:09:49.114234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.188748ms","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-08T22:09:49.114254Z","caller":"traceutil/trace.go:171","msg":"trace[1223290943] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:664; }","duration":"104.232298ms","start":"2026-02-08T22:09:49.010016Z","end":"2026-02-08T22:09:49.114249Z","steps":["trace[1223290943] 'agreement among raft nodes before linearized reading'  (duration: 104.140457ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:09:49.114332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.8234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:1 size:1889"}
{"level":"info","ts":"2026-02-08T22:09:49.114347Z","caller":"traceutil/trace.go:171","msg":"trace[1588273814] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:1; response_revision:664; }","duration":"101.85081ms","start":"2026-02-08T22:09:49.012492Z","end":"2026-02-08T22:09:49.114343Z","steps":["trace[1588273814] 'agreement among raft nodes before linearized reading'  (duration: 101.828399ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:10:05.276855Z","caller":"traceutil/trace.go:171","msg":"trace[1973695555] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"100.44948ms","start":"2026-02-08T22:10:05.176388Z","end":"2026-02-08T22:10:05.276837Z","steps":["trace[1973695555] 'process raft request'  (duration: 100.128908ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:10:23.481104Z","caller":"traceutil/trace.go:171","msg":"trace[73270959] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"124.366714ms","start":"2026-02-08T22:10:23.356687Z","end":"2026-02-08T22:10:23.481054Z","steps":["trace[73270959] 'process raft request'  (duration: 124.158767ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:11:00.784131Z","caller":"traceutil/trace.go:171","msg":"trace[1033743827] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"104.309121ms","start":"2026-02-08T22:11:00.679802Z","end":"2026-02-08T22:11:00.784111Z","steps":["trace[1033743827] 'read index received'  (duration: 104.073396ms)","trace[1033743827] 'applied index is now lower than readState.Index'  (duration: 234.905µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:11:00.784246Z","caller":"traceutil/trace.go:171","msg":"trace[2119833774] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"147.328908ms","start":"2026-02-08T22:11:00.636905Z","end":"2026-02-08T22:11:00.784234Z","steps":["trace[2119833774] 'process raft request'  (duration: 147.032531ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:11:00.784523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.70645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"}
{"level":"info","ts":"2026-02-08T22:11:00.784564Z","caller":"traceutil/trace.go:171","msg":"trace[1202006368] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:971; }","duration":"104.785381ms","start":"2026-02-08T22:11:00.679768Z","end":"2026-02-08T22:11:00.784553Z","steps":["trace[1202006368] 'agreement among raft nodes before linearized reading'  (duration: 104.656018ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:11:11.398685Z","caller":"traceutil/trace.go:171","msg":"trace[613014470] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"467.111129ms","start":"2026-02-08T22:11:10.931549Z","end":"2026-02-08T22:11:11.39866Z","steps":["trace[613014470] 'read index received'  (duration: 466.927485ms)","trace[613014470] 'applied index is now lower than readState.Index'  (duration: 182.584µs)"],"step_count":2}
{"level":"info","ts":"2026-02-08T22:11:11.398841Z","caller":"traceutil/trace.go:171","msg":"trace[746303273] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"515.81428ms","start":"2026-02-08T22:11:10.883005Z","end":"2026-02-08T22:11:11.39882Z","steps":["trace[746303273] 'process raft request'  (duration: 515.501994ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:11:11.399077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:11:10.882968Z","time spent":"515.907912ms","remote":"127.0.0.1:55804","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1003 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-08T22:11:11.399512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.079526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"warn","ts":"2026-02-08T22:11:11.399703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.153701ms","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-08T22:11:11.399752Z","caller":"traceutil/trace.go:171","msg":"trace[101680669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1010; }","duration":"468.240323ms","start":"2026-02-08T22:11:10.931499Z","end":"2026-02-08T22:11:11.399739Z","steps":["trace[101680669] 'agreement among raft nodes before linearized reading'  (duration: 468.11313ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:11:11.399783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-08T22:11:10.931487Z","time spent":"468.289073ms","remote":"127.0.0.1:55804","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-08T22:11:11.399724Z","caller":"traceutil/trace.go:171","msg":"trace[771625054] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1010; }","duration":"261.348822ms","start":"2026-02-08T22:11:11.138356Z","end":"2026-02-08T22:11:11.399704Z","steps":["trace[771625054] 'agreement among raft nodes before linearized reading'  (duration: 260.993535ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:11:11.403953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.297288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-08T22:11:11.404199Z","caller":"traceutil/trace.go:171","msg":"trace[897965234] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"204.583593ms","start":"2026-02-08T22:11:11.199601Z","end":"2026-02-08T22:11:11.404185Z","steps":["trace[897965234] 'agreement among raft nodes before linearized reading'  (duration: 204.285047ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:11:26.956836Z","caller":"traceutil/trace.go:171","msg":"trace[1959009097] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"159.904222ms","start":"2026-02-08T22:11:26.796923Z","end":"2026-02-08T22:11:26.956827Z","steps":["trace[1959009097] 'process raft request'  (duration: 159.679418ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-08T22:11:26.957501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.476842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-scheduler\" ","response":"range_response_count:1 size:1381"}
{"level":"info","ts":"2026-02-08T22:11:26.957532Z","caller":"traceutil/trace.go:171","msg":"trace[317807980] range","detail":"{range_begin:/registry/clusterroles/system:kube-scheduler; range_end:; response_count:1; response_revision:1058; }","duration":"130.547413ms","start":"2026-02-08T22:11:26.826977Z","end":"2026-02-08T22:11:26.957524Z","steps":["trace[317807980] 'agreement among raft nodes before linearized reading'  (duration: 130.484532ms)"],"step_count":1}
{"level":"info","ts":"2026-02-08T22:11:26.956707Z","caller":"traceutil/trace.go:171","msg":"trace[398872193] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"129.676998ms","start":"2026-02-08T22:11:26.827017Z","end":"2026-02-08T22:11:26.956694Z","steps":["trace[398872193] 'read index received'  (duration: 129.571426ms)","trace[398872193] 'applied index is now lower than readState.Index'  (duration: 104.942µs)"],"step_count":2}