{"level":"warn","ts":"2026-02-25T14:59:22.87346Z","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-25T14:59:22.873616Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-25T14:59:22.873871Z","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-25T14:59:22.873896Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]}
{"level":"info","ts":"2026-02-25T14:59:22.873931Z","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-25T14:59:22.874947Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]}
{"level":"info","ts":"2026-02-25T14:59:22.87516Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-25T14:59:22.880068Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.532793ms"}
{"level":"info","ts":"2026-02-25T14:59:22.889506Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"}
{"level":"info","ts":"2026-02-25T14:59:22.889629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"}
{"level":"info","ts":"2026-02-25T14:59:22.889658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"}
{"level":"info","ts":"2026-02-25T14:59:22.889672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-25T14:59:22.889704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"}
{"level":"info","ts":"2026-02-25T14:59:22.889797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"}
{"level":"warn","ts":"2026-02-25T14:59:22.89699Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-25T14:59:22.898777Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-25T14:59:22.900364Z","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-25T14:59:22.90332Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-25T14:59:22.903514Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-25T14:59:22.90376Z","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-25T14:59:22.903849Z","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-25T14:59:22.903862Z","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-25T14:59:22.904614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"}
{"level":"info","ts":"2026-02-25T14:59:22.905071Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]}
{"level":"info","ts":"2026-02-25T14:59:22.909567Z","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-25T14:59:22.909724Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"}
{"level":"info","ts":"2026-02-25T14:59:22.909805Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"}
{"level":"info","ts":"2026-02-25T14:59:22.90995Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-25T14:59:22.910026Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-25T14:59:23.390882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"}
{"level":"info","ts":"2026-02-25T14:59:23.391007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-25T14:59:23.391034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"}
{"level":"info","ts":"2026-02-25T14:59:23.391056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"}
{"level":"info","ts":"2026-02-25T14:59:23.391067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"}
{"level":"info","ts":"2026-02-25T14:59:23.391085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"}
{"level":"info","ts":"2026-02-25T14:59:23.3911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"}
{"level":"info","ts":"2026-02-25T14:59:23.392356Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-25T14:59:23.392527Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:59:23.392627Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T14:59:23.392672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-25T14:59:23.392833Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-25T14:59:23.3929Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-25T14:59:23.393887Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:59:23.394039Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:59:23.394097Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-25T14:59:23.39458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-25T14:59:23.406546Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"}
{"level":"info","ts":"2026-02-25T14:59:26.324763Z","caller":"traceutil/trace.go:171","msg":"trace[1639211421] transaction","detail":"{read_only:false; response_revision:181; number_of_response:1; }","duration":"139.131283ms","start":"2026-02-25T14:59:26.185597Z","end":"2026-02-25T14:59:26.324729Z","steps":["trace[1639211421] 'process raft request'  (duration: 43.911021ms)","trace[1639211421] 'compare'  (duration: 95.07933ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:26.667641Z","caller":"traceutil/trace.go:171","msg":"trace[381825722] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"185.03465ms","start":"2026-02-25T14:59:26.482572Z","end":"2026-02-25T14:59:26.667606Z","steps":["trace[381825722] 'process raft request'  (duration: 97.460077ms)","trace[381825722] 'compare'  (duration: 87.429051ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:27.013599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.021331ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178783 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" value_size:676 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:27.013795Z","caller":"traceutil/trace.go:171","msg":"trace[1283514876] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:214; }","duration":"252.516506ms","start":"2026-02-25T14:59:26.76126Z","end":"2026-02-25T14:59:27.013777Z","steps":["trace[1283514876] 'read index received'  (duration: 33.746772ms)","trace[1283514876] 'applied index is now lower than readState.Index'  (duration: 218.768524ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:27.014282Z","caller":"traceutil/trace.go:171","msg":"trace[489193292] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"264.964256ms","start":"2026-02-25T14:59:26.749304Z","end":"2026-02-25T14:59:27.014268Z","steps":["trace[489193292] 'process raft request'  (duration: 45.68819ms)","trace[489193292] 'compare'  (duration: 217.879709ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:27.014641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.326733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:27.014724Z","caller":"traceutil/trace.go:171","msg":"trace[1541360330] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:210; }","duration":"253.481767ms","start":"2026-02-25T14:59:26.761222Z","end":"2026-02-25T14:59:27.014704Z","steps":["trace[1541360330] 'agreement among raft nodes before linearized reading'  (duration: 253.216174ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:27.041773Z","caller":"traceutil/trace.go:171","msg":"trace[474075923] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"279.37994ms","start":"2026-02-25T14:59:26.762367Z","end":"2026-02-25T14:59:27.041746Z","steps":["trace[474075923] 'process raft request'  (duration: 279.198925ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.041835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.648211ms","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-25T14:59:27.041905Z","caller":"traceutil/trace.go:171","msg":"trace[153316875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:211; }","duration":"262.75081ms","start":"2026-02-25T14:59:26.779137Z","end":"2026-02-25T14:59:27.041888Z","steps":["trace[153316875] 'agreement among raft nodes before linearized reading'  (duration: 262.591547ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.041911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.793613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T14:59:27.041968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.528326ms","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-25T14:59:27.042088Z","caller":"traceutil/trace.go:171","msg":"trace[1294600836] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:211; }","duration":"202.040734ms","start":"2026-02-25T14:59:26.839989Z","end":"2026-02-25T14:59:27.04203Z","steps":["trace[1294600836] 'agreement among raft nodes before linearized reading'  (duration: 201.725138ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:27.042172Z","caller":"traceutil/trace.go:171","msg":"trace[1976612105] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:211; }","duration":"280.850643ms","start":"2026-02-25T14:59:26.761279Z","end":"2026-02-25T14:59:27.04213Z","steps":["trace[1976612105] 'agreement among raft nodes before linearized reading'  (duration: 280.496744ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.042329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.411425ms","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-25T14:59:27.042458Z","caller":"traceutil/trace.go:171","msg":"trace[1713356791] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:211; }","duration":"263.57531ms","start":"2026-02-25T14:59:26.778855Z","end":"2026-02-25T14:59:27.04243Z","steps":["trace[1713356791] 'agreement among raft nodes before linearized reading'  (duration: 263.053486ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.356147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.464319ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178788 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" value_size:667 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:27.356546Z","caller":"traceutil/trace.go:171","msg":"trace[768583057] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"310.339275ms","start":"2026-02-25T14:59:27.04617Z","end":"2026-02-25T14:59:27.356509Z","steps":["trace[768583057] 'process raft request'  (duration: 202.45216ms)","trace[768583057] 'compare'  (duration: 107.341908ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:27.356619Z","caller":"traceutil/trace.go:171","msg":"trace[1556879057] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"309.193859ms","start":"2026-02-25T14:59:27.04741Z","end":"2026-02-25T14:59:27.356604Z","steps":["trace[1556879057] 'process raft request'  (duration: 309.106171ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.356718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.046152Z","time spent":"310.498649ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":744,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pod-garbage-collector\" value_size:667 >> failure:<>"}
{"level":"info","ts":"2026-02-25T14:59:27.35675Z","caller":"traceutil/trace.go:171","msg":"trace[998379651] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"310.525251ms","start":"2026-02-25T14:59:27.046195Z","end":"2026-02-25T14:59:27.356721Z","steps":["trace[998379651] 'process raft request'  (duration: 310.05683ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.356845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.047401Z","time spent":"309.260365ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:47 > 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":"warn","ts":"2026-02-25T14:59:27.356857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.046186Z","time spent":"310.611598ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:209 > 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":"info","ts":"2026-02-25T14:59:27.356892Z","caller":"traceutil/trace.go:171","msg":"trace[1925983995] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"309.55898ms","start":"2026-02-25T14:59:27.047295Z","end":"2026-02-25T14:59:27.356854Z","steps":["trace[1925983995] 'process raft request'  (duration: 309.014073ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:27.357127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.047288Z","time spent":"309.723664ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:45 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T14:59:27.787519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.7999ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178795 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:replication-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:replication-controller\" value_size:670 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:27.787734Z","caller":"traceutil/trace.go:171","msg":"trace[643394861] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"411.683318ms","start":"2026-02-25T14:59:27.376025Z","end":"2026-02-25T14:59:27.787708Z","steps":["trace[643394861] 'process raft request'  (duration: 144.598694ms)","trace[643394861] 'compare'  (duration: 266.592043ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:27.787818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.375993Z","time spent":"411.794068ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":748,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:replication-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:replication-controller\" value_size:670 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:28.279553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.660648ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178799 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:route-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:route-controller\" value_size:652 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:28.279691Z","caller":"traceutil/trace.go:171","msg":"trace[1654908911] linearizableReadLoop","detail":"{readStateIndex:224; appliedIndex:223; }","duration":"323.399013ms","start":"2026-02-25T14:59:27.956269Z","end":"2026-02-25T14:59:28.279668Z","steps":["trace[1654908911] 'read index received'  (duration: 11.490965ms)","trace[1654908911] 'applied index is now lower than readState.Index'  (duration: 311.906328ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:28.279745Z","caller":"traceutil/trace.go:171","msg":"trace[1892720407] transaction","detail":"{read_only:false; response_revision:219; number_of_response:1; }","duration":"462.626098ms","start":"2026-02-25T14:59:27.817081Z","end":"2026-02-25T14:59:28.279707Z","steps":["trace[1892720407] 'process raft request'  (duration: 150.72841ms)","trace[1892720407] 'compare'  (duration: 311.496684ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:28.279925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.638733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T14:59:28.279948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.817055Z","time spent":"462.796402ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:route-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:route-controller\" value_size:652 >> failure:<>"}
{"level":"info","ts":"2026-02-25T14:59:28.279998Z","caller":"traceutil/trace.go:171","msg":"trace[886467821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:219; }","duration":"323.741512ms","start":"2026-02-25T14:59:27.956243Z","end":"2026-02-25T14:59:28.279984Z","steps":["trace[886467821] 'agreement among raft nodes before linearized reading'  (duration: 323.60301ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:28.280041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.956232Z","time spent":"323.803707ms","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T14:59:28.280153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.692917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:28.280205Z","caller":"traceutil/trace.go:171","msg":"trace[1173382110] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:219; }","duration":"323.763843ms","start":"2026-02-25T14:59:27.956429Z","end":"2026-02-25T14:59:28.280193Z","steps":["trace[1173382110] 'agreement among raft nodes before linearized reading'  (duration: 323.564637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:28.280317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:27.956422Z","time spent":"323.881194ms","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T14:59:28.434202Z","caller":"traceutil/trace.go:171","msg":"trace[14598036] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"136.182469ms","start":"2026-02-25T14:59:28.297993Z","end":"2026-02-25T14:59:28.434175Z","steps":["trace[14598036] 'process raft request'  (duration: 122.503657ms)","trace[14598036] 'compare'  (duration: 13.505518ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:29.028685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.182411ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178811 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:certificate-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:certificate-controller\" value_size:670 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:29.02907Z","caller":"traceutil/trace.go:171","msg":"trace[1437228800] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"496.772398ms","start":"2026-02-25T14:59:28.532277Z","end":"2026-02-25T14:59:29.02905Z","steps":["trace[1437228800] 'process raft request'  (duration: 44.098734ms)","trace[1437228800] 'compare'  (duration: 451.981304ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:29.029139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:28.532257Z","time spent":"496.854295ms","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":748,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:certificate-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:certificate-controller\" value_size:670 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:29.540471Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678178813,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:30.041629Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678178813,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:30.043865Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009047022s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T14:59:30.088176Z","caller":"traceutil/trace.go:171","msg":"trace[1214903237] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:229; }","duration":"1.048319425s","start":"2026-02-25T14:59:29.0398Z","end":"2026-02-25T14:59:30.08812Z","steps":["trace[1214903237] 'read index received'  (duration: 1.004343606s)","trace[1214903237] 'applied index is now lower than readState.Index'  (duration: 43.974199ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:30.08862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.399702ms","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-25T14:59:30.088714Z","caller":"traceutil/trace.go:171","msg":"trace[724943860] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:225; }","duration":"727.559335ms","start":"2026-02-25T14:59:29.361138Z","end":"2026-02-25T14:59:30.088698Z","steps":["trace[724943860] 'agreement among raft nodes before linearized reading'  (duration: 727.341197ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:30.088719Z","caller":"traceutil/trace.go:171","msg":"trace[1192832181] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"1.054099912s","start":"2026-02-25T14:59:29.034598Z","end":"2026-02-25T14:59:30.088698Z","steps":["trace[1192832181] 'process raft request'  (duration: 1.009559795s)","trace[1192832181] 'compare'  (duration: 43.248657ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:30.088743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.361119Z","time spent":"727.618241ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T14:59:30.088902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.058513ms","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-25T14:59:30.088916Z","caller":"traceutil/trace.go:171","msg":"trace[296020650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:225; }","duration":"727.107307ms","start":"2026-02-25T14:59:29.361804Z","end":"2026-02-25T14:59:30.088912Z","steps":["trace[296020650] 'agreement among raft nodes before linearized reading'  (duration: 727.075675ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:30.088644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.341194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T14:59:30.08894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.361793Z","time spent":"727.13386ms","remote":"127.0.0.1:36104","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-25T14:59:30.088853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.034587Z","time spent":"1.05418518s","remote":"127.0.0.1:36216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":760,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" value_size:679 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:30.088976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049133854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:30.089008Z","caller":"traceutil/trace.go:171","msg":"trace[113470852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:225; }","duration":"587.737578ms","start":"2026-02-25T14:59:29.501227Z","end":"2026-02-25T14:59:30.088965Z","steps":["trace[113470852] 'agreement among raft nodes before linearized reading'  (duration: 587.323363ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:30.089052Z","caller":"traceutil/trace.go:171","msg":"trace[736649350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:225; }","duration":"1.049255695s","start":"2026-02-25T14:59:29.039777Z","end":"2026-02-25T14:59:30.089033Z","steps":["trace[736649350] 'agreement among raft nodes before linearized reading'  (duration: 1.049106662s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:30.089041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.211336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-02-25T14:59:30.089096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.039767Z","time spent":"1.049319339s","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-25T14:59:30.089101Z","caller":"traceutil/trace.go:171","msg":"trace[1446289363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:225; }","duration":"727.295243ms","start":"2026-02-25T14:59:29.361788Z","end":"2026-02-25T14:59:30.089083Z","steps":["trace[1446289363] 'agreement among raft nodes before linearized reading'  (duration: 727.166612ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:30.089134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.361774Z","time spent":"727.353287ms","remote":"127.0.0.1:36104","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":"warn","ts":"2026-02-25T14:59:30.08913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:29.501209Z","time spent":"587.88001ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T14:59:32.409578Z","caller":"traceutil/trace.go:171","msg":"trace[1699856591] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"125.704728ms","start":"2026-02-25T14:59:32.283854Z","end":"2026-02-25T14:59:32.409559Z","steps":["trace[1699856591] 'process raft request'  (duration: 77.941952ms)","trace[1699856591] 'compare'  (duration: 47.417267ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:32.632707Z","caller":"traceutil/trace.go:171","msg":"trace[344157228] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"135.425917ms","start":"2026-02-25T14:59:32.497251Z","end":"2026-02-25T14:59:32.632677Z","steps":["trace[344157228] 'read index received'  (duration: 131.085216ms)","trace[344157228] 'applied index is now lower than readState.Index'  (duration: 4.339541ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:32.632764Z","caller":"traceutil/trace.go:171","msg":"trace[1978721093] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"137.147654ms","start":"2026-02-25T14:59:32.495594Z","end":"2026-02-25T14:59:32.632741Z","steps":["trace[1978721093] 'process raft request'  (duration: 132.730537ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.632929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.645226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-02-25T14:59:32.632975Z","caller":"traceutil/trace.go:171","msg":"trace[1188791718] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:303; }","duration":"135.742745ms","start":"2026-02-25T14:59:32.497222Z","end":"2026-02-25T14:59:32.632965Z","steps":["trace[1188791718] 'agreement among raft nodes before linearized reading'  (duration: 135.601423ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.635945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.445398ms","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-25T14:59:32.636027Z","caller":"traceutil/trace.go:171","msg":"trace[1841427993] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:304; }","duration":"103.581039ms","start":"2026-02-25T14:59:32.532428Z","end":"2026-02-25T14:59:32.636009Z","steps":["trace[1841427993] 'agreement among raft nodes before linearized reading'  (duration: 103.428656ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.636044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.865329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:32.635948Z","caller":"traceutil/trace.go:171","msg":"trace[145034415] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"123.110246ms","start":"2026-02-25T14:59:32.512802Z","end":"2026-02-25T14:59:32.635912Z","steps":["trace[145034415] 'process raft request'  (duration: 122.946992ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.636108Z","caller":"traceutil/trace.go:171","msg":"trace[290495320] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:304; }","duration":"102.948955ms","start":"2026-02-25T14:59:32.533146Z","end":"2026-02-25T14:59:32.636095Z","steps":["trace[290495320] 'agreement among raft nodes before linearized reading'  (duration: 102.835756ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.872214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.207908ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678178997 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.1897855399ad1dae\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.1897855399ad1dae\" value_size:557 lease:2398338966678178543 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:32.872336Z","caller":"traceutil/trace.go:171","msg":"trace[1383046163] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"235.090663ms","start":"2026-02-25T14:59:32.637221Z","end":"2026-02-25T14:59:32.872312Z","steps":["trace[1383046163] 'read index received'  (duration: 129.741383ms)","trace[1383046163] 'applied index is now lower than readState.Index'  (duration: 105.34801ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:32.872451Z","caller":"traceutil/trace.go:171","msg":"trace[1621969720] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"236.155944ms","start":"2026-02-25T14:59:32.636282Z","end":"2026-02-25T14:59:32.872438Z","steps":["trace[1621969720] 'process raft request'  (duration: 130.661111ms)","trace[1621969720] 'compare'  (duration: 105.069397ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:32.872686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.433922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"}
{"level":"info","ts":"2026-02-25T14:59:32.872785Z","caller":"traceutil/trace.go:171","msg":"trace[692839727] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:305; }","duration":"235.570664ms","start":"2026-02-25T14:59:32.637194Z","end":"2026-02-25T14:59:32.872765Z","steps":["trace[692839727] 'agreement among raft nodes before linearized reading'  (duration: 235.315802ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.898341Z","caller":"traceutil/trace.go:171","msg":"trace[1201616089] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"259.204251ms","start":"2026-02-25T14:59:32.639116Z","end":"2026-02-25T14:59:32.89832Z","steps":["trace[1201616089] 'process raft request'  (duration: 258.855172ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.898711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.477134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3707"}
{"level":"info","ts":"2026-02-25T14:59:32.898775Z","caller":"traceutil/trace.go:171","msg":"trace[567460541] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"232.032432ms","start":"2026-02-25T14:59:32.666721Z","end":"2026-02-25T14:59:32.898753Z","steps":["trace[567460541] 'process raft request'  (duration: 231.558832ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.89877Z","caller":"traceutil/trace.go:171","msg":"trace[1393211670] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"233.478446ms","start":"2026-02-25T14:59:32.665281Z","end":"2026-02-25T14:59:32.898759Z","steps":["trace[1393211670] 'process raft request'  (duration: 232.886165ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.898782Z","caller":"traceutil/trace.go:171","msg":"trace[1175258215] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"233.704856ms","start":"2026-02-25T14:59:32.665054Z","end":"2026-02-25T14:59:32.898759Z","steps":["trace[1175258215] 'process raft request'  (duration: 233.04884ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.899Z","caller":"traceutil/trace.go:171","msg":"trace[170121027] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"193.207678ms","start":"2026-02-25T14:59:32.705783Z","end":"2026-02-25T14:59:32.89899Z","steps":["trace[170121027] 'process raft request'  (duration: 192.570174ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.899061Z","caller":"traceutil/trace.go:171","msg":"trace[123897622] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:308; }","duration":"259.644369ms","start":"2026-02-25T14:59:32.639157Z","end":"2026-02-25T14:59:32.898801Z","steps":["trace[123897622] 'agreement among raft nodes before linearized reading'  (duration: 259.228154ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.899023Z","caller":"traceutil/trace.go:171","msg":"trace[339763504] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"231.112714ms","start":"2026-02-25T14:59:32.6679Z","end":"2026-02-25T14:59:32.899012Z","steps":["trace[339763504] 'process raft request'  (duration: 230.422196ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:32.899182Z","caller":"traceutil/trace.go:171","msg":"trace[1204050369] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"233.367546ms","start":"2026-02-25T14:59:32.665804Z","end":"2026-02-25T14:59:32.899172Z","steps":["trace[1204050369] 'process raft request'  (duration: 232.399244ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:32.899297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.372345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"}
{"level":"info","ts":"2026-02-25T14:59:32.899343Z","caller":"traceutil/trace.go:171","msg":"trace[1238560916] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:308; }","duration":"257.444121ms","start":"2026-02-25T14:59:32.641888Z","end":"2026-02-25T14:59:32.899332Z","steps":["trace[1238560916] 'agreement among raft nodes before linearized reading'  (duration: 257.360284ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.304431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.864652ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179010 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.18978553a5b37c7b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18978553a5b37c7b\" value_size:570 lease:2398338966678178543 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:33.304604Z","caller":"traceutil/trace.go:171","msg":"trace[1753600175] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"378.614459ms","start":"2026-02-25T14:59:32.925973Z","end":"2026-02-25T14:59:33.304587Z","steps":["trace[1753600175] 'process raft request'  (duration: 378.559064ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.304662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.925956Z","time spent":"378.681094ms","remote":"127.0.0.1:36022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1196,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/specs/kube-system/kube-dns\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/kube-system/kube-dns\" value_size:1143 >> failure:<>"}
{"level":"info","ts":"2026-02-25T14:59:33.304912Z","caller":"traceutil/trace.go:171","msg":"trace[2010899911] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"390.393755ms","start":"2026-02-25T14:59:32.914473Z","end":"2026-02-25T14:59:33.304867Z","steps":["trace[2010899911] 'process raft request'  (duration: 133.987417ms)","trace[2010899911] 'compare'  (duration: 255.711768ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:33.304962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.914458Z","time spent":"390.482122ms","remote":"127.0.0.1:35894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18978553a5b37c7b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18978553a5b37c7b\" value_size:570 lease:2398338966678178543 >> failure:<>"}
{"level":"info","ts":"2026-02-25T14:59:33.305077Z","caller":"traceutil/trace.go:171","msg":"trace[488006932] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:321; }","duration":"380.442485ms","start":"2026-02-25T14:59:32.924626Z","end":"2026-02-25T14:59:33.305068Z","steps":["trace[488006932] 'read index received'  (duration: 123.830309ms)","trace[488006932] 'applied index is now lower than readState.Index'  (duration: 256.611076ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:33.30517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.920989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3707"}
{"level":"info","ts":"2026-02-25T14:59:33.305195Z","caller":"traceutil/trace.go:171","msg":"trace[31663609] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:313; }","duration":"403.979043ms","start":"2026-02-25T14:59:32.901208Z","end":"2026-02-25T14:59:33.305187Z","steps":["trace[31663609] 'agreement among raft nodes before linearized reading'  (duration: 403.891976ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.305222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.901197Z","time spent":"404.018676ms","remote":"127.0.0.1:35996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3729,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:33.305495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.388534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:33.305527Z","caller":"traceutil/trace.go:171","msg":"trace[201998542] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:313; }","duration":"403.434327ms","start":"2026-02-25T14:59:32.902083Z","end":"2026-02-25T14:59:33.305517Z","steps":["trace[201998542] 'agreement among raft nodes before linearized reading'  (duration: 403.384753ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.305553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.902077Z","time spent":"403.46993ms","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:33.305693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.722922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4597"}
{"level":"info","ts":"2026-02-25T14:59:33.305718Z","caller":"traceutil/trace.go:171","msg":"trace[2048270863] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:313; }","duration":"403.766866ms","start":"2026-02-25T14:59:32.901944Z","end":"2026-02-25T14:59:33.305711Z","steps":["trace[2048270863] 'agreement among raft nodes before linearized reading'  (duration: 403.715821ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.305742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.901935Z","time spent":"403.801958ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4619,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:33.305903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.40958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"}
{"level":"info","ts":"2026-02-25T14:59:33.306218Z","caller":"traceutil/trace.go:171","msg":"trace[694120390] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:313; }","duration":"404.909063ms","start":"2026-02-25T14:59:32.901291Z","end":"2026-02-25T14:59:33.306201Z","steps":["trace[694120390] 'agreement among raft nodes before linearized reading'  (duration: 404.498127ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:33.30626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:32.901269Z","time spent":"404.983269ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6920,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:33.523078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.158333ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179015 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/kube-system/kube-proxy\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-system/kube-proxy\" value_size:1883 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:33.523198Z","caller":"traceutil/trace.go:171","msg":"trace[1882023918] linearizableReadLoop","detail":"{readStateIndex:325; appliedIndex:324; }","duration":"204.375574ms","start":"2026-02-25T14:59:33.318803Z","end":"2026-02-25T14:59:33.523178Z","steps":["trace[1882023918] 'read index received'  (duration: 103.992151ms)","trace[1882023918] 'applied index is now lower than readState.Index'  (duration: 100.381953ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:33.523236Z","caller":"traceutil/trace.go:171","msg":"trace[1840849229] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"208.085632ms","start":"2026-02-25T14:59:33.315109Z","end":"2026-02-25T14:59:33.523195Z","steps":["trace[1840849229] 'process raft request'  (duration: 107.740143ms)","trace[1840849229] 'compare'  (duration: 99.976788ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:33.523455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.255597ms","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-25T14:59:33.523502Z","caller":"traceutil/trace.go:171","msg":"trace[1813664257] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:315; }","duration":"208.327363ms","start":"2026-02-25T14:59:33.315164Z","end":"2026-02-25T14:59:33.523491Z","steps":["trace[1813664257] 'agreement among raft nodes before linearized reading'  (duration: 208.157558ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.538191Z","caller":"traceutil/trace.go:171","msg":"trace[604706143] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"210.158119ms","start":"2026-02-25T14:59:33.328013Z","end":"2026-02-25T14:59:33.538171Z","steps":["trace[604706143] 'process raft request'  (duration: 210.023688ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.781579Z","caller":"traceutil/trace.go:171","msg":"trace[1145935570] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"183.202482ms","start":"2026-02-25T14:59:33.598346Z","end":"2026-02-25T14:59:33.781549Z","steps":["trace[1145935570] 'process raft request'  (duration: 183.104274ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.781632Z","caller":"traceutil/trace.go:171","msg":"trace[1881798681] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:328; }","duration":"187.687556ms","start":"2026-02-25T14:59:33.593892Z","end":"2026-02-25T14:59:33.78158Z","steps":["trace[1881798681] 'read index received'  (duration: 108.670322ms)","trace[1881798681] 'applied index is now lower than readState.Index'  (duration: 79.013993ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:33.78174Z","caller":"traceutil/trace.go:171","msg":"trace[33732036] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"200.693309ms","start":"2026-02-25T14:59:33.581033Z","end":"2026-02-25T14:59:33.781726Z","steps":["trace[33732036] 'process raft request'  (duration: 121.320965ms)","trace[33732036] 'compare'  (duration: 78.940887ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:33.781892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.833147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5270"}
{"level":"warn","ts":"2026-02-25T14:59:33.781904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.469531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T14:59:33.781938Z","caller":"traceutil/trace.go:171","msg":"trace[2118980285] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:319; }","duration":"201.938215ms","start":"2026-02-25T14:59:33.579987Z","end":"2026-02-25T14:59:33.781925Z","steps":["trace[2118980285] 'agreement among raft nodes before linearized reading'  (duration: 201.771061ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.781961Z","caller":"traceutil/trace.go:171","msg":"trace[1214167832] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:319; }","duration":"184.565329ms","start":"2026-02-25T14:59:33.597379Z","end":"2026-02-25T14:59:33.781944Z","steps":["trace[1214167832] 'agreement among raft nodes before linearized reading'  (duration: 184.408315ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.781666Z","caller":"traceutil/trace.go:171","msg":"trace[1148973838] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"199.389278ms","start":"2026-02-25T14:59:33.58213Z","end":"2026-02-25T14:59:33.781519Z","steps":["trace[1148973838] 'process raft request'  (duration: 199.247425ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:33.78208Z","caller":"traceutil/trace.go:171","msg":"trace[1927608835] transaction","detail":"{read_only:false; number_of_response:0; response_revision:318; }","duration":"199.581714ms","start":"2026-02-25T14:59:33.582477Z","end":"2026-02-25T14:59:33.782059Z","steps":["trace[1927608835] 'process raft request'  (duration: 198.935609ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:34.040017Z","caller":"traceutil/trace.go:171","msg":"trace[645729605] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"252.186025ms","start":"2026-02-25T14:59:33.787809Z","end":"2026-02-25T14:59:34.039995Z","steps":["trace[645729605] 'process raft request'  (duration: 153.212745ms)","trace[645729605] 'compare'  (duration: 98.698756ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:34.04009Z","caller":"traceutil/trace.go:171","msg":"trace[497866357] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"189.728579ms","start":"2026-02-25T14:59:33.85033Z","end":"2026-02-25T14:59:34.040059Z","steps":["trace[497866357] 'process raft request'  (duration: 189.659473ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:34.04014Z","caller":"traceutil/trace.go:171","msg":"trace[2105859430] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"247.175466ms","start":"2026-02-25T14:59:33.792925Z","end":"2026-02-25T14:59:34.0401Z","steps":["trace[2105859430] 'process raft request'  (duration: 246.977759ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:34.169995Z","caller":"traceutil/trace.go:171","msg":"trace[1637166015] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"117.947287ms","start":"2026-02-25T14:59:34.052021Z","end":"2026-02-25T14:59:34.169969Z","steps":["trace[1637166015] 'process raft request'  (duration: 111.096908ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:34.176013Z","caller":"traceutil/trace.go:171","msg":"trace[1035059761] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"115.926832ms","start":"2026-02-25T14:59:34.060059Z","end":"2026-02-25T14:59:34.175986Z","steps":["trace[1035059761] 'process raft request'  (duration: 115.680311ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:34.726529Z","caller":"traceutil/trace.go:171","msg":"trace[272992091] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"108.255132ms","start":"2026-02-25T14:59:34.618247Z","end":"2026-02-25T14:59:34.726502Z","steps":["trace[272992091] 'process raft request'  (duration: 27.314154ms)","trace[272992091] 'compare'  (duration: 80.581588ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:34.727223Z","caller":"traceutil/trace.go:171","msg":"trace[611104675] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"103.322609ms","start":"2026-02-25T14:59:34.623888Z","end":"2026-02-25T14:59:34.72721Z","steps":["trace[611104675] 'process raft request'  (duration: 103.231811ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:35.637595Z","caller":"traceutil/trace.go:171","msg":"trace[587061561] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"306.055978ms","start":"2026-02-25T14:59:35.331524Z","end":"2026-02-25T14:59:35.63758Z","steps":["trace[587061561] 'read index received'  (duration: 305.925787ms)","trace[587061561] 'applied index is now lower than readState.Index'  (duration: 129.581µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:35.637763Z","caller":"traceutil/trace.go:171","msg":"trace[626525347] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"347.363065ms","start":"2026-02-25T14:59:35.290391Z","end":"2026-02-25T14:59:35.637754Z","steps":["trace[626525347] 'process raft request'  (duration: 347.099992ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:35.637967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.290366Z","time spent":"347.551582ms","remote":"127.0.0.1:35984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/kube-dns\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/kube-dns\" value_size:539 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:35.638138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.617247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-02-25T14:59:35.638167Z","caller":"traceutil/trace.go:171","msg":"trace[852879380] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:352; }","duration":"306.679433ms","start":"2026-02-25T14:59:35.331479Z","end":"2026-02-25T14:59:35.638159Z","steps":["trace[852879380] 'agreement among raft nodes before linearized reading'  (duration: 306.605926ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:35.638189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.331461Z","time spent":"306.723726ms","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:35.638298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.018961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-25T14:59:35.638322Z","caller":"traceutil/trace.go:171","msg":"trace[392756502] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:352; }","duration":"256.072136ms","start":"2026-02-25T14:59:35.382244Z","end":"2026-02-25T14:59:35.638316Z","steps":["trace[392756502] 'agreement among raft nodes before linearized reading'  (duration: 256.033523ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:35.638608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.297281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"info","ts":"2026-02-25T14:59:35.638647Z","caller":"traceutil/trace.go:171","msg":"trace[12412763] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:352; }","duration":"106.371138ms","start":"2026-02-25T14:59:35.532269Z","end":"2026-02-25T14:59:35.63864Z","steps":["trace[12412763] 'agreement among raft nodes before linearized reading'  (duration: 106.317153ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:35.638709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.493383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-25T14:59:35.638731Z","caller":"traceutil/trace.go:171","msg":"trace[558837731] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:352; }","duration":"156.566769ms","start":"2026-02-25T14:59:35.482159Z","end":"2026-02-25T14:59:35.638726Z","steps":["trace[558837731] 'agreement among raft nodes before linearized reading'  (duration: 156.530786ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:35.638791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.151188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-02-25T14:59:35.63881Z","caller":"traceutil/trace.go:171","msg":"trace[1154824825] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:352; }","duration":"206.199202ms","start":"2026-02-25T14:59:35.432606Z","end":"2026-02-25T14:59:35.638805Z","steps":["trace[1154824825] 'agreement among raft nodes before linearized reading'  (duration: 206.166539ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:36.233581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179111,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:36.73423Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179111,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:37.014435Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.327041935s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T14:59:38.904861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000736102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-25T14:59:38.905003Z","caller":"traceutil/trace.go:171","msg":"trace[1557080233] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000898136s","start":"2026-02-25T14:59:36.904083Z","end":"2026-02-25T14:59:38.904981Z","steps":["trace[1557080233] 'agreement among raft nodes before linearized reading'  (duration: 2.000731452s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:38.905066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.904042Z","time spent":"2.001012467s","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/25 14:59:38 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-25T14:59:39.176118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.161364823s","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179112 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/default/instance.18978554394d07ec\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18978554394d07ec\" value_size:581 lease:2398338966678178543 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:39.176212Z","caller":"traceutil/trace.go:171","msg":"trace[686655622] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:365; }","duration":"3.443533386s","start":"2026-02-25T14:59:35.732664Z","end":"2026-02-25T14:59:39.176197Z","steps":["trace[686655622] 'read index received'  (duration: 1.281951383s)","trace[686655622] 'applied index is now lower than readState.Index'  (duration: 2.161579853s)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:39.176263Z","caller":"traceutil/trace.go:171","msg":"trace[1354255236] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"3.488933644s","start":"2026-02-25T14:59:35.687322Z","end":"2026-02-25T14:59:39.176256Z","steps":["trace[1354255236] 'process raft request'  (duration: 1.327362592s)","trace[1354255236] 'compare'  (duration: 2.160948037s)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:39.176298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.687311Z","time spent":"3.488970027s","remote":"127.0.0.1:35894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18978554394d07ec\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18978554394d07ec\" value_size:581 lease:2398338966678178543 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:39.176568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.443906948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T14:59:39.176597Z","caller":"traceutil/trace.go:171","msg":"trace[1532178406] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:353; }","duration":"3.443977215s","start":"2026-02-25T14:59:35.732613Z","end":"2026-02-25T14:59:39.17659Z","steps":["trace[1532178406] 'agreement among raft nodes before linearized reading'  (duration: 3.443892078s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:39.176617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.732594Z","time spent":"3.444018558s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:39.677355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179114,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T14:59:40.003535Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.095335057s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-25T14:59:40.585577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.566878ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179113 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189785551778b202\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189785551778b202\" value_size:670 lease:2398338966678178543 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T14:59:40.585718Z","caller":"traceutil/trace.go:171","msg":"trace[2050463488] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"1.409465582s","start":"2026-02-25T14:59:39.17623Z","end":"2026-02-25T14:59:40.585696Z","steps":["trace[2050463488] 'read index received'  (duration: 827.590817ms)","trace[2050463488] 'applied index is now lower than readState.Index'  (duration: 581.871665ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T14:59:40.585844Z","caller":"traceutil/trace.go:171","msg":"trace[1659224879] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"1.677747629s","start":"2026-02-25T14:59:38.908079Z","end":"2026-02-25T14:59:40.585826Z","steps":["trace[1659224879] 'process raft request'  (duration: 1.095845041s)","trace[1659224879] 'compare'  (duration: 581.089926ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:40.585933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:38.908054Z","time spent":"1.677839006s","remote":"127.0.0.1:35894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-apiserver-instance.189785551778b202\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-apiserver-instance.189785551778b202\" value_size:670 lease:2398338966678178543 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T14:59:40.586246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.599557659s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-25T14:59:40.586283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.552352359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-02-25T14:59:40.586409Z","caller":"traceutil/trace.go:171","msg":"trace[1513336923] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:354; }","duration":"3.599727654s","start":"2026-02-25T14:59:36.986666Z","end":"2026-02-25T14:59:40.586393Z","steps":["trace[1513336923] 'agreement among raft nodes before linearized reading'  (duration: 3.599541748s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.586438Z","caller":"traceutil/trace.go:171","msg":"trace[841538910] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:354; }","duration":"4.552549236s","start":"2026-02-25T14:59:36.033864Z","end":"2026-02-25T14:59:40.586414Z","steps":["trace[841538910] 'agreement among raft nodes before linearized reading'  (duration: 4.552219157s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.586427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.767494477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"warn","ts":"2026-02-25T14:59:40.586489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.03385Z","time spent":"4.552629012s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"info","ts":"2026-02-25T14:59:40.586505Z","caller":"traceutil/trace.go:171","msg":"trace[813630946] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.76764252s","start":"2026-02-25T14:59:35.818843Z","end":"2026-02-25T14:59:40.586485Z","steps":["trace[813630946] 'agreement among raft nodes before linearized reading'  (duration: 4.767392758s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.586554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.818801Z","time spent":"4.767743698s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.586513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.703332134s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-25T14:59:40.586656Z","caller":"traceutil/trace.go:171","msg":"trace[1861235129] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:354; }","duration":"4.703491227s","start":"2026-02-25T14:59:35.883147Z","end":"2026-02-25T14:59:40.586638Z","steps":["trace[1861235129] 'agreement among raft nodes before linearized reading'  (duration: 4.703080821s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.586638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.502448461s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"warn","ts":"2026-02-25T14:59:40.586304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.651801268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"warn","ts":"2026-02-25T14:59:40.586703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.883137Z","time spent":"4.703553153s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "}
{"level":"info","ts":"2026-02-25T14:59:40.586719Z","caller":"traceutil/trace.go:171","msg":"trace[942337561] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.502571911s","start":"2026-02-25T14:59:36.084126Z","end":"2026-02-25T14:59:40.586698Z","steps":["trace[942337561] 'agreement among raft nodes before linearized reading'  (duration: 4.502357703s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.586722Z","caller":"traceutil/trace.go:171","msg":"trace[1363271853] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.652240366s","start":"2026-02-25T14:59:35.934466Z","end":"2026-02-25T14:59:40.586706Z","steps":["trace[1363271853] 'agreement among raft nodes before linearized reading'  (duration: 4.651743173s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.58676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.084105Z","time spent":"4.502646408s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.586774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.934455Z","time spent":"4.652303071s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.586779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.271936032s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"}
{"level":"info","ts":"2026-02-25T14:59:40.586821Z","caller":"traceutil/trace.go:171","msg":"trace[1988115394] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:354; }","duration":"4.271999688s","start":"2026-02-25T14:59:36.31481Z","end":"2026-02-25T14:59:40.58681Z","steps":["trace[1988115394] 'agreement among raft nodes before linearized reading'  (duration: 4.271842034s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.586854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.314798Z","time spent":"4.272046722s","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4282,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.30099346s","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-25T14:59:40.587115Z","caller":"traceutil/trace.go:171","msg":"trace[864563898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"4.301082638s","start":"2026-02-25T14:59:36.286021Z","end":"2026-02-25T14:59:40.587103Z","steps":["trace[864563898] 'agreement among raft nodes before linearized reading'  (duration: 4.300500098s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.285999Z","time spent":"4.301137413s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.736411111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"}
{"level":"info","ts":"2026-02-25T14:59:40.587208Z","caller":"traceutil/trace.go:171","msg":"trace[2138096677] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:354; }","duration":"4.736481287s","start":"2026-02-25T14:59:35.850713Z","end":"2026-02-25T14:59:40.587194Z","steps":["trace[2138096677] 'agreement among raft nodes before linearized reading'  (duration: 4.735567908s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.58725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.850702Z","time spent":"4.736536663s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.58732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.753981415s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-02-25T14:59:40.587361Z","caller":"traceutil/trace.go:171","msg":"trace[707644172] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.754064152s","start":"2026-02-25T14:59:35.833285Z","end":"2026-02-25T14:59:40.58735Z","steps":["trace[707644172] 'agreement among raft nodes before linearized reading'  (duration: 4.753013041s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.833262Z","time spent":"4.754135628s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.302252469s","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-25T14:59:40.587476Z","caller":"traceutil/trace.go:171","msg":"trace[1293681032] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"4.302306863s","start":"2026-02-25T14:59:36.285155Z","end":"2026-02-25T14:59:40.587462Z","steps":["trace[1293681032] 'agreement among raft nodes before linearized reading'  (duration: 4.301406675s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.285107Z","time spent":"4.302400101s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.454490281s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-02-25T14:59:40.587569Z","caller":"traceutil/trace.go:171","msg":"trace[2122878887] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.454571548s","start":"2026-02-25T14:59:36.132982Z","end":"2026-02-25T14:59:40.587553Z","steps":["trace[2122878887] 'agreement among raft nodes before linearized reading'  (duration: 4.453491435s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.58761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.132962Z","time spent":"4.454640395s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":236,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.298004873s","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-25T14:59:40.587685Z","caller":"traceutil/trace.go:171","msg":"trace[481909347] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"4.298107752s","start":"2026-02-25T14:59:36.289563Z","end":"2026-02-25T14:59:40.587671Z","steps":["trace[481909347] 'agreement among raft nodes before linearized reading'  (duration: 4.297115246s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.298673021s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"warn","ts":"2026-02-25T14:59:40.587734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.289541Z","time spent":"4.298180758s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-25T14:59:40.587748Z","caller":"traceutil/trace.go:171","msg":"trace[332649907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"4.298755978s","start":"2026-02-25T14:59:36.288974Z","end":"2026-02-25T14:59:40.58773Z","steps":["trace[332649907] 'agreement among raft nodes before linearized reading'  (duration: 4.297148998s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:36.288966Z","time spent":"4.298812863s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.408604447s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T14:59:40.587885Z","caller":"traceutil/trace.go:171","msg":"trace[345238530] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.408679053s","start":"2026-02-25T14:59:39.179194Z","end":"2026-02-25T14:59:40.587874Z","steps":["trace[345238530] 'agreement among raft nodes before linearized reading'  (duration: 1.407062993s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.587923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:39.179183Z","time spent":"1.408731748s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-02-25T14:59:40.587921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.60420798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-02-25T14:59:40.587978Z","caller":"traceutil/trace.go:171","msg":"trace[1249789345] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:354; }","duration":"4.604293468s","start":"2026-02-25T14:59:35.983668Z","end":"2026-02-25T14:59:40.587962Z","steps":["trace[1249789345] 'agreement among raft nodes before linearized reading'  (duration: 4.60247787s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.588031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T14:59:35.983651Z","time spent":"4.604360994s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "}
{"level":"info","ts":"2026-02-25T14:59:40.749476Z","caller":"traceutil/trace.go:171","msg":"trace[1098347515] linearizableReadLoop","detail":"{readStateIndex:368; appliedIndex:367; }","duration":"152.738217ms","start":"2026-02-25T14:59:40.596712Z","end":"2026-02-25T14:59:40.74945Z","steps":["trace[1098347515] 'read index received'  (duration: 148.64375ms)","trace[1098347515] 'applied index is now lower than readState.Index'  (duration: 4.090146ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T14:59:40.749652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.906952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-02-25T14:59:40.749741Z","caller":"traceutil/trace.go:171","msg":"trace[1035762176] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:354; }","duration":"153.065065ms","start":"2026-02-25T14:59:40.596656Z","end":"2026-02-25T14:59:40.749721Z","steps":["trace[1035762176] 'agreement among raft nodes before linearized reading'  (duration: 152.883079ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754233Z","caller":"traceutil/trace.go:171","msg":"trace[33898510] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"157.397854ms","start":"2026-02-25T14:59:40.59681Z","end":"2026-02-25T14:59:40.754208Z","steps":["trace[33898510] 'process raft request'  (duration: 156.837805ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754304Z","caller":"traceutil/trace.go:171","msg":"trace[2099630097] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"157.481131ms","start":"2026-02-25T14:59:40.596811Z","end":"2026-02-25T14:59:40.754292Z","steps":["trace[2099630097] 'process raft request'  (duration: 156.873108ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754466Z","caller":"traceutil/trace.go:171","msg":"trace[1246657813] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"155.053529ms","start":"2026-02-25T14:59:40.599337Z","end":"2026-02-25T14:59:40.754391Z","steps":["trace[1246657813] 'process raft request'  (duration: 154.558006ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754487Z","caller":"traceutil/trace.go:171","msg":"trace[198637454] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"154.680836ms","start":"2026-02-25T14:59:40.599773Z","end":"2026-02-25T14:59:40.754454Z","steps":["trace[198637454] 'process raft request'  (duration: 154.156291ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.75465Z","caller":"traceutil/trace.go:171","msg":"trace[272755340] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"155.546382ms","start":"2026-02-25T14:59:40.599081Z","end":"2026-02-25T14:59:40.754627Z","steps":["trace[272755340] 'process raft request'  (duration: 154.746703ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754739Z","caller":"traceutil/trace.go:171","msg":"trace[1072045156] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"155.62928ms","start":"2026-02-25T14:59:40.599097Z","end":"2026-02-25T14:59:40.754727Z","steps":["trace[1072045156] 'process raft request'  (duration: 154.770855ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754984Z","caller":"traceutil/trace.go:171","msg":"trace[1154174941] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"154.863572ms","start":"2026-02-25T14:59:40.60011Z","end":"2026-02-25T14:59:40.754974Z","steps":["trace[1154174941] 'process raft request'  (duration: 153.863345ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.755056Z","caller":"traceutil/trace.go:171","msg":"trace[1458071930] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"158.28541ms","start":"2026-02-25T14:59:40.596759Z","end":"2026-02-25T14:59:40.755045Z","steps":["trace[1458071930] 'process raft request'  (duration: 156.850086ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.755024Z","caller":"traceutil/trace.go:171","msg":"trace[542443723] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"156.028324ms","start":"2026-02-25T14:59:40.598981Z","end":"2026-02-25T14:59:40.75501Z","steps":["trace[542443723] 'process raft request'  (duration: 154.762964ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754145Z","caller":"traceutil/trace.go:171","msg":"trace[242484825] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"155.076322ms","start":"2026-02-25T14:59:40.599052Z","end":"2026-02-25T14:59:40.754129Z","steps":["trace[242484825] 'process raft request'  (duration: 154.730792ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.754995Z","caller":"traceutil/trace.go:171","msg":"trace[1953453962] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"158.269729ms","start":"2026-02-25T14:59:40.596711Z","end":"2026-02-25T14:59:40.754981Z","steps":["trace[1953453962] 'process raft request'  (duration: 156.78886ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.755724Z","caller":"traceutil/trace.go:171","msg":"trace[519331248] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"144.763821ms","start":"2026-02-25T14:59:40.610943Z","end":"2026-02-25T14:59:40.755707Z","steps":["trace[519331248] 'process raft request'  (duration: 143.076694ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.756138Z","caller":"traceutil/trace.go:171","msg":"trace[585120689] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"144.225604ms","start":"2026-02-25T14:59:40.611901Z","end":"2026-02-25T14:59:40.756126Z","steps":["trace[585120689] 'process raft request'  (duration: 143.656195ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.756228Z","caller":"traceutil/trace.go:171","msg":"trace[2056315976] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"143.042322ms","start":"2026-02-25T14:59:40.613177Z","end":"2026-02-25T14:59:40.756219Z","steps":["trace[2056315976] 'process raft request'  (duration: 142.923622ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:40.756349Z","caller":"traceutil/trace.go:171","msg":"trace[1813665689] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"143.567448ms","start":"2026-02-25T14:59:40.612768Z","end":"2026-02-25T14:59:40.756335Z","steps":["trace[1813665689] 'process raft request'  (duration: 143.271772ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T14:59:40.756595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.411429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"}
{"level":"info","ts":"2026-02-25T14:59:40.756629Z","caller":"traceutil/trace.go:171","msg":"trace[682617850] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:369; }","duration":"159.470855ms","start":"2026-02-25T14:59:40.597146Z","end":"2026-02-25T14:59:40.756617Z","steps":["trace[682617850] 'agreement among raft nodes before linearized reading'  (duration: 159.41931ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T14:59:47.067144Z","caller":"traceutil/trace.go:171","msg":"trace[160010527] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"133.159858ms","start":"2026-02-25T14:59:46.933954Z","end":"2026-02-25T14:59:47.067114Z","steps":["trace[160010527] 'process raft request'  (duration: 132.991463ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:03.55521Z","caller":"traceutil/trace.go:171","msg":"trace[647428761] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"192.065702ms","start":"2026-02-25T15:00:03.363122Z","end":"2026-02-25T15:00:03.555188Z","steps":["trace[647428761] 'process raft request'  (duration: 191.747564ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:05.522769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.052003ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179440 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:526 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:00:05.522879Z","caller":"traceutil/trace.go:171","msg":"trace[1046102891] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"430.60494ms","start":"2026-02-25T15:00:05.092255Z","end":"2026-02-25T15:00:05.52286Z","steps":["trace[1046102891] 'process raft request'  (duration: 260.381026ms)","trace[1046102891] 'compare'  (duration: 169.817017ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:05.522943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.09224Z","time spent":"430.671576ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:526 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-02-25T15:00:05.977272Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179439,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:00:06.274432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.439265ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179441 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:527 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:00:06.274751Z","caller":"traceutil/trace.go:171","msg":"trace[908634779] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"1.182194322s","start":"2026-02-25T15:00:05.092527Z","end":"2026-02-25T15:00:06.274721Z","steps":["trace[908634779] 'process raft request'  (duration: 944.388717ms)","trace[908634779] 'compare'  (duration: 237.35374ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:06.274816Z","caller":"traceutil/trace.go:171","msg":"trace[1750432734] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"1.182135696s","start":"2026-02-25T15:00:05.092662Z","end":"2026-02-25T15:00:06.274798Z","steps":["trace[1750432734] 'process raft request'  (duration: 1.181887869s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:06.274879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.092517Z","time spent":"1.182296056s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:527 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-02-25T15:00:06.274896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.092639Z","time spent":"1.18221918s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:528 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-25T15:00:06.672469Z","caller":"traceutil/trace.go:171","msg":"trace[2064897521] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"888.338172ms","start":"2026-02-25T15:00:05.784105Z","end":"2026-02-25T15:00:06.672443Z","steps":["trace[2064897521] 'process raft request'  (duration: 790.20661ms)","trace[2064897521] 'compare'  (duration: 97.660218ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:06.672607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.784083Z","time spent":"888.455146ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:475 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-25T15:00:06.700837Z","caller":"traceutil/trace.go:171","msg":"trace[340244713] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:551; }","duration":"1.224527121s","start":"2026-02-25T15:00:05.476284Z","end":"2026-02-25T15:00:06.700811Z","steps":["trace[340244713] 'read index received'  (duration: 560.638118ms)","trace[340244713] 'applied index is now lower than readState.Index'  (duration: 663.887693ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:06.700999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.224702861s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:06.701041Z","caller":"traceutil/trace.go:171","msg":"trace[1721953046] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"1.224793976s","start":"2026-02-25T15:00:05.476237Z","end":"2026-02-25T15:00:06.701031Z","steps":["trace[1721953046] 'agreement among raft nodes before linearized reading'  (duration: 1.224710821s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:06.701081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.47622Z","time spent":"1.224853614s","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:00:06.701087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.108269581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:06.701191Z","caller":"traceutil/trace.go:171","msg":"trace[1743162040] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:534; }","duration":"1.108421274s","start":"2026-02-25T15:00:05.592742Z","end":"2026-02-25T15:00:06.701164Z","steps":["trace[1743162040] 'agreement among raft nodes before linearized reading'  (duration: 1.108256802s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:06.701257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:05.59272Z","time spent":"1.108522557s","remote":"127.0.0.1:36032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "}
{"level":"info","ts":"2026-02-25T15:00:06.841402Z","caller":"traceutil/trace.go:171","msg":"trace[397598395] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"109.011363ms","start":"2026-02-25T15:00:06.732365Z","end":"2026-02-25T15:00:06.841376Z","steps":["trace[397598395] 'process raft request'  (duration: 108.958316ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:06.841412Z","caller":"traceutil/trace.go:171","msg":"trace[697210785] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"110.811333ms","start":"2026-02-25T15:00:06.73057Z","end":"2026-02-25T15:00:06.841382Z","steps":["trace[697210785] 'process raft request'  (duration: 41.836934ms)","trace[697210785] 'compare'  (duration: 68.698434ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:07.218355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.898637ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179460 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/local-path-storage/local-path-config\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/local-path-storage/local-path-config\" value_size:1362 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:00:07.218515Z","caller":"traceutil/trace.go:171","msg":"trace[603125624] linearizableReadLoop","detail":"{readStateIndex:561; appliedIndex:560; }","duration":"125.589528ms","start":"2026-02-25T15:00:07.092906Z","end":"2026-02-25T15:00:07.218496Z","steps":["trace[603125624] 'read index received'  (duration: 35.218µs)","trace[603125624] 'applied index is now lower than readState.Index'  (duration: 125.55213ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:07.218623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.714141ms","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-25T15:00:07.218651Z","caller":"traceutil/trace.go:171","msg":"trace[1334718804] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:540; }","duration":"125.746839ms","start":"2026-02-25T15:00:07.092894Z","end":"2026-02-25T15:00:07.218641Z","steps":["trace[1334718804] 'agreement among raft nodes before linearized reading'  (duration: 125.651244ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:07.21865Z","caller":"traceutil/trace.go:171","msg":"trace[288734540] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"310.584633ms","start":"2026-02-25T15:00:06.908011Z","end":"2026-02-25T15:00:07.218596Z","steps":["trace[288734540] 'process raft request'  (duration: 58.412811ms)","trace[288734540] 'compare'  (duration: 251.547786ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:07.218771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:06.90799Z","time spent":"310.720206ms","remote":"127.0.0.1:35922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1427,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/local-path-storage/local-path-config\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/local-path-storage/local-path-config\" value_size:1362 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:00:10.969879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.456248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8jmpf\" ","response":"range_response_count:1 size:16656"}
{"level":"info","ts":"2026-02-25T15:00:10.969929Z","caller":"traceutil/trace.go:171","msg":"trace[181017349] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8jmpf; range_end:; response_count:1; response_revision:568; }","duration":"290.553024ms","start":"2026-02-25T15:00:10.679366Z","end":"2026-02-25T15:00:10.969919Z","steps":["trace[181017349] 'range keys from in-memory index tree'  (duration: 290.320515ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:11.735591Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179515,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-02-25T15:00:11.796951Z","caller":"traceutil/trace.go:171","msg":"trace[1607140861] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"561.956687ms","start":"2026-02-25T15:00:11.234969Z","end":"2026-02-25T15:00:11.796925Z","steps":["trace[1607140861] 'read index received'  (duration: 561.690559ms)","trace[1607140861] 'applied index is now lower than readState.Index'  (duration: 265.298µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:11.797071Z","caller":"traceutil/trace.go:171","msg":"trace[902928461] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"812.22671ms","start":"2026-02-25T15:00:10.984834Z","end":"2026-02-25T15:00:11.797061Z","steps":["trace[902928461] 'process raft request'  (duration: 811.882426ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:11.797356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:10.984814Z","time spent":"812.399033ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-8jmpf\" mod_revision:514 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-8jmpf\" value_size:16754 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-8jmpf\" > >"}
{"level":"warn","ts":"2026-02-25T15:00:11.797419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.48501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T15:00:11.797493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.509831ms","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-25T15:00:11.797541Z","caller":"traceutil/trace.go:171","msg":"trace[1218083014] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:569; }","duration":"251.651972ms","start":"2026-02-25T15:00:11.54586Z","end":"2026-02-25T15:00:11.797512Z","steps":["trace[1218083014] 'agreement among raft nodes before linearized reading'  (duration: 251.401433ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:11.797575Z","caller":"traceutil/trace.go:171","msg":"trace[340843351] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:569; }","duration":"562.628726ms","start":"2026-02-25T15:00:11.234929Z","end":"2026-02-25T15:00:11.797557Z","steps":["trace[340843351] 'agreement among raft nodes before linearized reading'  (duration: 562.404426ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:11.797604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:11.234914Z","time spent":"562.685613ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-02-25T15:00:12.572834Z","caller":"traceutil/trace.go:171","msg":"trace[967073818] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"274.79417ms","start":"2026-02-25T15:00:12.298016Z","end":"2026-02-25T15:00:12.57281Z","steps":["trace[967073818] 'process raft request'  (duration: 274.624537ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:12.58976Z","caller":"traceutil/trace.go:171","msg":"trace[1383268656] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"117.766748ms","start":"2026-02-25T15:00:12.471969Z","end":"2026-02-25T15:00:12.589736Z","steps":["trace[1383268656] 'read index received'  (duration: 100.684057ms)","trace[1383268656] 'applied index is now lower than readState.Index'  (duration: 17.081511ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:12.589875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.881654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:12.589867Z","caller":"traceutil/trace.go:171","msg":"trace[253522459] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"290.169156ms","start":"2026-02-25T15:00:12.299664Z","end":"2026-02-25T15:00:12.589834Z","steps":["trace[253522459] 'process raft request'  (duration: 289.941136ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:12.589907Z","caller":"traceutil/trace.go:171","msg":"trace[1064747196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"117.96757ms","start":"2026-02-25T15:00:12.47193Z","end":"2026-02-25T15:00:12.589898Z","steps":["trace[1064747196] 'agreement among raft nodes before linearized reading'  (duration: 117.891314ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:14.346015Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179529,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:00:14.846406Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179529,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:00:15.346725Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398338966678179529,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-25T15:00:15.782142Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.95549163s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-25T15:00:15.782486Z","caller":"traceutil/trace.go:171","msg":"trace[1798580520] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.955878585s","start":"2026-02-25T15:00:13.826588Z","end":"2026-02-25T15:00:15.782466Z","steps":["trace[1798580520] 'process raft request'  (duration: 1.95574361s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:15.782593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:13.826579Z","time spent":"1.955945634s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:570 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-25T15:00:15.812551Z","caller":"traceutil/trace.go:171","msg":"trace[927577384] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.898382982s","start":"2026-02-25T15:00:13.914089Z","end":"2026-02-25T15:00:15.812472Z","steps":["trace[927577384] 'process raft request'  (duration: 1.898157541s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:15.813457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:13.914064Z","time spent":"1.898608575s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:529 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-02-25T15:00:15.81577Z","caller":"traceutil/trace.go:171","msg":"trace[1844660465] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:595; }","duration":"1.970676635s","start":"2026-02-25T15:00:13.845067Z","end":"2026-02-25T15:00:15.815744Z","steps":["trace[1844660465] 'read index received'  (duration: 1.937262194s)","trace[1844660465] 'applied index is now lower than readState.Index'  (duration: 33.412791ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:15.815931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239641176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"warn","ts":"2026-02-25T15:00:15.81593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.970848818s","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-25T15:00:15.815986Z","caller":"traceutil/trace.go:171","msg":"trace[1691726158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"1.239736613s","start":"2026-02-25T15:00:14.576234Z","end":"2026-02-25T15:00:15.815971Z","steps":["trace[1691726158] 'agreement among raft nodes before linearized reading'  (duration: 1.239642407s)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:15.816005Z","caller":"traceutil/trace.go:171","msg":"trace[843012585] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:575; }","duration":"1.970981693s","start":"2026-02-25T15:00:13.845007Z","end":"2026-02-25T15:00:15.815988Z","steps":["trace[843012585] 'agreement among raft nodes before linearized reading'  (duration: 1.970850938s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:15.816028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:14.576219Z","time spent":"1.23980012s","remote":"127.0.0.1:36104","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-25T15:00:15.816052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:13.844996Z","time spent":"1.971043701s","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-25T15:00:15.816179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.643318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:15.816235Z","caller":"traceutil/trace.go:171","msg":"trace[1924174438] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"344.719055ms","start":"2026-02-25T15:00:15.471502Z","end":"2026-02-25T15:00:15.816221Z","steps":["trace[1924174438] 'agreement among raft nodes before linearized reading'  (duration: 344.644377ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:15.816275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:15.471489Z","time spent":"344.774973ms","remote":"127.0.0.1:35814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-25T15:00:15.816487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221481395s","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-25T15:00:15.816544Z","caller":"traceutil/trace.go:171","msg":"trace[1513855748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"1.221554053s","start":"2026-02-25T15:00:14.594976Z","end":"2026-02-25T15:00:15.81653Z","steps":["trace[1513855748] 'agreement among raft nodes before linearized reading'  (duration: 1.221300972s)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:15.816583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:14.594968Z","time spent":"1.22160542s","remote":"127.0.0.1:36104","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":"warn","ts":"2026-02-25T15:00:18.237618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.173675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:18.23769Z","caller":"traceutil/trace.go:171","msg":"trace[1557459128] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:610; }","duration":"148.295712ms","start":"2026-02-25T15:00:18.089378Z","end":"2026-02-25T15:00:18.237674Z","steps":["trace[1557459128] 'range keys from in-memory index tree'  (duration: 148.096378ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:20.816698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.018842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"}
{"level":"info","ts":"2026-02-25T15:00:20.816797Z","caller":"traceutil/trace.go:171","msg":"trace[358112378] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:642; }","duration":"128.167557ms","start":"2026-02-25T15:00:20.688605Z","end":"2026-02-25T15:00:20.816773Z","steps":["trace[358112378] 'range keys from in-memory index tree'  (duration: 127.787759ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:21.100335Z","caller":"traceutil/trace.go:171","msg":"trace[989960425] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"268.899298ms","start":"2026-02-25T15:00:20.831403Z","end":"2026-02-25T15:00:21.100302Z","steps":["trace[989960425] 'process raft request'  (duration: 171.678423ms)","trace[989960425] 'compare'  (duration: 96.920274ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:21.228554Z","caller":"traceutil/trace.go:171","msg":"trace[1357098963] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"140.017125ms","start":"2026-02-25T15:00:21.088507Z","end":"2026-02-25T15:00:21.228524Z","steps":["trace[1357098963] 'read index received'  (duration: 137.478984ms)","trace[1357098963] 'applied index is now lower than readState.Index'  (duration: 2.537201ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:21.228774Z","caller":"traceutil/trace.go:171","msg":"trace[1676111005] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"306.748661ms","start":"2026-02-25T15:00:20.921986Z","end":"2026-02-25T15:00:21.228735Z","steps":["trace[1676111005] 'process raft request'  (duration: 304.156382ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.228949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.420203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"}
{"level":"info","ts":"2026-02-25T15:00:21.229003Z","caller":"traceutil/trace.go:171","msg":"trace[1725169992] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:645; }","duration":"140.52883ms","start":"2026-02-25T15:00:21.088459Z","end":"2026-02-25T15:00:21.228988Z","steps":["trace[1725169992] 'agreement among raft nodes before linearized reading'  (duration: 140.307706ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.228974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:20.921949Z","time spent":"306.946606ms","remote":"127.0.0.1:35858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:187148 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:00:21.665751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.348923ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:21.665903Z","caller":"traceutil/trace.go:171","msg":"trace[1247415283] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:645; }","duration":"212.512078ms","start":"2026-02-25T15:00:21.453369Z","end":"2026-02-25T15:00:21.665881Z","steps":["trace[1247415283] 'range keys from in-memory index tree'  (duration: 212.328913ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.666567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.307854ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179650 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:645 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188130 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:00:21.666736Z","caller":"traceutil/trace.go:171","msg":"trace[1541715081] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"365.811318ms","start":"2026-02-25T15:00:21.300905Z","end":"2026-02-25T15:00:21.666717Z","steps":["trace[1541715081] 'process raft request'  (duration: 199.272781ms)","trace[1541715081] 'compare'  (duration: 165.433328ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:00:21.666848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:21.300879Z","time spent":"365.932726ms","remote":"127.0.0.1:35858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:645 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:188130 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" > >"}
{"level":"info","ts":"2026-02-25T15:00:21.682268Z","caller":"traceutil/trace.go:171","msg":"trace[1434560823] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"210.470314ms","start":"2026-02-25T15:00:21.471778Z","end":"2026-02-25T15:00:21.682248Z","steps":["trace[1434560823] 'read index received'  (duration: 28.376163ms)","trace[1434560823] 'applied index is now lower than readState.Index'  (duration: 182.093411ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:21.682337Z","caller":"traceutil/trace.go:171","msg":"trace[1683870452] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"341.441996ms","start":"2026-02-25T15:00:21.340871Z","end":"2026-02-25T15:00:21.682313Z","steps":["trace[1683870452] 'process raft request'  (duration: 341.136505ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.682427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.646459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:00:21.682468Z","caller":"traceutil/trace.go:171","msg":"trace[1522976065] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"210.729977ms","start":"2026-02-25T15:00:21.471726Z","end":"2026-02-25T15:00:21.682456Z","steps":["trace[1522976065] 'agreement among raft nodes before linearized reading'  (duration: 210.63552ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.682446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:00:21.340852Z","time spent":"341.545313ms","remote":"127.0.0.1:35858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" value_size:187346 >> failure:<>"}
{"level":"warn","ts":"2026-02-25T15:00:21.682825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.16915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"}
{"level":"info","ts":"2026-02-25T15:00:21.682948Z","caller":"traceutil/trace.go:171","msg":"trace[235319767] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:647; }","duration":"194.342145ms","start":"2026-02-25T15:00:21.488581Z","end":"2026-02-25T15:00:21.682923Z","steps":["trace[235319767] 'agreement among raft nodes before linearized reading'  (duration: 194.064903ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:21.939475Z","caller":"traceutil/trace.go:171","msg":"trace[2123892754] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"216.468029ms","start":"2026-02-25T15:00:21.722987Z","end":"2026-02-25T15:00:21.939455Z","steps":["trace[2123892754] 'process raft request'  (duration: 197.580927ms)","trace[2123892754] 'compare'  (duration: 18.659358ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:21.939975Z","caller":"traceutil/trace.go:171","msg":"trace[2095457492] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"192.698821ms","start":"2026-02-25T15:00:21.747249Z","end":"2026-02-25T15:00:21.939948Z","steps":["trace[2095457492] 'process raft request'  (duration: 192.176595ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:21.940162Z","caller":"traceutil/trace.go:171","msg":"trace[1775601182] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:671; }","duration":"131.256854ms","start":"2026-02-25T15:00:21.808878Z","end":"2026-02-25T15:00:21.940135Z","steps":["trace[1775601182] 'read index received'  (duration: 111.657291ms)","trace[1775601182] 'applied index is now lower than readState.Index'  (duration: 19.598303ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:21.940145Z","caller":"traceutil/trace.go:171","msg":"trace[270974834] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"184.905734ms","start":"2026-02-25T15:00:21.75522Z","end":"2026-02-25T15:00:21.940126Z","steps":["trace[270974834] 'process raft request'  (duration: 184.584183ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:21.940292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.40846ms","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-25T15:00:21.940323Z","caller":"traceutil/trace.go:171","msg":"trace[1136923558] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:651; }","duration":"131.484408ms","start":"2026-02-25T15:00:21.808831Z","end":"2026-02-25T15:00:21.940315Z","steps":["trace[1136923558] 'agreement among raft nodes before linearized reading'  (duration: 131.370531ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:22.209053Z","caller":"traceutil/trace.go:171","msg":"trace[744699658] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"119.784154ms","start":"2026-02-25T15:00:22.089242Z","end":"2026-02-25T15:00:22.209026Z","steps":["trace[744699658] 'read index received'  (duration: 117.410984ms)","trace[744699658] 'applied index is now lower than readState.Index'  (duration: 2.37204ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:22.209171Z","caller":"traceutil/trace.go:171","msg":"trace[1049875829] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"160.815567ms","start":"2026-02-25T15:00:22.048313Z","end":"2026-02-25T15:00:22.209128Z","steps":["trace[1049875829] 'process raft request'  (duration: 158.477637ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:22.209405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.138754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-02-25T15:00:22.209501Z","caller":"traceutil/trace.go:171","msg":"trace[90309055] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:657; }","duration":"120.279551ms","start":"2026-02-25T15:00:22.0892Z","end":"2026-02-25T15:00:22.209479Z","steps":["trace[90309055] 'agreement among raft nodes before linearized reading'  (duration: 119.963159ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:25.86717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.710646ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678179731 > lease_revoke:<id:21489c954fd48eb5>","response":"size:27"}
{"level":"info","ts":"2026-02-25T15:00:26.833132Z","caller":"traceutil/trace.go:171","msg":"trace[236275807] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"170.100079ms","start":"2026-02-25T15:00:26.663015Z","end":"2026-02-25T15:00:26.833116Z","steps":["trace[236275807] 'process raft request'  (duration: 169.988611ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:27.040671Z","caller":"traceutil/trace.go:171","msg":"trace[427825554] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"124.662421ms","start":"2026-02-25T15:00:26.915973Z","end":"2026-02-25T15:00:27.040635Z","steps":["trace[427825554] 'process raft request'  (duration: 94.088272ms)","trace[427825554] 'compare'  (duration: 30.437501ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:27.122607Z","caller":"traceutil/trace.go:171","msg":"trace[253076882] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"161.566934ms","start":"2026-02-25T15:00:26.961007Z","end":"2026-02-25T15:00:27.122574Z","steps":["trace[253076882] 'process raft request'  (duration: 161.498905ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:27.123268Z","caller":"traceutil/trace.go:171","msg":"trace[1376909562] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"165.287662ms","start":"2026-02-25T15:00:26.957968Z","end":"2026-02-25T15:00:27.123255Z","steps":["trace[1376909562] 'process raft request'  (duration: 164.124863ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:27.12342Z","caller":"traceutil/trace.go:171","msg":"trace[217487009] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"163.987537ms","start":"2026-02-25T15:00:26.959422Z","end":"2026-02-25T15:00:27.12341Z","steps":["trace[217487009] 'process raft request'  (duration: 162.835968ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:27.123684Z","caller":"traceutil/trace.go:171","msg":"trace[455517440] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"163.688643ms","start":"2026-02-25T15:00:26.95997Z","end":"2026-02-25T15:00:27.123659Z","steps":["trace[455517440] 'process raft request'  (duration: 162.360948ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:27.123979Z","caller":"traceutil/trace.go:171","msg":"trace[1940353187] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"163.493388ms","start":"2026-02-25T15:00:26.960473Z","end":"2026-02-25T15:00:27.123967Z","steps":["trace[1940353187] 'process raft request'  (duration: 161.989725ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.023216Z","caller":"traceutil/trace.go:171","msg":"trace[159649768] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"165.486491ms","start":"2026-02-25T15:00:29.857693Z","end":"2026-02-25T15:00:30.023179Z","steps":["trace[159649768] 'process raft request'  (duration: 109.750635ms)","trace[159649768] 'compare'  (duration: 55.558979ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:30.091874Z","caller":"traceutil/trace.go:171","msg":"trace[1161865279] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:749; }","duration":"229.449464ms","start":"2026-02-25T15:00:29.862402Z","end":"2026-02-25T15:00:30.091852Z","steps":["trace[1161865279] 'read index received'  (duration: 105.052185ms)","trace[1161865279] 'applied index is now lower than readState.Index'  (duration: 124.396219ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:30.092047Z","caller":"traceutil/trace.go:171","msg":"trace[1898492232] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"229.027632ms","start":"2026-02-25T15:00:29.863003Z","end":"2026-02-25T15:00:30.092031Z","steps":["trace[1898492232] 'process raft request'  (duration: 228.808755ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.092098Z","caller":"traceutil/trace.go:171","msg":"trace[1458900048] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"233.976327ms","start":"2026-02-25T15:00:29.8581Z","end":"2026-02-25T15:00:30.092077Z","steps":["trace[1458900048] 'process raft request'  (duration: 233.607892ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:30.092264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.831959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-25T15:00:30.092315Z","caller":"traceutil/trace.go:171","msg":"trace[662532213] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:725; }","duration":"229.920448ms","start":"2026-02-25T15:00:29.86238Z","end":"2026-02-25T15:00:30.092301Z","steps":["trace[662532213] 'agreement among raft nodes before linearized reading'  (duration: 229.818689ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.24122Z","caller":"traceutil/trace.go:171","msg":"trace[986268887] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"140.68197ms","start":"2026-02-25T15:00:30.100493Z","end":"2026-02-25T15:00:30.241174Z","steps":["trace[986268887] 'process raft request'  (duration: 113.55496ms)","trace[986268887] 'compare'  (duration: 26.928602ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:30.241363Z","caller":"traceutil/trace.go:171","msg":"trace[459658796] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"137.972866ms","start":"2026-02-25T15:00:30.103373Z","end":"2026-02-25T15:00:30.241346Z","steps":["trace[459658796] 'process raft request'  (duration: 137.888987ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.24137Z","caller":"traceutil/trace.go:171","msg":"trace[469209718] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"137.634431ms","start":"2026-02-25T15:00:30.103722Z","end":"2026-02-25T15:00:30.241357Z","steps":["trace[469209718] 'process raft request'  (duration: 137.567982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.241465Z","caller":"traceutil/trace.go:171","msg":"trace[47144742] linearizableReadLoop","detail":"{readStateIndex:759; appliedIndex:753; }","duration":"137.457934ms","start":"2026-02-25T15:00:30.103985Z","end":"2026-02-25T15:00:30.241443Z","steps":["trace[47144742] 'read index received'  (duration: 9.711868ms)","trace[47144742] 'applied index is now lower than readState.Index'  (duration: 127.744906ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:30.241339Z","caller":"traceutil/trace.go:171","msg":"trace[765487693] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"138.250423ms","start":"2026-02-25T15:00:30.103042Z","end":"2026-02-25T15:00:30.241293Z","steps":["trace[765487693] 'process raft request'  (duration: 138.088015ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:30.241706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.697961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-565l4\" ","response":"range_response_count:1 size:4733"}
{"level":"info","ts":"2026-02-25T15:00:30.241768Z","caller":"traceutil/trace.go:171","msg":"trace[857139691] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-565l4; range_end:; response_count:1; response_revision:733; }","duration":"137.789879ms","start":"2026-02-25T15:00:30.10396Z","end":"2026-02-25T15:00:30.24175Z","steps":["trace[857139691] 'agreement among raft nodes before linearized reading'  (duration: 137.590471ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.242031Z","caller":"traceutil/trace.go:171","msg":"trace[733606903] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"136.692074ms","start":"2026-02-25T15:00:30.105331Z","end":"2026-02-25T15:00:30.242023Z","steps":["trace[733606903] 'process raft request'  (duration: 135.982534ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.242223Z","caller":"traceutil/trace.go:171","msg":"trace[1109380018] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"138.233733ms","start":"2026-02-25T15:00:30.103076Z","end":"2026-02-25T15:00:30.24131Z","steps":["trace[1109380018] 'process raft request'  (duration: 138.132714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.242267Z","caller":"traceutil/trace.go:171","msg":"trace[614457113] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"138.722236ms","start":"2026-02-25T15:00:30.10245Z","end":"2026-02-25T15:00:30.241172Z","steps":["trace[614457113] 'process raft request'  (duration: 138.633547ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.359481Z","caller":"traceutil/trace.go:171","msg":"trace[1544909530] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"111.485498ms","start":"2026-02-25T15:00:30.247968Z","end":"2026-02-25T15:00:30.359453Z","steps":["trace[1544909530] 'process raft request'  (duration: 111.34795ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:30.36525Z","caller":"traceutil/trace.go:171","msg":"trace[194876800] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"116.884514ms","start":"2026-02-25T15:00:30.248351Z","end":"2026-02-25T15:00:30.365236Z","steps":["trace[194876800] 'process raft request'  (duration: 116.794115ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:00:58.60083Z","caller":"traceutil/trace.go:171","msg":"trace[340259858] linearizableReadLoop","detail":"{readStateIndex:874; appliedIndex:873; }","duration":"120.187818ms","start":"2026-02-25T15:00:58.480618Z","end":"2026-02-25T15:00:58.600806Z","steps":["trace[340259858] 'read index received'  (duration: 112.617217ms)","trace[340259858] 'applied index is now lower than readState.Index'  (duration: 7.569241ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:00:58.600954Z","caller":"traceutil/trace.go:171","msg":"trace[143767959] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"122.203215ms","start":"2026-02-25T15:00:58.478728Z","end":"2026-02-25T15:00:58.600931Z","steps":["trace[143767959] 'process raft request'  (duration: 114.601964ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:58.601055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.413822ms","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-25T15:00:58.601103Z","caller":"traceutil/trace.go:171","msg":"trace[925105763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:840; }","duration":"120.502554ms","start":"2026-02-25T15:00:58.480588Z","end":"2026-02-25T15:00:58.60109Z","steps":["trace[925105763] 'agreement among raft nodes before linearized reading'  (duration: 120.345991ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:00:58.60112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.683731ms","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-25T15:00:58.601182Z","caller":"traceutil/trace.go:171","msg":"trace[192630690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:840; }","duration":"118.792072ms","start":"2026-02-25T15:00:58.482374Z","end":"2026-02-25T15:00:58.601166Z","steps":["trace[192630690] 'agreement among raft nodes before linearized reading'  (duration: 118.617499ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:00.770291Z","caller":"traceutil/trace.go:171","msg":"trace[123041796] transaction","detail":"{read_only:false; response_revision:847; number_of_response:1; }","duration":"120.315527ms","start":"2026-02-25T15:01:00.64995Z","end":"2026-02-25T15:01:00.770265Z","steps":["trace[123041796] 'process raft request'  (duration: 73.450394ms)","trace[123041796] 'compare'  (duration: 46.641349ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:00.770441Z","caller":"traceutil/trace.go:171","msg":"trace[291551677] transaction","detail":"{read_only:false; response_revision:848; number_of_response:1; }","duration":"120.156323ms","start":"2026-02-25T15:01:00.650258Z","end":"2026-02-25T15:01:00.770414Z","steps":["trace[291551677] 'process raft request'  (duration: 119.958879ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:16.774542Z","caller":"traceutil/trace.go:171","msg":"trace[805205754] linearizableReadLoop","detail":"{readStateIndex:925; appliedIndex:924; }","duration":"216.429193ms","start":"2026-02-25T15:01:16.558082Z","end":"2026-02-25T15:01:16.774511Z","steps":["trace[805205754] 'read index received'  (duration: 216.292829ms)","trace[805205754] 'applied index is now lower than readState.Index'  (duration: 135.224µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:16.774802Z","caller":"traceutil/trace.go:171","msg":"trace[953485963] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"380.484545ms","start":"2026-02-25T15:01:16.394287Z","end":"2026-02-25T15:01:16.774771Z","steps":["trace[953485963] 'process raft request'  (duration: 380.01351ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:16.774871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.769965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-02-25T15:01:16.775035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.394268Z","time spent":"380.642121ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:882 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"info","ts":"2026-02-25T15:01:16.775047Z","caller":"traceutil/trace.go:171","msg":"trace[1258549984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:887; }","duration":"216.94835ms","start":"2026-02-25T15:01:16.558037Z","end":"2026-02-25T15:01:16.774986Z","steps":["trace[1258549984] 'agreement among raft nodes before linearized reading'  (duration: 216.649101ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:17.092512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.148999ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678180249 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:883 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:01:17.092718Z","caller":"traceutil/trace.go:171","msg":"trace[1649013937] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"313.224039ms","start":"2026-02-25T15:01:16.779462Z","end":"2026-02-25T15:01:17.092686Z","steps":["trace[1649013937] 'process raft request'  (duration: 155.76304ms)","trace[1649013937] 'compare'  (duration: 156.994403ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:17.092786Z","caller":"traceutil/trace.go:171","msg":"trace[156947463] linearizableReadLoop","detail":"{readStateIndex:927; appliedIndex:926; }","duration":"239.732393ms","start":"2026-02-25T15:01:16.853037Z","end":"2026-02-25T15:01:17.092769Z","steps":["trace[156947463] 'read index received'  (duration: 82.205422ms)","trace[156947463] 'applied index is now lower than readState.Index'  (duration: 157.524091ms)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:17.092787Z","caller":"traceutil/trace.go:171","msg":"trace[1231391654] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"215.652791ms","start":"2026-02-25T15:01:16.877097Z","end":"2026-02-25T15:01:17.09275Z","steps":["trace[1231391654] 'process raft request'  (duration: 215.556738ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:17.092862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T15:01:16.779406Z","time spent":"313.379664ms","remote":"127.0.0.1:36104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:883 > 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-25T15:01:17.092992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.951011ms","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-25T15:01:17.093038Z","caller":"traceutil/trace.go:171","msg":"trace[106865149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:890; }","duration":"240.039564ms","start":"2026-02-25T15:01:16.852985Z","end":"2026-02-25T15:01:17.093025Z","steps":["trace[106865149] 'agreement among raft nodes before linearized reading'  (duration: 239.837087ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:17.093088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.691952ms","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-25T15:01:17.093187Z","caller":"traceutil/trace.go:171","msg":"trace[1015416725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:890; }","duration":"211.828117ms","start":"2026-02-25T15:01:16.881337Z","end":"2026-02-25T15:01:17.093165Z","steps":["trace[1015416725] 'agreement among raft nodes before linearized reading'  (duration: 211.592549ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:19.274011Z","caller":"traceutil/trace.go:171","msg":"trace[1463028256] linearizableReadLoop","detail":"{readStateIndex:934; appliedIndex:933; }","duration":"116.898158ms","start":"2026-02-25T15:01:19.157096Z","end":"2026-02-25T15:01:19.273994Z","steps":["trace[1463028256] 'read index received'  (duration: 116.753583ms)","trace[1463028256] 'applied index is now lower than readState.Index'  (duration: 144.025µs)"],"step_count":2}
{"level":"info","ts":"2026-02-25T15:01:19.274077Z","caller":"traceutil/trace.go:171","msg":"trace[673169429] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"143.800097ms","start":"2026-02-25T15:01:19.130261Z","end":"2026-02-25T15:01:19.274061Z","steps":["trace[673169429] 'process raft request'  (duration: 143.635591ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:19.274164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.053323ms","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-25T15:01:19.274182Z","caller":"traceutil/trace.go:171","msg":"trace[1733499919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:896; }","duration":"117.109965ms","start":"2026-02-25T15:01:19.157068Z","end":"2026-02-25T15:01:19.274178Z","steps":["trace[1733499919] 'agreement among raft nodes before linearized reading'  (duration: 116.998791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:19.274425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.988782ms","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-25T15:01:19.274514Z","caller":"traceutil/trace.go:171","msg":"trace[1087532568] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:896; }","duration":"105.100217ms","start":"2026-02-25T15:01:19.169375Z","end":"2026-02-25T15:01:19.274475Z","steps":["trace[1087532568] 'agreement among raft nodes before linearized reading'  (duration: 104.889309ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:22.962209Z","caller":"traceutil/trace.go:171","msg":"trace[1228770308] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"125.630725ms","start":"2026-02-25T15:01:22.83656Z","end":"2026-02-25T15:01:22.96219Z","steps":["trace[1228770308] 'process raft request'  (duration: 125.51473ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-25T15:01:25.626701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.631614ms","expected-duration":"100ms","prefix":"","request":"header:<ID:2398338966678180327 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:909 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-25T15:01:25.626789Z","caller":"traceutil/trace.go:171","msg":"trace[867822104] linearizableReadLoop","detail":"{readStateIndex:953; appliedIndex:952; }","duration":"156.462947ms","start":"2026-02-25T15:01:25.470313Z","end":"2026-02-25T15:01:25.626776Z","steps":["trace[867822104] 'read index received'  (duration: 51.692148ms)","trace[867822104] 'applied index is now lower than readState.Index'  (duration: 104.769899ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-25T15:01:25.626834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.516559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-25T15:01:25.626858Z","caller":"traceutil/trace.go:171","msg":"trace[2030539853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:914; }","duration":"156.553521ms","start":"2026-02-25T15:01:25.470294Z","end":"2026-02-25T15:01:25.626847Z","steps":["trace[2030539853] 'agreement among raft nodes before linearized reading'  (duration: 156.515569ms)"],"step_count":1}
{"level":"info","ts":"2026-02-25T15:01:25.626871Z","caller":"traceutil/trace.go:171","msg":"trace[1946326828] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"171.431695ms","start":"2026-02-25T15:01:25.455394Z","end":"2026-02-25T15:01:25.626826Z","steps":["trace[1946326828] 'process raft request'  (duration: 66.597284ms)","trace[1946326828] 'compare'  (duration: 104.529419ms)"],"step_count":2}