{"level":"warn","ts":"2026-02-05T17:32:07.026716Z","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-05T17:32:07.026788Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.49:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.49:2380","--initial-cluster=instance=https://162.253.55.49:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.49:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.49: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-05T17:32:07.026847Z","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-05T17:32:07.026856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.49:2380"]}
{"level":"info","ts":"2026-02-05T17:32:07.026872Z","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-05T17:32:07.027505Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"]}
{"level":"info","ts":"2026-02-05T17:32:07.027748Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.49: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-05T17:32:07.037312Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.378106ms"}
{"level":"info","ts":"2026-02-05T17:32:07.066593Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a9ba61e55fef5be","cluster-id":"9612db6e19ac6ce7"}
{"level":"info","ts":"2026-02-05T17:32:07.066645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=()"}
{"level":"info","ts":"2026-02-05T17:32:07.066663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 0"}
{"level":"info","ts":"2026-02-05T17:32:07.06667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a9ba61e55fef5be [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-02-05T17:32:07.066678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became follower at term 1"}
{"level":"info","ts":"2026-02-05T17:32:07.066706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"}
{"level":"warn","ts":"2026-02-05T17:32:07.08388Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-02-05T17:32:07.09051Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-02-05T17:32:07.096654Z","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-05T17:32:07.104966Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a9ba61e55fef5be","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-02-05T17:32:07.105298Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a9ba61e55fef5be","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-02-05T17:32:07.105411Z","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-05T17:32:07.105433Z","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-05T17:32:07.105441Z","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-05T17:32:07.106088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be switched to configuration voters=(7681916238632515006)"}
{"level":"info","ts":"2026-02-05T17:32:07.10616Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","added-peer-id":"6a9ba61e55fef5be","added-peer-peer-urls":["https://162.253.55.49:2380"]}
{"level":"info","ts":"2026-02-05T17:32:07.132798Z","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-05T17:32:07.132896Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.49:2380"}
{"level":"info","ts":"2026-02-05T17:32:07.132906Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.49:2380"}
{"level":"info","ts":"2026-02-05T17:32:07.135953Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a9ba61e55fef5be","initial-advertise-peer-urls":["https://162.253.55.49:2380"],"listen-peer-urls":["https://162.253.55.49:2380"],"advertise-client-urls":["https://162.253.55.49:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.49:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-02-05T17:32:07.136045Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-02-05T17:32:07.6676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be is starting a new election at term 1"}
{"level":"info","ts":"2026-02-05T17:32:07.667779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became pre-candidate at term 1"}
{"level":"info","ts":"2026-02-05T17:32:07.667819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgPreVoteResp from 6a9ba61e55fef5be at term 1"}
{"level":"info","ts":"2026-02-05T17:32:07.667856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became candidate at term 2"}
{"level":"info","ts":"2026-02-05T17:32:07.667875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be received MsgVoteResp from 6a9ba61e55fef5be at term 2"}
{"level":"info","ts":"2026-02-05T17:32:07.66791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a9ba61e55fef5be became leader at term 2"}
{"level":"info","ts":"2026-02-05T17:32:07.667974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a9ba61e55fef5be elected leader 6a9ba61e55fef5be at term 2"}
{"level":"info","ts":"2026-02-05T17:32:07.673027Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T17:32:07.67835Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a9ba61e55fef5be","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.49:2379]}","request-path":"/0/members/6a9ba61e55fef5be/attributes","cluster-id":"9612db6e19ac6ce7","publish-timeout":"7s"}
{"level":"info","ts":"2026-02-05T17:32:07.678372Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-05T17:32:07.680622Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-02-05T17:32:07.682626Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-02-05T17:32:07.68518Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-02-05T17:32:07.685195Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-02-05T17:32:07.686353Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.49:2379"}
{"level":"info","ts":"2026-02-05T17:32:07.706392Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9612db6e19ac6ce7","local-member-id":"6a9ba61e55fef5be","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T17:32:07.706518Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T17:32:07.709019Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-02-05T17:32:09.484189Z","caller":"traceutil/trace.go:171","msg":"trace[1897361061] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"102.914654ms","start":"2026-02-05T17:32:09.381212Z","end":"2026-02-05T17:32:09.484127Z","steps":["trace[1897361061] 'process raft request'  (duration: 102.50904ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:09.715324Z","caller":"traceutil/trace.go:171","msg":"trace[504976076] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"329.989784ms","start":"2026-02-05T17:32:09.385309Z","end":"2026-02-05T17:32:09.715299Z","steps":["trace[504976076] 'read index received'  (duration: 98.704967ms)","trace[504976076] 'applied index is now lower than readState.Index'  (duration: 231.283727ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:09.71566Z","caller":"traceutil/trace.go:171","msg":"trace[1415151929] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"295.863637ms","start":"2026-02-05T17:32:09.419783Z","end":"2026-02-05T17:32:09.715626Z","steps":["trace[1415151929] 'process raft request'  (duration: 295.153281ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:09.716066Z","caller":"traceutil/trace.go:171","msg":"trace[1129094739] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"294.128782ms","start":"2026-02-05T17:32:09.421925Z","end":"2026-02-05T17:32:09.716054Z","steps":["trace[1129094739] 'process raft request'  (duration: 293.063092ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:09.716432Z","caller":"traceutil/trace.go:171","msg":"trace[1393964552] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"331.176325ms","start":"2026-02-05T17:32:09.385226Z","end":"2026-02-05T17:32:09.716403Z","steps":["trace[1393964552] 'process raft request'  (duration: 329.305528ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.721353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.71392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"warn","ts":"2026-02-05T17:32:09.721749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.385212Z","time spent":"335.018629ms","remote":"127.0.0.1:36472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/ranges/servicenodeports\" mod_revision:0 > success:<request_put:<key:\"/registry/ranges/servicenodeports\" value_size:66 >> failure:<request_range:<key:\"/registry/ranges/servicenodeports\" > >"}
{"level":"info","ts":"2026-02-05T17:32:09.721391Z","caller":"traceutil/trace.go:171","msg":"trace[1272050756] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"301.792251ms","start":"2026-02-05T17:32:09.419588Z","end":"2026-02-05T17:32:09.72138Z","steps":["trace[1272050756] 'agreement among raft nodes before linearized reading'  (duration: 301.611139ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.722913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.419573Z","time spent":"303.305014ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-05T17:32:09.71662Z","caller":"traceutil/trace.go:171","msg":"trace[29590848] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"268.704043ms","start":"2026-02-05T17:32:09.44791Z","end":"2026-02-05T17:32:09.716614Z","steps":["trace[29590848] 'process raft request'  (duration: 267.22215ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:09.716654Z","caller":"traceutil/trace.go:171","msg":"trace[1504471189] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"294.549485ms","start":"2026-02-05T17:32:09.4221Z","end":"2026-02-05T17:32:09.716649Z","steps":["trace[1504471189] 'process raft request'  (duration: 292.927331ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.724134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.042062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:09.724191Z","caller":"traceutil/trace.go:171","msg":"trace[398281001] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"253.107622ms","start":"2026-02-05T17:32:09.471049Z","end":"2026-02-05T17:32:09.724157Z","steps":["trace[398281001] 'agreement among raft nodes before linearized reading'  (duration: 252.8798ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.724586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.645263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:09.724618Z","caller":"traceutil/trace.go:171","msg":"trace[1154179258] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"287.700323ms","start":"2026-02-05T17:32:09.436905Z","end":"2026-02-05T17:32:09.724605Z","steps":["trace[1154179258] 'agreement among raft nodes before linearized reading'  (duration: 287.516102ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.724931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.422092Z","time spent":"302.801939ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authentication.k8s.io\" value_size:894 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:09.716673Z","caller":"traceutil/trace.go:171","msg":"trace[652981631] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"294.478006ms","start":"2026-02-05T17:32:09.42219Z","end":"2026-02-05T17:32:09.716668Z","steps":["trace[652981631] 'process raft request'  (duration: 292.861951ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.729139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.422186Z","time spent":"306.365062ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apps\" value_size:860 >> failure:<>"}
{"level":"warn","ts":"2026-02-05T17:32:09.725037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.196501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:09.729309Z","caller":"traceutil/trace.go:171","msg":"trace[661013138] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"309.421659ms","start":"2026-02-05T17:32:09.419824Z","end":"2026-02-05T17:32:09.729245Z","steps":["trace[661013138] 'agreement among raft nodes before linearized reading'  (duration: 305.04138ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.729335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.419783Z","time spent":"309.54549ms","remote":"127.0.0.1:36500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "}
{"level":"info","ts":"2026-02-05T17:32:09.716701Z","caller":"traceutil/trace.go:171","msg":"trace[1665278514] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"294.467825ms","start":"2026-02-05T17:32:09.422228Z","end":"2026-02-05T17:32:09.716696Z","steps":["trace[1665278514] 'process raft request'  (duration: 292.84934ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.730271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.422223Z","time spent":"307.420981ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.admissionregistration.k8s.io\" value_size:908 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:09.716718Z","caller":"traceutil/trace.go:171","msg":"trace[332513170] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"294.455615ms","start":"2026-02-05T17:32:09.422258Z","end":"2026-02-05T17:32:09.716714Z","steps":["trace[332513170] 'process raft request'  (duration: 292.83872ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.730485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.422247Z","time spent":"308.173648ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.apiextensions.k8s.io\" value_size:892 >> failure:<>"}
{"level":"warn","ts":"2026-02-05T17:32:09.717427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.095713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2858"}
{"level":"info","ts":"2026-02-05T17:32:09.730682Z","caller":"traceutil/trace.go:171","msg":"trace[1780861252] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"345.377642ms","start":"2026-02-05T17:32:09.385297Z","end":"2026-02-05T17:32:09.730675Z","steps":["trace[1780861252] 'agreement among raft nodes before linearized reading'  (duration: 331.497978ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.730723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.385294Z","time spent":"345.418613ms","remote":"127.0.0.1:36610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":2881,"request content":"key:\"/registry/minions/instance\" "}
{"level":"info","ts":"2026-02-05T17:32:09.717905Z","caller":"traceutil/trace.go:171","msg":"trace[2057721498] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"250.179426ms","start":"2026-02-05T17:32:09.46771Z","end":"2026-02-05T17:32:09.71789Z","steps":["trace[2057721498] 'process raft request'  (duration: 247.544213ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.725238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.571454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:09.731008Z","caller":"traceutil/trace.go:171","msg":"trace[1769817816] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:0; response_revision:11; }","duration":"311.332366ms","start":"2026-02-05T17:32:09.419649Z","end":"2026-02-05T17:32:09.730982Z","steps":["trace[1769817816] 'agreement among raft nodes before linearized reading'  (duration: 305.425103ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:09.731032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.419646Z","time spent":"311.380316ms","remote":"127.0.0.1:36456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"info","ts":"2026-02-05T17:32:10.228098Z","caller":"traceutil/trace.go:171","msg":"trace[78119208] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"501.376223ms","start":"2026-02-05T17:32:09.726698Z","end":"2026-02-05T17:32:10.228074Z","steps":["trace[78119208] 'process raft request'  (duration: 453.993902ms)","trace[78119208] 'compare'  (duration: 47.26539ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:10.228285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.726675Z","time spent":"501.511264ms","remote":"127.0.0.1:36916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/node-high\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/node-high\" value_size:649 >> failure:<>"}
{"level":"warn","ts":"2026-02-05T17:32:10.648361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.052855ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948787331 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" value_size:892 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-02-05T17:32:10.64945Z","caller":"traceutil/trace.go:171","msg":"trace[825148145] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"916.895094ms","start":"2026-02-05T17:32:09.732525Z","end":"2026-02-05T17:32:10.64942Z","steps":["trace[825148145] 'process raft request'  (duration: 641.589668ms)","trace[825148145] 'compare'  (duration: 273.880413ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:10.6497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.732515Z","time spent":"917.099856ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.authorization.k8s.io\" value_size:892 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.650141Z","caller":"traceutil/trace.go:171","msg":"trace[1403610361] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"912.02019ms","start":"2026-02-05T17:32:09.738109Z","end":"2026-02-05T17:32:10.650129Z","steps":["trace[1403610361] 'process raft request'  (duration: 911.173773ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.65105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738102Z","time spent":"912.906178ms","remote":"127.0.0.1:36858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/csinodes/instance\" mod_revision:0 > success:<request_put:<key:\"/registry/csinodes/instance\" value_size:616 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.651715Z","caller":"traceutil/trace.go:171","msg":"trace[580462812] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"419.78146ms","start":"2026-02-05T17:32:10.231903Z","end":"2026-02-05T17:32:10.651685Z","steps":["trace[580462812] 'process raft request'  (duration: 419.73402ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.651868Z","caller":"traceutil/trace.go:171","msg":"trace[1422584511] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"913.374053ms","start":"2026-02-05T17:32:09.73848Z","end":"2026-02-05T17:32:10.651854Z","steps":["trace[1422584511] 'process raft request'  (duration: 913.01714ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.652045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738477Z","time spent":"913.502034ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.batch\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.batch\" value_size:862 >> failure:<>"}
{"level":"warn","ts":"2026-02-05T17:32:10.652333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:10.231841Z","time spent":"419.958571ms","remote":"127.0.0.1:36916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/prioritylevelconfigurations/leader-election\" mod_revision:0 > success:<request_put:<key:\"/registry/prioritylevelconfigurations/leader-election\" value_size:655 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.652376Z","caller":"traceutil/trace.go:171","msg":"trace[841945860] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"914.096188ms","start":"2026-02-05T17:32:09.738266Z","end":"2026-02-05T17:32:10.652362Z","steps":["trace[841945860] 'process raft request'  (duration: 911.149372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.652625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738262Z","time spent":"914.26195ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.65281Z","caller":"traceutil/trace.go:171","msg":"trace[1769745059] transaction","detail":"{read_only:false; number_of_response:0; response_revision:15; }","duration":"914.504192ms","start":"2026-02-05T17:32:09.738297Z","end":"2026-02-05T17:32:10.652801Z","steps":["trace[1769745059] 'process raft request'  (duration: 911.157712ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.652928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738294Z","time spent":"914.615103ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/namespaces/kube-system\" mod_revision:0 > success:<request_put:<key:\"/registry/namespaces/kube-system\" value_size:298 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.653152Z","caller":"traceutil/trace.go:171","msg":"trace[292591369] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"914.745274ms","start":"2026-02-05T17:32:09.738399Z","end":"2026-02-05T17:32:10.653144Z","steps":["trace[292591369] 'process raft request'  (duration: 911.082902ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.653281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738395Z","time spent":"914.840425ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v2.autoscaling\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v2.autoscaling\" value_size:874 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.653436Z","caller":"traceutil/trace.go:171","msg":"trace[1310736025] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"914.967667ms","start":"2026-02-05T17:32:09.738457Z","end":"2026-02-05T17:32:10.653425Z","steps":["trace[1310736025] 'process raft request'  (duration: 912.962249ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.653559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738454Z","time spent":"915.086458ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.autoscaling\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.autoscaling\" value_size:874 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.654023Z","caller":"traceutil/trace.go:171","msg":"trace[1530248429] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"914.008908ms","start":"2026-02-05T17:32:09.740003Z","end":"2026-02-05T17:32:10.654012Z","steps":["trace[1530248429] 'process raft request'  (duration: 911.562966ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.654182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.739998Z","time spent":"914.120049ms","remote":"127.0.0.1:36610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3166,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:10 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3132 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-02-05T17:32:10.654357Z","caller":"traceutil/trace.go:171","msg":"trace[1279689894] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"915.614072ms","start":"2026-02-05T17:32:09.738726Z","end":"2026-02-05T17:32:10.65434Z","steps":["trace[1279689894] 'process raft request'  (duration: 912.802027ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.654485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.73872Z","time spent":"915.742933ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v1.certificates.k8s.io\" value_size:890 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:10.654896Z","caller":"traceutil/trace.go:171","msg":"trace[628764335] linearizableReadLoop","detail":"{readStateIndex:17; appliedIndex:14; }","duration":"916.734512ms","start":"2026-02-05T17:32:09.738152Z","end":"2026-02-05T17:32:10.654887Z","steps":["trace[628764335] 'read index received'  (duration: 442.623789ms)","trace[628764335] 'applied index is now lower than readState.Index'  (duration: 474.109763ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:10.655078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.920563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.65516Z","caller":"traceutil/trace.go:171","msg":"trace[1262003085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21; }","duration":"917.016525ms","start":"2026-02-05T17:32:09.738135Z","end":"2026-02-05T17:32:10.655151Z","steps":["trace[1262003085] 'agreement among raft nodes before linearized reading'  (duration: 916.913514ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.655226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738131Z","time spent":"917.088096ms","remote":"127.0.0.1:36418","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-05T17:32:10.655442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"917.259577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-75zt7\" ","response":"range_response_count:1 size:861"}
{"level":"info","ts":"2026-02-05T17:32:10.655534Z","caller":"traceutil/trace.go:171","msg":"trace[1088127565] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-75zt7; range_end:; response_count:1; response_revision:21; }","duration":"917.355157ms","start":"2026-02-05T17:32:09.738171Z","end":"2026-02-05T17:32:10.655526Z","steps":["trace[1088127565] 'agreement among raft nodes before linearized reading'  (duration: 917.246146ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.655581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.738168Z","time spent":"917.405838ms","remote":"127.0.0.1:36704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-75zt7\" "}
{"level":"warn","ts":"2026-02-05T17:32:10.655847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.292907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.655958Z","caller":"traceutil/trace.go:171","msg":"trace[549944453] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:21; }","duration":"337.445419ms","start":"2026-02-05T17:32:10.318505Z","end":"2026-02-05T17:32:10.65595Z","steps":["trace[549944453] 'agreement among raft nodes before linearized reading'  (duration: 337.322498ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.656039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:10.318483Z","time spent":"337.54727ms","remote":"127.0.0.1:36802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "}
{"level":"warn","ts":"2026-02-05T17:32:10.656214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.815142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.656302Z","caller":"traceutil/trace.go:171","msg":"trace[1525420944] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:21; }","duration":"337.932923ms","start":"2026-02-05T17:32:10.318361Z","end":"2026-02-05T17:32:10.656294Z","steps":["trace[1525420944] 'agreement among raft nodes before linearized reading'  (duration: 337.831442ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.656393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:10.318336Z","time spent":"338.025314ms","remote":"127.0.0.1:36832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "}
{"level":"warn","ts":"2026-02-05T17:32:10.656591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.148376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-02-05T17:32:10.656697Z","caller":"traceutil/trace.go:171","msg":"trace[505113397] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"490.291586ms","start":"2026-02-05T17:32:10.166375Z","end":"2026-02-05T17:32:10.656666Z","steps":["trace[505113397] 'agreement among raft nodes before linearized reading'  (duration: 490.172285ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.656768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:10.166361Z","time spent":"490.399497ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-02-05T17:32:10.656938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.794046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.657017Z","caller":"traceutil/trace.go:171","msg":"trace[1532111982] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:21; }","duration":"726.892477ms","start":"2026-02-05T17:32:09.930116Z","end":"2026-02-05T17:32:10.657009Z","steps":["trace[1532111982] 'agreement among raft nodes before linearized reading'  (duration: 726.804647ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.657085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.930106Z","time spent":"726.972048ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "}
{"level":"warn","ts":"2026-02-05T17:32:10.657423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.470205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-02-05T17:32:10.657479Z","caller":"traceutil/trace.go:171","msg":"trace[1672442771] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:21; }","duration":"871.534836ms","start":"2026-02-05T17:32:09.785935Z","end":"2026-02-05T17:32:10.65747Z","steps":["trace[1672442771] 'agreement among raft nodes before linearized reading'  (duration: 871.433855ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.657671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:09.785929Z","time spent":"871.736017ms","remote":"127.0.0.1:36534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-02-05T17:32:10.933356Z","caller":"traceutil/trace.go:171","msg":"trace[1506030392] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"262.661906ms","start":"2026-02-05T17:32:10.670647Z","end":"2026-02-05T17:32:10.933309Z","steps":["trace[1506030392] 'process raft request'  (duration: 247.656712ms)","trace[1506030392] 'compare'  (duration: 14.808492ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:10.933753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.136763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.933802Z","caller":"traceutil/trace.go:171","msg":"trace[2071854299] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:30; }","duration":"260.223674ms","start":"2026-02-05T17:32:10.673565Z","end":"2026-02-05T17:32:10.933789Z","steps":["trace[2071854299] 'agreement among raft nodes before linearized reading'  (duration: 260.090493ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.934064Z","caller":"traceutil/trace.go:171","msg":"trace[1900788218] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"263.317691ms","start":"2026-02-05T17:32:10.670735Z","end":"2026-02-05T17:32:10.934053Z","steps":["trace[1900788218] 'process raft request'  (duration: 262.503754ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.934142Z","caller":"traceutil/trace.go:171","msg":"trace[956843658] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"263.340192ms","start":"2026-02-05T17:32:10.670795Z","end":"2026-02-05T17:32:10.934136Z","steps":["trace[956843658] 'process raft request'  (duration: 262.471674ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.934278Z","caller":"traceutil/trace.go:171","msg":"trace[1706423924] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"262.04705ms","start":"2026-02-05T17:32:10.672225Z","end":"2026-02-05T17:32:10.934272Z","steps":["trace[1706423924] 'process raft request'  (duration: 261.062122ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.934486Z","caller":"traceutil/trace.go:171","msg":"trace[1585218182] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"261.100242ms","start":"2026-02-05T17:32:10.673377Z","end":"2026-02-05T17:32:10.934477Z","steps":["trace[1585218182] 'process raft request'  (duration: 260.004982ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.933552Z","caller":"traceutil/trace.go:171","msg":"trace[928257705] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:26; }","duration":"211.226229ms","start":"2026-02-05T17:32:10.7223Z","end":"2026-02-05T17:32:10.933526Z","steps":["trace[928257705] 'read index received'  (duration: 196.021633ms)","trace[928257705] 'applied index is now lower than readState.Index'  (duration: 15.203646ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:10.93742Z","caller":"traceutil/trace.go:171","msg":"trace[1620275786] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"263.905407ms","start":"2026-02-05T17:32:10.673501Z","end":"2026-02-05T17:32:10.937407Z","steps":["trace[1620275786] 'process raft request'  (duration: 259.925932ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.937584Z","caller":"traceutil/trace.go:171","msg":"trace[1682620312] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"263.962738ms","start":"2026-02-05T17:32:10.673615Z","end":"2026-02-05T17:32:10.937577Z","steps":["trace[1682620312] 'process raft request'  (duration: 259.846181ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.937681Z","caller":"traceutil/trace.go:171","msg":"trace[1319357326] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"264.016237ms","start":"2026-02-05T17:32:10.673655Z","end":"2026-02-05T17:32:10.937671Z","steps":["trace[1319357326] 'process raft request'  (duration: 259.844441ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.937792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.153049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.937818Z","caller":"traceutil/trace.go:171","msg":"trace[1285387437] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:30; }","duration":"264.19098ms","start":"2026-02-05T17:32:10.673621Z","end":"2026-02-05T17:32:10.937812Z","steps":["trace[1285387437] 'agreement among raft nodes before linearized reading'  (duration: 264.143919ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.937925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.330071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.937953Z","caller":"traceutil/trace.go:171","msg":"trace[158316041] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:30; }","duration":"264.368731ms","start":"2026-02-05T17:32:10.673579Z","end":"2026-02-05T17:32:10.937948Z","steps":["trace[158316041] 'agreement among raft nodes before linearized reading'  (duration: 264.330401ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:10.993539Z","caller":"traceutil/trace.go:171","msg":"trace[1749660217] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"265.537291ms","start":"2026-02-05T17:32:10.72798Z","end":"2026-02-05T17:32:10.993517Z","steps":["trace[1749660217] 'process raft request'  (duration: 265.392729ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.993625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.698061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.993683Z","caller":"traceutil/trace.go:171","msg":"trace[18500048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:31; }","duration":"221.812432ms","start":"2026-02-05T17:32:10.771855Z","end":"2026-02-05T17:32:10.993668Z","steps":["trace[18500048] 'agreement among raft nodes before linearized reading'  (duration: 221.676071ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:10.993863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.78747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-02-05T17:32:10.993878Z","caller":"traceutil/trace.go:171","msg":"trace[1702261392] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:31; }","duration":"268.822441ms","start":"2026-02-05T17:32:10.72505Z","end":"2026-02-05T17:32:10.993873Z","steps":["trace[1702261392] 'agreement among raft nodes before linearized reading'  (duration: 268.796051ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:12.75041Z","caller":"traceutil/trace.go:171","msg":"trace[2056316926] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"105.847842ms","start":"2026-02-05T17:32:12.644533Z","end":"2026-02-05T17:32:12.750381Z","steps":["trace[2056316926] 'process raft request'  (duration: 97.55935ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:22.70204Z","caller":"traceutil/trace.go:171","msg":"trace[746750008] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"175.33453ms","start":"2026-02-05T17:32:22.52668Z","end":"2026-02-05T17:32:22.702015Z","steps":["trace[746750008] 'process raft request'  (duration: 175.201709ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.06195Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788052,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:26.562985Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788052,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:26.778069Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.533158818s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-05T17:32:26.778493Z","caller":"traceutil/trace.go:171","msg":"trace[2132458636] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:389; }","duration":"1.217118411s","start":"2026-02-05T17:32:25.561354Z","end":"2026-02-05T17:32:26.778473Z","steps":["trace[2132458636] 'read index received'  (duration: 1.216848169s)","trace[2132458636] 'applied index is now lower than readState.Index'  (duration: 269.432µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:26.778574Z","caller":"traceutil/trace.go:171","msg":"trace[2021171462] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"1.533736123s","start":"2026-02-05T17:32:25.244829Z","end":"2026-02-05T17:32:26.778565Z","steps":["trace[2021171462] 'process raft request'  (duration: 1.533445281s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.77867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:25.244812Z","time spent":"1.533787733s","remote":"127.0.0.1:36920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:347 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4109 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-02-05T17:32:26.77883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217473244s","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-05T17:32:26.778862Z","caller":"traceutil/trace.go:171","msg":"trace[1354642259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:379; }","duration":"1.217536344s","start":"2026-02-05T17:32:25.561314Z","end":"2026-02-05T17:32:26.77885Z","steps":["trace[1354642259] 'agreement among raft nodes before linearized reading'  (duration: 1.217478634s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.778889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:25.561297Z","time spent":"1.217586045s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T17:32:26.779032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.212701667s","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-05T17:32:26.7791Z","caller":"traceutil/trace.go:171","msg":"trace[411506061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"1.212783577s","start":"2026-02-05T17:32:25.566298Z","end":"2026-02-05T17:32:26.779081Z","steps":["trace[411506061] 'agreement among raft nodes before linearized reading'  (duration: 1.212679746s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.779137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:25.56629Z","time spent":"1.212839569s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T17:32:26.779212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.84539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-05T17:32:26.779248Z","caller":"traceutil/trace.go:171","msg":"trace[337244439] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:379; }","duration":"550.9158ms","start":"2026-02-05T17:32:26.228322Z","end":"2026-02-05T17:32:26.779238Z","steps":["trace[337244439] 'agreement among raft nodes before linearized reading'  (duration: 550.85942ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.779273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.228305Z","time spent":"550.962161ms","remote":"127.0.0.1:36716","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-05T17:32:26.779304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.728346ms","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-05T17:32:26.779335Z","caller":"traceutil/trace.go:171","msg":"trace[1722105126] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:379; }","duration":"779.792266ms","start":"2026-02-05T17:32:25.999533Z","end":"2026-02-05T17:32:26.779325Z","steps":["trace[1722105126] 'agreement among raft nodes before linearized reading'  (duration: 779.742206ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.779381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:25.999516Z","time spent":"779.859156ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-05T17:32:26.779397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.997592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:26.779543Z","caller":"traceutil/trace.go:171","msg":"trace[1380740814] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:379; }","duration":"355.170773ms","start":"2026-02-05T17:32:26.424361Z","end":"2026-02-05T17:32:26.779532Z","steps":["trace[1380740814] 'agreement among raft nodes before linearized reading'  (duration: 355.016172ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:26.779576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.424324Z","time spent":"355.241274ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-05T17:32:28.774784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.580367006s","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788057 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:370 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:32:28.774861Z","caller":"traceutil/trace.go:171","msg":"trace[1905655825] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"1.983251747s","start":"2026-02-05T17:32:26.791596Z","end":"2026-02-05T17:32:28.774848Z","steps":["trace[1905655825] 'process raft request'  (duration: 402.75355ms)","trace[1905655825] 'compare'  (duration: 1.580047653s)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:28.774895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.791584Z","time spent":"1.983296427s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:370 > 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-05T17:32:28.804625Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.610332644s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-05T17:32:28.806212Z","caller":"traceutil/trace.go:171","msg":"trace[48786679] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"2.012886703s","start":"2026-02-05T17:32:26.793294Z","end":"2026-02-05T17:32:28.806181Z","steps":["trace[48786679] 'process raft request'  (duration: 2.011928846s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:28.817453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.793288Z","time spent":"2.024071979s","remote":"127.0.0.1:36952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" value_size:3596 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:28.818822Z","caller":"traceutil/trace.go:171","msg":"trace[805543051] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"2.025366169s","start":"2026-02-05T17:32:26.793438Z","end":"2026-02-05T17:32:28.818804Z","steps":["trace[805543051] 'process raft request'  (duration: 2.012020167s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:28.819182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.793434Z","time spent":"2.025614701s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:377 > 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-05T17:32:28.819674Z","caller":"traceutil/trace.go:171","msg":"trace[221131625] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"2.026255476s","start":"2026-02-05T17:32:26.79341Z","end":"2026-02-05T17:32:28.819666Z","steps":["trace[221131625] 'process raft request'  (duration: 2.011972086s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:28.819897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.793406Z","time spent":"2.026460007s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:371 > 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-05T17:32:28.821785Z","caller":"traceutil/trace.go:171","msg":"trace[1175339239] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"2.027336824s","start":"2026-02-05T17:32:26.794438Z","end":"2026-02-05T17:32:28.821775Z","steps":["trace[1175339239] 'process raft request'  (duration: 2.011073179s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:28.822042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:26.794432Z","time spent":"2.027489775s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:378 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-05T17:32:28.950836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.270411ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788062 > lease_revoke:<id:75be9c2edc7a1bf0>","response":"size:28"}
{"level":"info","ts":"2026-02-05T17:32:28.951004Z","caller":"traceutil/trace.go:171","msg":"trace[865360897] linearizableReadLoop","detail":"{readStateIndex:396; appliedIndex:391; }","duration":"524.226688ms","start":"2026-02-05T17:32:28.426764Z","end":"2026-02-05T17:32:28.950991Z","steps":["trace[865360897] 'read index received'  (duration: 378.377682ms)","trace[865360897] 'applied index is now lower than readState.Index'  (duration: 145.848286ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:28.951047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.274678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:28.951059Z","caller":"traceutil/trace.go:171","msg":"trace[1033746888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:384; }","duration":"524.293398ms","start":"2026-02-05T17:32:28.42676Z","end":"2026-02-05T17:32:28.951054Z","steps":["trace[1033746888] 'agreement among raft nodes before linearized reading'  (duration: 524.262528ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:28.951086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:28.426725Z","time spent":"524.354539ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-05T17:32:28.95159Z","caller":"traceutil/trace.go:171","msg":"trace[1479532827] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"124.698883ms","start":"2026-02-05T17:32:28.826874Z","end":"2026-02-05T17:32:28.951573Z","steps":["trace[1479532827] 'process raft request'  (duration: 124.052318ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:29.073171Z","caller":"traceutil/trace.go:171","msg":"trace[1925915230] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:397; }","duration":"120.223756ms","start":"2026-02-05T17:32:28.952932Z","end":"2026-02-05T17:32:29.073156Z","steps":["trace[1925915230] 'read index received'  (duration: 120.019825ms)","trace[1925915230] 'applied index is now lower than readState.Index'  (duration: 203.121µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:29.073305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.352527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:29.073322Z","caller":"traceutil/trace.go:171","msg":"trace[275334897] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:387; }","duration":"120.412917ms","start":"2026-02-05T17:32:28.952904Z","end":"2026-02-05T17:32:29.073317Z","steps":["trace[275334897] 'agreement among raft nodes before linearized reading'  (duration: 120.316257ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:29.073506Z","caller":"traceutil/trace.go:171","msg":"trace[1197318105] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"243.213816ms","start":"2026-02-05T17:32:28.830287Z","end":"2026-02-05T17:32:29.073501Z","steps":["trace[1197318105] 'process raft request'  (duration: 242.828813ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:29.073625Z","caller":"traceutil/trace.go:171","msg":"trace[2107636589] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"246.577212ms","start":"2026-02-05T17:32:28.827044Z","end":"2026-02-05T17:32:29.073621Z","steps":["trace[2107636589] 'process raft request'  (duration: 245.955937ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:35.225302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.142624ms","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-05T17:32:35.225379Z","caller":"traceutil/trace.go:171","msg":"trace[1720634387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:422; }","duration":"337.270914ms","start":"2026-02-05T17:32:34.888094Z","end":"2026-02-05T17:32:35.225365Z","steps":["trace[1720634387] 'range keys from in-memory index tree'  (duration: 337.065143ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:35.225421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:34.888084Z","time spent":"337.328225ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T17:32:35.225434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.025437ms","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-05T17:32:35.225479Z","caller":"traceutil/trace.go:171","msg":"trace[22168787] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:422; }","duration":"324.078187ms","start":"2026-02-05T17:32:34.901389Z","end":"2026-02-05T17:32:35.225467Z","steps":["trace[22168787] 'range keys from in-memory index tree'  (duration: 323.925616ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:35.225501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:34.901367Z","time spent":"324.129198ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T17:32:35.225584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.126271ms","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-05T17:32:35.225598Z","caller":"traceutil/trace.go:171","msg":"trace[1562758736] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:422; }","duration":"323.151791ms","start":"2026-02-05T17:32:34.90244Z","end":"2026-02-05T17:32:35.225592Z","steps":["trace[1562758736] 'range keys from in-memory index tree'  (duration: 323.09487ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:35.225609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:34.902435Z","time spent":"323.171691ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-05T17:32:35.225834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.474441ms","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-05T17:32:35.225857Z","caller":"traceutil/trace.go:171","msg":"trace[2051017348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:422; }","duration":"339.533512ms","start":"2026-02-05T17:32:34.886317Z","end":"2026-02-05T17:32:35.22585Z","steps":["trace[2051017348] 'range keys from in-memory index tree'  (duration: 339.368931ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:35.225878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:34.886296Z","time spent":"339.577202ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-02-05T17:32:35.495448Z","caller":"traceutil/trace.go:171","msg":"trace[1630641955] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"261.267334ms","start":"2026-02-05T17:32:35.234165Z","end":"2026-02-05T17:32:35.495432Z","steps":["trace[1630641955] 'process raft request'  (duration: 261.189503ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:35.49559Z","caller":"traceutil/trace.go:171","msg":"trace[1677599659] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"261.694897ms","start":"2026-02-05T17:32:35.23389Z","end":"2026-02-05T17:32:35.495585Z","steps":["trace[1677599659] 'process raft request'  (duration: 256.084956ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:35.495726Z","caller":"traceutil/trace.go:171","msg":"trace[1016972889] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"261.426855ms","start":"2026-02-05T17:32:35.234276Z","end":"2026-02-05T17:32:35.495703Z","steps":["trace[1016972889] 'process raft request'  (duration: 261.130423ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:39.799333Z","caller":"traceutil/trace.go:171","msg":"trace[1988217084] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"275.966079ms","start":"2026-02-05T17:32:39.523352Z","end":"2026-02-05T17:32:39.799318Z","steps":["trace[1988217084] 'read index received'  (duration: 275.851548ms)","trace[1988217084] 'applied index is now lower than readState.Index'  (duration: 114.001µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:39.799519Z","caller":"traceutil/trace.go:171","msg":"trace[1382715025] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"282.872358ms","start":"2026-02-05T17:32:39.516641Z","end":"2026-02-05T17:32:39.799514Z","steps":["trace[1382715025] 'process raft request'  (duration: 282.600186ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:39.799632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.268151ms","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-05T17:32:39.799649Z","caller":"traceutil/trace.go:171","msg":"trace[510033789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:467; }","duration":"276.308101ms","start":"2026-02-05T17:32:39.523335Z","end":"2026-02-05T17:32:39.799643Z","steps":["trace[510033789] 'agreement among raft nodes before linearized reading'  (duration: 276.268791ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:39.799713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.326451ms","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-05T17:32:39.799724Z","caller":"traceutil/trace.go:171","msg":"trace[1456927916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:467; }","duration":"276.344412ms","start":"2026-02-05T17:32:39.523376Z","end":"2026-02-05T17:32:39.799721Z","steps":["trace[1456927916] 'agreement among raft nodes before linearized reading'  (duration: 276.325052ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:41.478438Z","caller":"traceutil/trace.go:171","msg":"trace[730564372] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"197.508342ms","start":"2026-02-05T17:32:41.280909Z","end":"2026-02-05T17:32:41.478417Z","steps":["trace[730564372] 'process raft request'  (duration: 197.075109ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:43.074843Z","caller":"traceutil/trace.go:171","msg":"trace[1093810122] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"102.12247ms","start":"2026-02-05T17:32:42.972696Z","end":"2026-02-05T17:32:43.074818Z","steps":["trace[1093810122] 'process raft request'  (duration: 75.869725ms)","trace[1093810122] 'compare'  (duration: 26.121054ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:43.397625Z","caller":"traceutil/trace.go:171","msg":"trace[374987080] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"172.247471ms","start":"2026-02-05T17:32:43.225352Z","end":"2026-02-05T17:32:43.3976Z","steps":["trace[374987080] 'process raft request'  (duration: 124.031992ms)","trace[374987080] 'compare'  (duration: 48.075878ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:43.397764Z","caller":"traceutil/trace.go:171","msg":"trace[435275258] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"161.509826ms","start":"2026-02-05T17:32:43.236239Z","end":"2026-02-05T17:32:43.397749Z","steps":["trace[435275258] 'process raft request'  (duration: 161.327685ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:43.397954Z","caller":"traceutil/trace.go:171","msg":"trace[307852312] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"170.347708ms","start":"2026-02-05T17:32:43.227599Z","end":"2026-02-05T17:32:43.397947Z","steps":["trace[307852312] 'read index received'  (duration: 38.252939ms)","trace[307852312] 'applied index is now lower than readState.Index'  (duration: 132.094279ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:43.397994Z","caller":"traceutil/trace.go:171","msg":"trace[2040687871] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"161.701917ms","start":"2026-02-05T17:32:43.236286Z","end":"2026-02-05T17:32:43.397988Z","steps":["trace[2040687871] 'process raft request'  (duration: 161.406595ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:43.398053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.442879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:3653"}
{"level":"info","ts":"2026-02-05T17:32:43.398072Z","caller":"traceutil/trace.go:171","msg":"trace[1934273691] range","detail":"{range_begin:/registry/deployments/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:496; }","duration":"170.470759ms","start":"2026-02-05T17:32:43.227594Z","end":"2026-02-05T17:32:43.398065Z","steps":["trace[1934273691] 'agreement among raft nodes before linearized reading'  (duration: 170.375799ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:44.115047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.378589ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788297 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:474 > 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\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:32:44.115131Z","caller":"traceutil/trace.go:171","msg":"trace[646513363] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:516; }","duration":"262.807035ms","start":"2026-02-05T17:32:43.852309Z","end":"2026-02-05T17:32:44.115116Z","steps":["trace[646513363] 'read index received'  (duration: 19.241985ms)","trace[646513363] 'applied index is now lower than readState.Index'  (duration: 243.56374ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:44.115209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.895315ms","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-05T17:32:44.115234Z","caller":"traceutil/trace.go:171","msg":"trace[1920445549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:501; }","duration":"262.939646ms","start":"2026-02-05T17:32:43.852286Z","end":"2026-02-05T17:32:44.115225Z","steps":["trace[1920445549] 'agreement among raft nodes before linearized reading'  (duration: 262.870545ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:44.11546Z","caller":"traceutil/trace.go:171","msg":"trace[1233265982] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"263.982753ms","start":"2026-02-05T17:32:43.851466Z","end":"2026-02-05T17:32:44.115449Z","steps":["trace[1233265982] 'process raft request'  (duration: 20.116401ms)","trace[1233265982] 'compare'  (duration: 243.212998ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:44.971235Z","caller":"traceutil/trace.go:171","msg":"trace[2135699254] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"851.823474ms","start":"2026-02-05T17:32:44.119385Z","end":"2026-02-05T17:32:44.971208Z","steps":["trace[2135699254] 'process raft request'  (duration: 851.671473ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:44.971968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:44.119364Z","time spent":"852.51754ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:475 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-05T17:32:45.003769Z","caller":"traceutil/trace.go:171","msg":"trace[973256075] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:518; }","duration":"267.049469ms","start":"2026-02-05T17:32:44.736703Z","end":"2026-02-05T17:32:45.003752Z","steps":["trace[973256075] 'read index received'  (duration: 234.900934ms)","trace[973256075] 'applied index is now lower than readState.Index'  (duration: 32.147725ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:45.003869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.148669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:45.003887Z","caller":"traceutil/trace.go:171","msg":"trace[687340420] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"267.18317ms","start":"2026-02-05T17:32:44.736698Z","end":"2026-02-05T17:32:45.003881Z","steps":["trace[687340420] 'agreement among raft nodes before linearized reading'  (duration: 267.116259ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:45.004067Z","caller":"traceutil/trace.go:171","msg":"trace[20578769] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"459.729209ms","start":"2026-02-05T17:32:44.544332Z","end":"2026-02-05T17:32:45.004061Z","steps":["trace[20578769] 'process raft request'  (duration: 459.333506ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:45.004119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:44.544294Z","time spent":"459.785199ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:422 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-05T17:32:50.081806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.401881ms","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-05T17:32:50.081853Z","caller":"traceutil/trace.go:171","msg":"trace[1265669713] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:513; }","duration":"397.479205ms","start":"2026-02-05T17:32:49.684362Z","end":"2026-02-05T17:32:50.081842Z","steps":["trace[1265669713] 'range keys from in-memory index tree'  (duration: 397.292696ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:50.081874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:49.68435Z","time spent":"397.519757ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-05T17:32:50.081909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.096353824s","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-05T17:32:50.081962Z","caller":"traceutil/trace.go:171","msg":"trace[1477072602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"1.096440427s","start":"2026-02-05T17:32:48.985506Z","end":"2026-02-05T17:32:50.081946Z","steps":["trace[1477072602] 'range keys from in-memory index tree'  (duration: 1.096210709s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:50.081989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:48.985488Z","time spent":"1.096495098s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T17:32:50.08215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081309882s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bvgb6\" ","response":"range_response_count:1 size:16652"}
{"level":"warn","ts":"2026-02-05T17:32:50.08216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.264402ms","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-05T17:32:50.082171Z","caller":"traceutil/trace.go:171","msg":"trace[526466497] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bvgb6; range_end:; response_count:1; response_revision:513; }","duration":"1.081358103s","start":"2026-02-05T17:32:49.000805Z","end":"2026-02-05T17:32:50.082163Z","steps":["trace[526466497] 'range keys from in-memory index tree'  (duration: 1.081205609s)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:50.082177Z","caller":"traceutil/trace.go:171","msg":"trace[285342081] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:513; }","duration":"205.303374ms","start":"2026-02-05T17:32:49.876869Z","end":"2026-02-05T17:32:50.082172Z","steps":["trace[285342081] 'range keys from in-memory index tree'  (duration: 205.196739ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:50.08219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:49.000792Z","time spent":"1.081394664s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16675,"request content":"key:\"/registry/pods/kube-system/cilium-bvgb6\" "}
{"level":"warn","ts":"2026-02-05T17:32:50.082425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.351766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:50.082442Z","caller":"traceutil/trace.go:171","msg":"trace[1576078737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"660.366577ms","start":"2026-02-05T17:32:49.422069Z","end":"2026-02-05T17:32:50.082435Z","steps":["trace[1576078737] 'range keys from in-memory index tree'  (duration: 660.312194ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:50.082454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:49.422032Z","time spent":"660.418599ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-05T17:32:50.653567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788337,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:51.154589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788337,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:51.426337Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.307869922s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-05T17:32:51.426933Z","caller":"traceutil/trace.go:171","msg":"trace[1213939814] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.337611051s","start":"2026-02-05T17:32:50.089306Z","end":"2026-02-05T17:32:51.426917Z","steps":["trace[1213939814] 'process raft request'  (duration: 1.33713121s)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:51.426997Z","caller":"traceutil/trace.go:171","msg":"trace[1840383275] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:531; }","duration":"1.274493807s","start":"2026-02-05T17:32:50.152495Z","end":"2026-02-05T17:32:51.426989Z","steps":["trace[1840383275] 'read index received'  (duration: 1.27390453s)","trace[1840383275] 'applied index is now lower than readState.Index'  (duration: 588.847µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:51.427024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:50.089295Z","time spent":"1.337673594s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:509 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T17:32:51.427108Z","caller":"traceutil/trace.go:171","msg":"trace[1294128074] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.32773866s","start":"2026-02-05T17:32:50.099364Z","end":"2026-02-05T17:32:51.427102Z","steps":["trace[1294128074] 'process raft request'  (duration: 1.327332891s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:51.427137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:50.099347Z","time spent":"1.327772292s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-bvgb6\" mod_revision:459 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-bvgb6\" value_size:16750 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-bvgb6\" > >"}
{"level":"info","ts":"2026-02-05T17:32:51.427143Z","caller":"traceutil/trace.go:171","msg":"trace[253937373] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.335606649s","start":"2026-02-05T17:32:50.09153Z","end":"2026-02-05T17:32:51.427136Z","steps":["trace[253937373] 'process raft request'  (duration: 1.335131968s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:51.427176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:50.091522Z","time spent":"1.33563606s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:507 > 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-05T17:32:51.427234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274745138s","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-05T17:32:51.42725Z","caller":"traceutil/trace.go:171","msg":"trace[363255286] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:517; }","duration":"1.274786929s","start":"2026-02-05T17:32:50.152458Z","end":"2026-02-05T17:32:51.427245Z","steps":["trace[363255286] 'agreement among raft nodes before linearized reading'  (duration: 1.274732957s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:51.427265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:50.152444Z","time spent":"1.274817211s","remote":"127.0.0.1:36716","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-05T17:32:54.02664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.232317156s","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788341 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:510 > 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-05T17:32:54.026752Z","caller":"traceutil/trace.go:171","msg":"trace[1195659328] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"2.149063777s","start":"2026-02-05T17:32:51.877671Z","end":"2026-02-05T17:32:54.026735Z","steps":["trace[1195659328] 'read index received'  (duration: 27.332µs)","trace[1195659328] 'applied index is now lower than readState.Index'  (duration: 2.149035135s)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:32:54.026993Z","caller":"traceutil/trace.go:171","msg":"trace[1132809179] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"2.58851817s","start":"2026-02-05T17:32:51.438416Z","end":"2026-02-05T17:32:54.026934Z","steps":["trace[1132809179] 'process raft request'  (duration: 355.815147ms)","trace[1132809179] 'compare'  (duration: 2.231247419s)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:54.027086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:51.4384Z","time spent":"2.588647615s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:510 > 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-05T17:32:54.028119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150451537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-05T17:32:54.028145Z","caller":"traceutil/trace.go:171","msg":"trace[1251978453] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:1; response_revision:518; }","duration":"2.15050661s","start":"2026-02-05T17:32:51.87763Z","end":"2026-02-05T17:32:54.028137Z","steps":["trace[1251978453] 'agreement among raft nodes before linearized reading'  (duration: 2.150455228s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:54.028165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:51.877603Z","time spent":"2.150558592s","remote":"127.0.0.1:36456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"warn","ts":"2026-02-05T17:32:54.527478Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788343,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:55.028038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788343,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:55.426003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000953658s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-02-05T17:32:55.426068Z","caller":"traceutil/trace.go:171","msg":"trace[1895533459] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001069213s","start":"2026-02-05T17:32:53.424985Z","end":"2026-02-05T17:32:55.426055Z","steps":["trace[1895533459] 'agreement among raft nodes before linearized reading'  (duration: 2.000983319s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:55.426106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:53.424969Z","time spent":"2.001129335s","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/02/05 17:32:55 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-02-05T17:32:55.528721Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788343,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:32:55.556695Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.536743142s","expected-duration":"1s"}
{"level":"warn","ts":"2026-02-05T17:32:55.619009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:54.028837Z","time spent":"1.590168951s","remote":"127.0.0.1:36456","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-02-05T17:32:55.619133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.496439705s","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-05T17:32:55.619158Z","caller":"traceutil/trace.go:171","msg":"trace[592566921] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:520; }","duration":"3.496495938s","start":"2026-02-05T17:32:52.122655Z","end":"2026-02-05T17:32:55.619151Z","steps":["trace[592566921] 'agreement among raft nodes before linearized reading'  (duration: 3.496385593s)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:55.619175Z","caller":"traceutil/trace.go:171","msg":"trace[61367521] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"3.599311374s","start":"2026-02-05T17:32:52.019853Z","end":"2026-02-05T17:32:55.619164Z","steps":["trace[61367521] 'process raft request'  (duration: 3.537095448s)","trace[61367521] 'compare'  (duration: 61.437983ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:55.61918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:52.122643Z","time spent":"3.496530129s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-05T17:32:55.619235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:52.019835Z","time spent":"3.599358907s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:472 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-02-05T17:32:55.6193Z","caller":"traceutil/trace.go:171","msg":"trace[1016865761] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"414.490178ms","start":"2026-02-05T17:32:55.204803Z","end":"2026-02-05T17:32:55.619293Z","steps":["trace[1016865761] 'process raft request'  (duration: 414.146513ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:55.619338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:55.20478Z","time spent":"414.53743ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:503 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-02-05T17:32:55.619427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.18095259s","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-05T17:32:55.619446Z","caller":"traceutil/trace.go:171","msg":"trace[293742082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:520; }","duration":"2.180992761s","start":"2026-02-05T17:32:53.438448Z","end":"2026-02-05T17:32:55.61944Z","steps":["trace[293742082] 'agreement among raft nodes before linearized reading'  (duration: 2.180931639s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:55.619465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:53.438439Z","time spent":"2.181021772s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-02-05T17:32:55.619011Z","caller":"traceutil/trace.go:171","msg":"trace[1135135974] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:535; }","duration":"1.59221461s","start":"2026-02-05T17:32:54.026781Z","end":"2026-02-05T17:32:55.618995Z","steps":["trace[1135135974] 'read index received'  (duration: 1.53014121s)","trace[1135135974] 'applied index is now lower than readState.Index'  (duration: 62.0728ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:55.619575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.187517298s","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-05T17:32:55.619595Z","caller":"traceutil/trace.go:171","msg":"trace[1009546518] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:520; }","duration":"2.18755072s","start":"2026-02-05T17:32:53.432039Z","end":"2026-02-05T17:32:55.619589Z","steps":["trace[1009546518] 'agreement among raft nodes before linearized reading'  (duration: 2.187493677s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:55.619612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:53.432032Z","time spent":"2.187575711s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-05T17:32:55.619676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"882.376003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:55.619697Z","caller":"traceutil/trace.go:171","msg":"trace[2095227061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"882.421365ms","start":"2026-02-05T17:32:54.737269Z","end":"2026-02-05T17:32:55.619691Z","steps":["trace[2095227061] 'agreement among raft nodes before linearized reading'  (duration: 882.377733ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:55.619716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:54.737256Z","time spent":"882.455247ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-05T17:32:55.619798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.683645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:55.619818Z","caller":"traceutil/trace.go:171","msg":"trace[316355790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"193.724796ms","start":"2026-02-05T17:32:55.426088Z","end":"2026-02-05T17:32:55.619812Z","steps":["trace[316355790] 'agreement among raft nodes before linearized reading'  (duration: 193.694145ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:56.334296Z","caller":"traceutil/trace.go:171","msg":"trace[167334152] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"214.746683ms","start":"2026-02-05T17:32:56.119534Z","end":"2026-02-05T17:32:56.334281Z","steps":["trace[167334152] 'process raft request'  (duration: 214.646218ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:56.732472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.888807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:32:56.73253Z","caller":"traceutil/trace.go:171","msg":"trace[525884227] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"308.975851ms","start":"2026-02-05T17:32:56.423541Z","end":"2026-02-05T17:32:56.732517Z","steps":["trace[525884227] 'range keys from in-memory index tree'  (duration: 308.832775ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:56.73255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:56.423528Z","time spent":"309.017922ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-05T17:32:57.401023Z","caller":"traceutil/trace.go:171","msg":"trace[723018659] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"372.520247ms","start":"2026-02-05T17:32:57.028481Z","end":"2026-02-05T17:32:57.401001Z","steps":["trace[723018659] 'process raft request'  (duration: 358.54515ms)","trace[723018659] 'compare'  (duration: 13.839761ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:57.401137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:57.028466Z","time spent":"372.60511ms","remote":"127.0.0.1:36488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-bvgb6.18916a1757fd7037\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-bvgb6.18916a1757fd7037\" value_size:624 lease:8484390473094011863 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:32:57.401366Z","caller":"traceutil/trace.go:171","msg":"trace[1855705383] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:547; }","duration":"362.588849ms","start":"2026-02-05T17:32:57.038768Z","end":"2026-02-05T17:32:57.401357Z","steps":["trace[1855705383] 'read index received'  (duration: 348.267457ms)","trace[1855705383] 'applied index is now lower than readState.Index'  (duration: 14.320752ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:57.413835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.050102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bvgb6\" ","response":"range_response_count:1 size:16912"}
{"level":"info","ts":"2026-02-05T17:32:57.413884Z","caller":"traceutil/trace.go:171","msg":"trace[126786424] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bvgb6; range_end:; response_count:1; response_revision:530; }","duration":"375.132707ms","start":"2026-02-05T17:32:57.038739Z","end":"2026-02-05T17:32:57.413871Z","steps":["trace[126786424] 'agreement among raft nodes before linearized reading'  (duration: 362.644372ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:57.413908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:57.038726Z","time spent":"375.176918ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16935,"request content":"key:\"/registry/pods/kube-system/cilium-bvgb6\" "}
{"level":"info","ts":"2026-02-05T17:32:57.557751Z","caller":"traceutil/trace.go:171","msg":"trace[1938989307] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"128.143886ms","start":"2026-02-05T17:32:57.429586Z","end":"2026-02-05T17:32:57.557729Z","steps":["trace[1938989307] 'process raft request'  (duration: 127.99551ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:58.075572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.17168ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788373 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:522 > 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-05T17:32:58.075671Z","caller":"traceutil/trace.go:171","msg":"trace[169514488] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"355.832931ms","start":"2026-02-05T17:32:57.719824Z","end":"2026-02-05T17:32:58.075657Z","steps":["trace[169514488] 'process raft request'  (duration: 194.522516ms)","trace[169514488] 'compare'  (duration: 161.089385ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:32:58.075706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:57.719806Z","time spent":"355.884993ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:522 > 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-05T17:32:58.075844Z","caller":"traceutil/trace.go:171","msg":"trace[356739835] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"354.847429ms","start":"2026-02-05T17:32:57.720992Z","end":"2026-02-05T17:32:58.075839Z","steps":["trace[356739835] 'process raft request'  (duration: 354.641271ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:32:58.075866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:32:57.720986Z","time spent":"354.86854ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:525 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T17:32:58.155648Z","caller":"traceutil/trace.go:171","msg":"trace[1113297535] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"106.752535ms","start":"2026-02-05T17:32:58.048881Z","end":"2026-02-05T17:32:58.155633Z","steps":["trace[1113297535] 'process raft request'  (duration: 106.688382ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:58.355636Z","caller":"traceutil/trace.go:171","msg":"trace[1449287849] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"196.605306ms","start":"2026-02-05T17:32:58.159015Z","end":"2026-02-05T17:32:58.355621Z","steps":["trace[1449287849] 'process raft request'  (duration: 196.537164ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:58.355768Z","caller":"traceutil/trace.go:171","msg":"trace[1844014139] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"267.626706ms","start":"2026-02-05T17:32:58.088134Z","end":"2026-02-05T17:32:58.355761Z","steps":["trace[1844014139] 'process raft request'  (duration: 265.735708ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:32:59.89956Z","caller":"traceutil/trace.go:171","msg":"trace[1187339957] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"169.339602ms","start":"2026-02-05T17:32:59.730205Z","end":"2026-02-05T17:32:59.899544Z","steps":["trace[1187339957] 'process raft request'  (duration: 169.254499ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:00.259377Z","caller":"traceutil/trace.go:171","msg":"trace[913802774] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"117.679085ms","start":"2026-02-05T17:33:00.141682Z","end":"2026-02-05T17:33:00.259361Z","steps":["trace[913802774] 'process raft request'  (duration: 105.156397ms)","trace[913802774] 'compare'  (duration: 12.347501ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:00.528692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.951185ms","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-05T17:33:00.528755Z","caller":"traceutil/trace.go:171","msg":"trace[645222889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:544; }","duration":"168.055449ms","start":"2026-02-05T17:33:00.360684Z","end":"2026-02-05T17:33:00.528739Z","steps":["trace[645222889] 'range keys from in-memory index tree'  (duration: 167.799168ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.653667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.30709705s","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788401 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-fdt9j.18916a186182525b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-fdt9j.18916a186182525b\" value_size:739 lease:8484390473094011863 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:33:03.653762Z","caller":"traceutil/trace.go:171","msg":"trace[1371359822] linearizableReadLoop","detail":"{readStateIndex:567; appliedIndex:566; }","duration":"1.77236953s","start":"2026-02-05T17:33:01.881378Z","end":"2026-02-05T17:33:03.653747Z","steps":["trace[1371359822] 'read index received'  (duration: 465.099894ms)","trace[1371359822] 'applied index is now lower than readState.Index'  (duration: 1.307268166s)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:03.653839Z","caller":"traceutil/trace.go:171","msg":"trace[517454315] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"2.154707305s","start":"2026-02-05T17:33:01.49912Z","end":"2026-02-05T17:33:03.653827Z","steps":["trace[517454315] 'process raft request'  (duration: 847.373466ms)","trace[517454315] 'compare'  (duration: 1.306905432s)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:03.653884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:01.499107Z","time spent":"2.154755416s","remote":"127.0.0.1:36488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-fdt9j.18916a186182525b\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-operator-7fcd8d6ffd-fdt9j.18916a186182525b\" value_size:739 lease:8484390473094011863 >> failure:<>"}
{"level":"warn","ts":"2026-02-05T17:33:03.654135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.772756735s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-05T17:33:03.654164Z","caller":"traceutil/trace.go:171","msg":"trace[345694813] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:1; response_revision:548; }","duration":"1.772810817s","start":"2026-02-05T17:33:01.881344Z","end":"2026-02-05T17:33:03.654155Z","steps":["trace[345694813] 'agreement among raft nodes before linearized reading'  (duration: 1.772674062s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.65419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:01.881329Z","time spent":"1.77285521s","remote":"127.0.0.1:36456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.49\" "}
{"level":"warn","ts":"2026-02-05T17:33:03.654288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.750311166s","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-05T17:33:03.654333Z","caller":"traceutil/trace.go:171","msg":"trace[735724816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:548; }","duration":"1.750389889s","start":"2026-02-05T17:33:01.903932Z","end":"2026-02-05T17:33:03.654322Z","steps":["trace[735724816] 'agreement among raft nodes before linearized reading'  (duration: 1.750264624s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:01.903917Z","time spent":"1.750434741s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-02-05T17:33:03.654492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.53238131s","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-05T17:33:03.654508Z","caller":"traceutil/trace.go:171","msg":"trace[1111571900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"1.532407751s","start":"2026-02-05T17:33:02.122094Z","end":"2026-02-05T17:33:03.654501Z","steps":["trace[1111571900] 'agreement among raft nodes before linearized reading'  (duration: 1.532363579s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.516699068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bvgb6\" ","response":"range_response_count:1 size:17411"}
{"level":"info","ts":"2026-02-05T17:33:03.654542Z","caller":"traceutil/trace.go:171","msg":"trace[679043066] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bvgb6; range_end:; response_count:1; response_revision:548; }","duration":"1.51674692s","start":"2026-02-05T17:33:02.137786Z","end":"2026-02-05T17:33:03.654533Z","steps":["trace[679043066] 'agreement among raft nodes before linearized reading'  (duration: 1.516659737s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.540024153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-05T17:33:03.654572Z","caller":"traceutil/trace.go:171","msg":"trace[915533516] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:548; }","duration":"1.540060645s","start":"2026-02-05T17:33:02.114507Z","end":"2026-02-05T17:33:03.654568Z","steps":["trace[915533516] 'agreement among raft nodes before linearized reading'  (duration: 1.540022803s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:02.137777Z","time spent":"1.516785621s","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17434,"request content":"key:\"/registry/pods/kube-system/cilium-bvgb6\" "}
{"level":"warn","ts":"2026-02-05T17:33:03.654585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:02.114494Z","time spent":"1.540088035s","remote":"127.0.0.1:36716","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-05T17:33:03.654713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035629538s","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-05T17:33:03.654521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:02.122087Z","time spent":"1.532429422s","remote":"127.0.0.1:36716","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":"info","ts":"2026-02-05T17:33:03.654738Z","caller":"traceutil/trace.go:171","msg":"trace[1550257477] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:548; }","duration":"1.03568543s","start":"2026-02-05T17:33:02.619045Z","end":"2026-02-05T17:33:03.65473Z","steps":["trace[1550257477] 'agreement among raft nodes before linearized reading'  (duration: 1.035617357s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:02.619027Z","time spent":"1.035730412s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-02-05T17:33:03.654797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230344536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:03.654813Z","caller":"traceutil/trace.go:171","msg":"trace[1280819559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"1.230385948s","start":"2026-02-05T17:33:02.424423Z","end":"2026-02-05T17:33:03.654808Z","steps":["trace[1280819559] 'agreement among raft nodes before linearized reading'  (duration: 1.230360657s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:03.654826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:02.424408Z","time spent":"1.230414869s","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-05T17:33:04.173944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.105128ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788405 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:75be9c2edc7a1eb4>","response":"size:40"}
{"level":"warn","ts":"2026-02-05T17:33:04.174619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.658685Z","time spent":"515.929301ms","remote":"127.0.0.1:36456","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-02-05T17:33:04.174831Z","caller":"traceutil/trace.go:171","msg":"trace[1575574187] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"507.144437ms","start":"2026-02-05T17:33:03.667675Z","end":"2026-02-05T17:33:04.174819Z","steps":["trace[1575574187] 'process raft request'  (duration: 506.718121ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.174901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.66766Z","time spent":"507.189048ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:542 > 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":"info","ts":"2026-02-05T17:33:04.175728Z","caller":"traceutil/trace.go:171","msg":"trace[2115214031] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"507.974979ms","start":"2026-02-05T17:33:03.667745Z","end":"2026-02-05T17:33:04.17572Z","steps":["trace[2115214031] 'process raft request'  (duration: 506.850256ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.175764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.66774Z","time spent":"508.00255ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:545 > 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-05T17:33:04.175872Z","caller":"traceutil/trace.go:171","msg":"trace[1873485549] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"508.085664ms","start":"2026-02-05T17:33:03.667779Z","end":"2026-02-05T17:33:04.175865Z","steps":["trace[1873485549] 'process raft request'  (duration: 506.869737ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.175898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.667773Z","time spent":"508.110404ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:540 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-02-05T17:33:04.176154Z","caller":"traceutil/trace.go:171","msg":"trace[1380562292] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"506.521782ms","start":"2026-02-05T17:33:03.669626Z","end":"2026-02-05T17:33:04.176147Z","steps":["trace[1380562292] 'process raft request'  (duration: 505.051115ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.176189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.669616Z","time spent":"506.555984ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:541 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T17:33:04.177049Z","caller":"traceutil/trace.go:171","msg":"trace[462610334] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:567; }","duration":"496.733258ms","start":"2026-02-05T17:33:03.680297Z","end":"2026-02-05T17:33:04.17703Z","steps":["trace[462610334] 'read index received'  (duration: 173.54588ms)","trace[462610334] 'applied index is now lower than readState.Index'  (duration: 323.186018ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:04.177556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.252269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:04.1776Z","caller":"traceutil/trace.go:171","msg":"trace[905520298] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:553; }","duration":"497.325321ms","start":"2026-02-05T17:33:03.680264Z","end":"2026-02-05T17:33:04.17759Z","steps":["trace[905520298] 'agreement among raft nodes before linearized reading'  (duration: 496.857322ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.177763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.680256Z","time spent":"497.419765ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-05T17:33:04.178051Z","caller":"traceutil/trace.go:171","msg":"trace[8352505] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"505.819874ms","start":"2026-02-05T17:33:03.672223Z","end":"2026-02-05T17:33:04.178043Z","steps":["trace[8352505] 'process raft request'  (duration: 502.483815ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.178966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:03.672217Z","time spent":"506.727569ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17558,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-bvgb6\" mod_revision:544 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-bvgb6\" value_size:17509 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-bvgb6\" > >"}
{"level":"warn","ts":"2026-02-05T17:33:04.451997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.038655ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788412 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/masterleases/162.253.55.49\" mod_revision:521 > success:<request_put:<key:\"/registry/masterleases/162.253.55.49\" value_size:66 lease:8484390473094012596 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.49\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:33:04.452357Z","caller":"traceutil/trace.go:171","msg":"trace[1931994759] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"277.047722ms","start":"2026-02-05T17:33:04.175293Z","end":"2026-02-05T17:33:04.45234Z","steps":["trace[1931994759] 'process raft request'  (duration: 136.605621ms)","trace[1931994759] 'compare'  (duration: 139.939071ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:04.876373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.182934ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788414 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/cilium-bvgb6.18916a19112f47ac\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-bvgb6.18916a19112f47ac\" value_size:673 lease:8484390473094011863 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:33:04.876497Z","caller":"traceutil/trace.go:171","msg":"trace[1105788979] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"412.49351ms","start":"2026-02-05T17:33:04.463994Z","end":"2026-02-05T17:33:04.876488Z","steps":["trace[1105788979] 'process raft request'  (duration: 412.454738ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.876536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:04.463974Z","time spent":"412.541331ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17651,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-bvgb6\" mod_revision:553 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-bvgb6\" value_size:17602 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-bvgb6\" > >"}
{"level":"info","ts":"2026-02-05T17:33:04.876628Z","caller":"traceutil/trace.go:171","msg":"trace[206105414] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"446.965265ms","start":"2026-02-05T17:33:04.429656Z","end":"2026-02-05T17:33:04.876621Z","steps":["trace[206105414] 'process raft request'  (duration: 230.493979ms)","trace[206105414] 'compare'  (duration: 216.0595ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:04.876647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:04.42964Z","time spent":"446.998087ms","remote":"127.0.0.1:36488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":749,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/cilium-bvgb6.18916a19112f47ac\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/cilium-bvgb6.18916a19112f47ac\" value_size:673 lease:8484390473094011863 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:33:04.876706Z","caller":"traceutil/trace.go:171","msg":"trace[129527829] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"422.241987ms","start":"2026-02-05T17:33:04.45446Z","end":"2026-02-05T17:33:04.876702Z","steps":["trace[129527829] 'read index received'  (duration: 205.697169ms)","trace[129527829] 'applied index is now lower than readState.Index'  (duration: 216.544278ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:04.876859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.343927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:04.876873Z","caller":"traceutil/trace.go:171","msg":"trace[1871348670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"140.384958ms","start":"2026-02-05T17:33:04.736484Z","end":"2026-02-05T17:33:04.876869Z","steps":["trace[1871348670] 'agreement among raft nodes before linearized reading'  (duration: 140.356167ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.877062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.402793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-02-05T17:33:04.877131Z","caller":"traceutil/trace.go:171","msg":"trace[1221086051] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:556; }","duration":"422.712055ms","start":"2026-02-05T17:33:04.454407Z","end":"2026-02-05T17:33:04.877119Z","steps":["trace[1221086051] 'agreement among raft nodes before linearized reading'  (duration: 422.401893ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:04.877163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:04.454391Z","time spent":"422.765158ms","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-05T17:33:06.035794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.096172ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788453 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" value_size:879 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:33:06.036317Z","caller":"traceutil/trace.go:171","msg":"trace[617953275] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:593; }","duration":"437.72063ms","start":"2026-02-05T17:33:05.598577Z","end":"2026-02-05T17:33:06.036298Z","steps":["trace[617953275] 'read index received'  (duration: 285.085388ms)","trace[617953275] 'applied index is now lower than readState.Index'  (duration: 152.634222ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:06.036727Z","caller":"traceutil/trace.go:171","msg":"trace[1093082029] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"446.227226ms","start":"2026-02-05T17:33:05.590485Z","end":"2026-02-05T17:33:06.036712Z","steps":["trace[1093082029] 'process raft request'  (duration: 293.152227ms)","trace[1093082029] 'compare'  (duration: 151.865993ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:06.036899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:05.590471Z","time spent":"446.394632ms","remote":"127.0.0.1:37002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiregistration.k8s.io/apiservices/v2alpha1.cilium.io\" value_size:879 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:33:06.037319Z","caller":"traceutil/trace.go:171","msg":"trace[1184807802] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"442.744652ms","start":"2026-02-05T17:33:05.594561Z","end":"2026-02-05T17:33:06.037306Z","steps":["trace[1184807802] 'process raft request'  (duration: 441.500005ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:06.037706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:05.594552Z","time spent":"442.806614ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" mod_revision:572 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" value_size:5061 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" > >"}
{"level":"info","ts":"2026-02-05T17:33:06.037787Z","caller":"traceutil/trace.go:171","msg":"trace[260327605] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"410.06315ms","start":"2026-02-05T17:33:05.627718Z","end":"2026-02-05T17:33:06.037782Z","steps":["trace[260327605] 'process raft request'  (duration: 408.424808ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:06.037813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:05.627702Z","time spent":"410.099741ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" value_size:8170 >> failure:<>"}
{"level":"info","ts":"2026-02-05T17:33:06.037919Z","caller":"traceutil/trace.go:171","msg":"trace[423008809] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"297.675305ms","start":"2026-02-05T17:33:05.740239Z","end":"2026-02-05T17:33:06.037915Z","steps":["trace[423008809] 'process raft request'  (duration: 296.012323ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:06.037989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.409334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:06.038007Z","caller":"traceutil/trace.go:171","msg":"trace[1303548281] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:576; }","duration":"439.443475ms","start":"2026-02-05T17:33:05.598559Z","end":"2026-02-05T17:33:06.038002Z","steps":["trace[1303548281] 'agreement among raft nodes before linearized reading'  (duration: 439.415614ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:06.038021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:05.598551Z","time spent":"439.467656ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "}
{"level":"warn","ts":"2026-02-05T17:33:06.040453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.488689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-fdt9j\" ","response":"range_response_count:1 size:4818"}
{"level":"info","ts":"2026-02-05T17:33:06.040512Z","caller":"traceutil/trace.go:171","msg":"trace[1865149255] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-fdt9j; range_end:; response_count:1; response_revision:578; }","duration":"425.574063ms","start":"2026-02-05T17:33:05.614927Z","end":"2026-02-05T17:33:06.040501Z","steps":["trace[1865149255] 'agreement among raft nodes before linearized reading'  (duration: 425.149027ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:06.040568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:05.614912Z","time spent":"425.649166ms","remote":"127.0.0.1:36622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4841,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-fdt9j\" "}
{"level":"warn","ts":"2026-02-05T17:33:06.042705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.529153ms","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-05T17:33:06.042735Z","caller":"traceutil/trace.go:171","msg":"trace[1734897862] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:578; }","duration":"241.672329ms","start":"2026-02-05T17:33:05.801055Z","end":"2026-02-05T17:33:06.042727Z","steps":["trace[1734897862] 'agreement among raft nodes before linearized reading'  (duration: 241.537804ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:06.55098Z","caller":"traceutil/trace.go:171","msg":"trace[1266829230] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"102.965688ms","start":"2026-02-05T17:33:06.447999Z","end":"2026-02-05T17:33:06.550965Z","steps":["trace[1266829230] 'process raft request'  (duration: 102.930207ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:06.551003Z","caller":"traceutil/trace.go:171","msg":"trace[1876224430] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"116.655227ms","start":"2026-02-05T17:33:06.43432Z","end":"2026-02-05T17:33:06.550975Z","steps":["trace[1876224430] 'process raft request'  (duration: 110.013615ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:06.551181Z","caller":"traceutil/trace.go:171","msg":"trace[276161412] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"105.65148ms","start":"2026-02-05T17:33:06.44552Z","end":"2026-02-05T17:33:06.551172Z","steps":["trace[276161412] 'read index received'  (duration: 98.824592ms)","trace[276161412] 'applied index is now lower than readState.Index'  (duration: 6.825878ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:06.551326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.792565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-bvgb6\" ","response":"range_response_count:1 size:17914"}
{"level":"info","ts":"2026-02-05T17:33:06.551349Z","caller":"traceutil/trace.go:171","msg":"trace[1218349237] range","detail":"{range_begin:/registry/pods/kube-system/cilium-bvgb6; range_end:; response_count:1; response_revision:596; }","duration":"105.850418ms","start":"2026-02-05T17:33:06.445492Z","end":"2026-02-05T17:33:06.551343Z","steps":["trace[1218349237] 'agreement among raft nodes before linearized reading'  (duration: 105.714153ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:07.546388Z","caller":"traceutil/trace.go:171","msg":"trace[583568332] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"310.688151ms","start":"2026-02-05T17:33:07.235135Z","end":"2026-02-05T17:33:07.545824Z","steps":["trace[583568332] 'process raft request'  (duration: 228.916439ms)","trace[583568332] 'compare'  (duration: 81.593225ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:07.546525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:07.235117Z","time spent":"311.335045ms","remote":"127.0.0.1:36462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:604 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:24132 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" > >"}
{"level":"info","ts":"2026-02-05T17:33:07.549245Z","caller":"traceutil/trace.go:171","msg":"trace[1994159058] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:625; }","duration":"119.200052ms","start":"2026-02-05T17:33:07.430038Z","end":"2026-02-05T17:33:07.549238Z","steps":["trace[1994159058] 'read index received'  (duration: 34.023564ms)","trace[1994159058] 'applied index is now lower than readState.Index'  (duration: 85.176008ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:07.549333Z","caller":"traceutil/trace.go:171","msg":"trace[1406683144] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"142.855538ms","start":"2026-02-05T17:33:07.406473Z","end":"2026-02-05T17:33:07.549328Z","steps":["trace[1406683144] 'process raft request'  (duration: 142.721313ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:07.549418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.385999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:07.549434Z","caller":"traceutil/trace.go:171","msg":"trace[2058063254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:606; }","duration":"119.431251ms","start":"2026-02-05T17:33:07.429998Z","end":"2026-02-05T17:33:07.54943Z","steps":["trace[2058063254] 'agreement among raft nodes before linearized reading'  (duration: 119.383929ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:07.549509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.54276ms","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-05T17:33:07.549521Z","caller":"traceutil/trace.go:171","msg":"trace[1434623633] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:606; }","duration":"109.576342ms","start":"2026-02-05T17:33:07.439941Z","end":"2026-02-05T17:33:07.549517Z","steps":["trace[1434623633] 'agreement among raft nodes before linearized reading'  (duration: 109.551861ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:14.485564Z","caller":"traceutil/trace.go:171","msg":"trace[997277061] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"205.435593ms","start":"2026-02-05T17:33:14.28011Z","end":"2026-02-05T17:33:14.485546Z","steps":["trace[997277061] 'process raft request'  (duration: 113.768828ms)","trace[997277061] 'compare'  (duration: 91.584432ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:14.486842Z","caller":"traceutil/trace.go:171","msg":"trace[217422169] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"204.948917ms","start":"2026-02-05T17:33:14.281886Z","end":"2026-02-05T17:33:14.486835Z","steps":["trace[217422169] 'process raft request'  (duration: 204.907375ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:14.486862Z","caller":"traceutil/trace.go:171","msg":"trace[1905636275] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"205.577598ms","start":"2026-02-05T17:33:14.281262Z","end":"2026-02-05T17:33:14.48684Z","steps":["trace[1905636275] 'process raft request'  (duration: 205.472634ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.629505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.278864ms","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-05T17:33:16.629557Z","caller":"traceutil/trace.go:171","msg":"trace[1004354769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:712; }","duration":"138.363577ms","start":"2026-02-05T17:33:16.491179Z","end":"2026-02-05T17:33:16.629543Z","steps":["trace[1004354769] 'range keys from in-memory index tree'  (duration: 138.179121ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.629751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.10029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"}
{"level":"info","ts":"2026-02-05T17:33:16.629772Z","caller":"traceutil/trace.go:171","msg":"trace[275740649] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:712; }","duration":"141.170693ms","start":"2026-02-05T17:33:16.488596Z","end":"2026-02-05T17:33:16.629766Z","steps":["trace[275740649] 'range keys from in-memory index tree'  (duration: 141.030018ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.62988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.62163ms","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-05T17:33:16.629897Z","caller":"traceutil/trace.go:171","msg":"trace[863477278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:712; }","duration":"139.660221ms","start":"2026-02-05T17:33:16.490233Z","end":"2026-02-05T17:33:16.629893Z","steps":["trace[863477278] 'range keys from in-memory index tree'  (duration: 139.551277ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:16.759204Z","caller":"traceutil/trace.go:171","msg":"trace[1038321820] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"125.778931ms","start":"2026-02-05T17:33:16.633402Z","end":"2026-02-05T17:33:16.759181Z","steps":["trace[1038321820] 'process raft request'  (duration: 125.654647ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:16.987353Z","caller":"traceutil/trace.go:171","msg":"trace[313748193] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:738; }","duration":"326.854362ms","start":"2026-02-05T17:33:16.660476Z","end":"2026-02-05T17:33:16.987331Z","steps":["trace[313748193] 'read index received'  (duration: 98.514047ms)","trace[313748193] 'applied index is now lower than readState.Index'  (duration: 228.339665ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:16.987518Z","caller":"traceutil/trace.go:171","msg":"trace[1185600963] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"353.992251ms","start":"2026-02-05T17:33:16.633519Z","end":"2026-02-05T17:33:16.987511Z","steps":["trace[1185600963] 'process raft request'  (duration: 353.686771ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.987596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.633515Z","time spent":"354.030163ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:669 > 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-05T17:33:16.987735Z","caller":"traceutil/trace.go:171","msg":"trace[1692408284] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"353.838257ms","start":"2026-02-05T17:33:16.633891Z","end":"2026-02-05T17:33:16.987729Z","steps":["trace[1692408284] 'process raft request'  (duration: 353.412482ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.987768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.633886Z","time spent":"353.864308ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:668 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-02-05T17:33:16.987886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.403101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.987912Z","caller":"traceutil/trace.go:171","msg":"trace[1894927542] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:715; }","duration":"327.448083ms","start":"2026-02-05T17:33:16.660455Z","end":"2026-02-05T17:33:16.987903Z","steps":["trace[1894927542] 'agreement among raft nodes before linearized reading'  (duration: 327.397011ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.987931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.660443Z","time spent":"327.483094ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "}
{"level":"warn","ts":"2026-02-05T17:33:16.988028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.515985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988047Z","caller":"traceutil/trace.go:171","msg":"trace[823006497] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:715; }","duration":"327.543185ms","start":"2026-02-05T17:33:16.660499Z","end":"2026-02-05T17:33:16.988042Z","steps":["trace[823006497] 'agreement among raft nodes before linearized reading'  (duration: 327.515705ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.660496Z","time spent":"327.562957ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T17:33:16.988224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.800004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988243Z","caller":"traceutil/trace.go:171","msg":"trace[550585757] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:715; }","duration":"309.824506ms","start":"2026-02-05T17:33:16.678412Z","end":"2026-02-05T17:33:16.988237Z","steps":["trace[550585757] 'agreement among raft nodes before linearized reading'  (duration: 309.794525ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.98826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.67841Z","time spent":"309.845917ms","remote":"127.0.0.1:37890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "}
{"level":"warn","ts":"2026-02-05T17:33:16.988351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.96261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988367Z","caller":"traceutil/trace.go:171","msg":"trace[1638935786] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:715; }","duration":"309.986531ms","start":"2026-02-05T17:33:16.678376Z","end":"2026-02-05T17:33:16.988362Z","steps":["trace[1638935786] 'agreement among raft nodes before linearized reading'  (duration: 309.96216ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.678373Z","time spent":"310.005722ms","remote":"127.0.0.1:37890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T17:33:16.988462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.133786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.98848Z","caller":"traceutil/trace.go:171","msg":"trace[1137762837] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:715; }","duration":"310.161967ms","start":"2026-02-05T17:33:16.678313Z","end":"2026-02-05T17:33:16.988475Z","steps":["trace[1137762837] 'agreement among raft nodes before linearized reading'  (duration: 310.133496ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.678308Z","time spent":"310.183538ms","remote":"127.0.0.1:37890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "}
{"level":"warn","ts":"2026-02-05T17:33:16.988571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.334853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988589Z","caller":"traceutil/trace.go:171","msg":"trace[135851612] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:715; }","duration":"318.358865ms","start":"2026-02-05T17:33:16.670226Z","end":"2026-02-05T17:33:16.988584Z","steps":["trace[135851612] 'agreement among raft nodes before linearized reading'  (duration: 318.332054ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.670223Z","time spent":"318.377845ms","remote":"127.0.0.1:37888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "}
{"level":"warn","ts":"2026-02-05T17:33:16.988688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.462438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988705Z","caller":"traceutil/trace.go:171","msg":"trace[498863703] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:715; }","duration":"318.485979ms","start":"2026-02-05T17:33:16.670213Z","end":"2026-02-05T17:33:16.988699Z","steps":["trace[498863703] 'agreement among raft nodes before linearized reading'  (duration: 318.462168ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.670211Z","time spent":"318.505499ms","remote":"127.0.0.1:37888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T17:33:16.988789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.582362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988805Z","caller":"traceutil/trace.go:171","msg":"trace[302415943] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:715; }","duration":"318.608323ms","start":"2026-02-05T17:33:16.670191Z","end":"2026-02-05T17:33:16.9888Z","steps":["trace[302415943] 'agreement among raft nodes before linearized reading'  (duration: 318.585562ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.670186Z","time spent":"318.630714ms","remote":"127.0.0.1:37888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "}
{"level":"warn","ts":"2026-02-05T17:33:16.988887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.6606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:16.988902Z","caller":"traceutil/trace.go:171","msg":"trace[1886827741] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:715; }","duration":"327.68416ms","start":"2026-02-05T17:33:16.661214Z","end":"2026-02-05T17:33:16.988898Z","steps":["trace[1886827741] 'agreement among raft nodes before linearized reading'  (duration: 327.66075ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:16.988918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:16.661209Z","time spent":"327.705611ms","remote":"127.0.0.1:37882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "}
{"level":"info","ts":"2026-02-05T17:33:18.729815Z","caller":"traceutil/trace.go:171","msg":"trace[1062192937] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"211.535113ms","start":"2026-02-05T17:33:18.518037Z","end":"2026-02-05T17:33:18.729572Z","steps":["trace[1062192937] 'process raft request'  (duration: 211.397748ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:23.412802Z","caller":"traceutil/trace.go:171","msg":"trace[1222574802] linearizableReadLoop","detail":"{readStateIndex:765; appliedIndex:764; }","duration":"406.176579ms","start":"2026-02-05T17:33:23.006605Z","end":"2026-02-05T17:33:23.412781Z","steps":["trace[1222574802] 'read index received'  (duration: 406.020284ms)","trace[1222574802] 'applied index is now lower than readState.Index'  (duration: 155.435µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:23.413148Z","caller":"traceutil/trace.go:171","msg":"trace[1070927247] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"609.287281ms","start":"2026-02-05T17:33:22.803848Z","end":"2026-02-05T17:33:23.413135Z","steps":["trace[1070927247] 'process raft request'  (duration: 608.827376ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:23.413278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:22.803838Z","time spent":"609.371993ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:731 > 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-05T17:33:23.413462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.443608ms","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-05T17:33:23.414003Z","caller":"traceutil/trace.go:171","msg":"trace[2099427693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:737; }","duration":"401.022927ms","start":"2026-02-05T17:33:23.012964Z","end":"2026-02-05T17:33:23.413987Z","steps":["trace[2099427693] 'agreement among raft nodes before linearized reading'  (duration: 400.352625ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:23.414219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.012941Z","time spent":"401.261094ms","remote":"127.0.0.1:36716","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-05T17:33:23.413557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.961033ms","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-05T17:33:23.415327Z","caller":"traceutil/trace.go:171","msg":"trace[1278121446] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:737; }","duration":"408.7518ms","start":"2026-02-05T17:33:23.006556Z","end":"2026-02-05T17:33:23.415308Z","steps":["trace[1278121446] 'agreement among raft nodes before linearized reading'  (duration: 406.949123ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:23.415414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.006535Z","time spent":"408.864423ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-05T17:33:23.923727Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948788792,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:33:24.77079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.994812ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788793 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:732 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:33:24.770943Z","caller":"traceutil/trace.go:171","msg":"trace[533862220] linearizableReadLoop","detail":"{readStateIndex:767; appliedIndex:765; }","duration":"1.348022566s","start":"2026-02-05T17:33:23.422905Z","end":"2026-02-05T17:33:24.770928Z","steps":["trace[533862220] 'read index received'  (duration: 596.90362ms)","trace[533862220] 'applied index is now lower than readState.Index'  (duration: 751.118025ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:24.771184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.407222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T17:33:24.771215Z","caller":"traceutil/trace.go:171","msg":"trace[1045931988] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:739; }","duration":"989.476514ms","start":"2026-02-05T17:33:23.781729Z","end":"2026-02-05T17:33:24.771206Z","steps":["trace[1045931988] 'agreement among raft nodes before linearized reading'  (duration: 989.419962ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.771208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.348276533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-02-05T17:33:24.771251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.781713Z","time spent":"989.527295ms","remote":"127.0.0.1:36630","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"info","ts":"2026-02-05T17:33:24.771279Z","caller":"traceutil/trace.go:171","msg":"trace[579862533] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"1.348367757s","start":"2026-02-05T17:33:23.422892Z","end":"2026-02-05T17:33:24.771259Z","steps":["trace[579862533] 'agreement among raft nodes before linearized reading'  (duration: 1.348206272s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.771319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.422885Z","time spent":"1.348426868s","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-05T17:33:24.771555Z","caller":"traceutil/trace.go:171","msg":"trace[659086572] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"1.351940719s","start":"2026-02-05T17:33:23.419601Z","end":"2026-02-05T17:33:24.771542Z","steps":["trace[659086572] 'process raft request'  (duration: 600.118021ms)","trace[659086572] 'compare'  (duration: 750.30548ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:24.771564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.180314ms","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-05T17:33:24.771598Z","caller":"traceutil/trace.go:171","msg":"trace[1437191357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:739; }","duration":"359.241216ms","start":"2026-02-05T17:33:24.412347Z","end":"2026-02-05T17:33:24.771588Z","steps":["trace[1437191357] 'agreement among raft nodes before linearized reading'  (duration: 359.138483ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.771622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:24.412332Z","time spent":"359.284107ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-02-05T17:33:24.771636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.419587Z","time spent":"1.351993351s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:732 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-02-05T17:33:24.771728Z","caller":"traceutil/trace.go:171","msg":"trace[1271348607] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"1.351174605s","start":"2026-02-05T17:33:23.420544Z","end":"2026-02-05T17:33:24.771719Z","steps":["trace[1271348607] 'process raft request'  (duration: 1.350335819s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.77177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.598192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:33:24.771818Z","caller":"traceutil/trace.go:171","msg":"trace[597846102] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:739; }","duration":"707.669755ms","start":"2026-02-05T17:33:24.064138Z","end":"2026-02-05T17:33:24.771807Z","steps":["trace[597846102] 'agreement among raft nodes before linearized reading'  (duration: 707.611003ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.771844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:24.064121Z","time spent":"707.716646ms","remote":"127.0.0.1:36758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T17:33:24.772014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.315623ms","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-05T17:33:24.77204Z","caller":"traceutil/trace.go:171","msg":"trace[1795513793] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:739; }","duration":"985.362825ms","start":"2026-02-05T17:33:23.786669Z","end":"2026-02-05T17:33:24.772032Z","steps":["trace[1795513793] 'agreement among raft nodes before linearized reading'  (duration: 985.287343ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:24.77207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.786655Z","time spent":"985.406986ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-02-05T17:33:24.771771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:33:23.420524Z","time spent":"1.351222516s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:733 > 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":"info","ts":"2026-02-05T17:33:47.06543Z","caller":"traceutil/trace.go:171","msg":"trace[1295148653] linearizableReadLoop","detail":"{readStateIndex:839; appliedIndex:838; }","duration":"132.133359ms","start":"2026-02-05T17:33:46.933275Z","end":"2026-02-05T17:33:47.065409Z","steps":["trace[1295148653] 'read index received'  (duration: 56.23164ms)","trace[1295148653] 'applied index is now lower than readState.Index'  (duration: 75.900399ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:47.065606Z","caller":"traceutil/trace.go:171","msg":"trace[664758175] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"134.110689ms","start":"2026-02-05T17:33:46.931477Z","end":"2026-02-05T17:33:47.065588Z","steps":["trace[664758175] 'process raft request'  (duration: 58.018914ms)","trace[664758175] 'compare'  (duration: 75.778767ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:33:47.065815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.51969ms","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-05T17:33:47.06591Z","caller":"traceutil/trace.go:171","msg":"trace[1328584753] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:807; }","duration":"132.639082ms","start":"2026-02-05T17:33:46.933258Z","end":"2026-02-05T17:33:47.065897Z","steps":["trace[1328584753] 'agreement among raft nodes before linearized reading'  (duration: 132.332545ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:33:47.288658Z","caller":"traceutil/trace.go:171","msg":"trace[69309662] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"214.967732ms","start":"2026-02-05T17:33:47.073662Z","end":"2026-02-05T17:33:47.28863Z","steps":["trace[69309662] 'process raft request'  (duration: 148.361947ms)","trace[69309662] 'compare'  (duration: 66.473411ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:33:47.288747Z","caller":"traceutil/trace.go:171","msg":"trace[1781580944] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"111.600743ms","start":"2026-02-05T17:33:47.177125Z","end":"2026-02-05T17:33:47.288726Z","steps":["trace[1781580944] 'process raft request'  (duration: 111.45787ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:33:47.391536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.495626ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948788991 > lease_revoke:<id:75be9c2edc7a207d>","response":"size:28"}
{"level":"warn","ts":"2026-02-05T17:33:59.729998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.10028ms","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-05T17:33:59.73008Z","caller":"traceutil/trace.go:171","msg":"trace[556803239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:843; }","duration":"121.235433ms","start":"2026-02-05T17:33:59.608828Z","end":"2026-02-05T17:33:59.730063Z","steps":["trace[556803239] 'range keys from in-memory index tree'  (duration: 120.953517ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:03.083914Z","caller":"traceutil/trace.go:171","msg":"trace[1803736745] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"118.083423ms","start":"2026-02-05T17:34:02.965815Z","end":"2026-02-05T17:34:03.083898Z","steps":["trace[1803736745] 'process raft request'  (duration: 117.630163ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:12.062928Z","caller":"traceutil/trace.go:171","msg":"trace[484687216] linearizableReadLoop","detail":"{readStateIndex:933; appliedIndex:932; }","duration":"104.796442ms","start":"2026-02-05T17:34:11.958111Z","end":"2026-02-05T17:34:12.062908Z","steps":["trace[484687216] 'read index received'  (duration: 17.006826ms)","trace[484687216] 'applied index is now lower than readState.Index'  (duration: 87.788656ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:12.063203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.069167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-02-05T17:34:12.063284Z","caller":"traceutil/trace.go:171","msg":"trace[1747864394] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:895; }","duration":"105.380783ms","start":"2026-02-05T17:34:11.957893Z","end":"2026-02-05T17:34:12.063274Z","steps":["trace[1747864394] 'agreement among raft nodes before linearized reading'  (duration: 105.24458ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:12.063529Z","caller":"traceutil/trace.go:171","msg":"trace[1633223410] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"129.686977ms","start":"2026-02-05T17:34:11.933832Z","end":"2026-02-05T17:34:12.063519Z","steps":["trace[1633223410] 'process raft request'  (duration: 41.34576ms)","trace[1633223410] 'compare'  (duration: 87.51125ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:15.531469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.093833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:15.531568Z","caller":"traceutil/trace.go:171","msg":"trace[1415098346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:903; }","duration":"106.259357ms","start":"2026-02-05T17:34:15.425286Z","end":"2026-02-05T17:34:15.531546Z","steps":["trace[1415098346] 'range keys from in-memory index tree'  (duration: 105.95893ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:17.332662Z","caller":"traceutil/trace.go:171","msg":"trace[187446865] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"149.15485ms","start":"2026-02-05T17:34:17.18348Z","end":"2026-02-05T17:34:17.332635Z","steps":["trace[187446865] 'process raft request'  (duration: 149.050518ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:21.614147Z","caller":"traceutil/trace.go:171","msg":"trace[883849725] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"128.852154ms","start":"2026-02-05T17:34:21.485269Z","end":"2026-02-05T17:34:21.614121Z","steps":["trace[883849725] 'process raft request'  (duration: 114.259249ms)","trace[883849725] 'compare'  (duration: 14.33065ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:22.106454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.66939ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948789326 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/local-path-storage/helper-pod-create-pvc-86251401-088a-4141-a1a1-5df7002e4382.18916a2721a62927\" mod_revision:867 > success:<request_put:<key:\"/registry/events/local-path-storage/helper-pod-create-pvc-86251401-088a-4141-a1a1-5df7002e4382.18916a2721a62927\" value_size:742 lease:8484390473094013464 >> failure:<request_range:<key:\"/registry/events/local-path-storage/helper-pod-create-pvc-86251401-088a-4141-a1a1-5df7002e4382.18916a2721a62927\" > >>","response":"size:16"}
{"level":"info","ts":"2026-02-05T17:34:22.106687Z","caller":"traceutil/trace.go:171","msg":"trace[957788982] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"243.300985ms","start":"2026-02-05T17:34:21.863373Z","end":"2026-02-05T17:34:22.106674Z","steps":["trace[957788982] 'process raft request'  (duration: 53.350359ms)","trace[957788982] 'compare'  (duration: 189.321904ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:34:22.164555Z","caller":"traceutil/trace.go:171","msg":"trace[700976733] linearizableReadLoop","detail":"{readStateIndex:964; appliedIndex:962; }","duration":"265.76354ms","start":"2026-02-05T17:34:21.898771Z","end":"2026-02-05T17:34:22.164535Z","steps":["trace[700976733] 'read index received'  (duration: 17.933738ms)","trace[700976733] 'applied index is now lower than readState.Index'  (duration: 247.828992ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:22.164717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.927853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.49\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-02-05T17:34:22.164745Z","caller":"traceutil/trace.go:171","msg":"trace[34055935] range","detail":"{range_begin:/registry/masterleases/162.253.55.49; range_end:; response_count:1; response_revision:924; }","duration":"265.984764ms","start":"2026-02-05T17:34:21.898753Z","end":"2026-02-05T17:34:22.164738Z","steps":["trace[34055935] 'agreement among raft nodes before linearized reading'  (duration: 265.857761ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:22.165028Z","caller":"traceutil/trace.go:171","msg":"trace[39800256] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"296.198817ms","start":"2026-02-05T17:34:21.86882Z","end":"2026-02-05T17:34:22.165019Z","steps":["trace[39800256] 'process raft request'  (duration: 295.618526ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:22.381651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.454464ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948789330 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:15-second id:75be9c2edc7a2251>","response":"size:40"}
{"level":"warn","ts":"2026-02-05T17:34:22.38252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.92867ms","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-05T17:34:22.383793Z","caller":"traceutil/trace.go:171","msg":"trace[1317200073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:924; }","duration":"114.235774ms","start":"2026-02-05T17:34:22.269543Z","end":"2026-02-05T17:34:22.383779Z","steps":["trace[1317200073] 'agreement among raft nodes before linearized reading'  (duration: 112.874559ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:22.382077Z","caller":"traceutil/trace.go:171","msg":"trace[1503112432] linearizableReadLoop","detail":"{readStateIndex:965; appliedIndex:964; }","duration":"112.478181ms","start":"2026-02-05T17:34:22.269581Z","end":"2026-02-05T17:34:22.382059Z","steps":["trace[1503112432] 'read index received'  (duration: 29.741µs)","trace[1503112432] 'applied index is now lower than readState.Index'  (duration: 112.44624ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:34:22.574193Z","caller":"traceutil/trace.go:171","msg":"trace[146399559] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"146.612801ms","start":"2026-02-05T17:34:22.427543Z","end":"2026-02-05T17:34:22.574156Z","steps":["trace[146399559] 'read index received'  (duration: 36.531256ms)","trace[146399559] 'applied index is now lower than readState.Index'  (duration: 110.080135ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:22.585413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.032702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:22.585581Z","caller":"traceutil/trace.go:171","msg":"trace[54450548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:926; }","duration":"153.211845ms","start":"2026-02-05T17:34:22.432352Z","end":"2026-02-05T17:34:22.585564Z","steps":["trace[54450548] 'agreement among raft nodes before linearized reading'  (duration: 152.967781ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:22.585906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.308507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-02-05T17:34:22.58605Z","caller":"traceutil/trace.go:171","msg":"trace[2089231645] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:926; }","duration":"120.46368ms","start":"2026-02-05T17:34:22.465576Z","end":"2026-02-05T17:34:22.58604Z","steps":["trace[2089231645] 'agreement among raft nodes before linearized reading'  (duration: 120.293737ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:22.586521Z","caller":"traceutil/trace.go:171","msg":"trace[1231328016] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"159.053754ms","start":"2026-02-05T17:34:22.427451Z","end":"2026-02-05T17:34:22.586504Z","steps":["trace[1231328016] 'process raft request'  (duration: 59.099528ms)","trace[1231328016] 'compare'  (duration: 86.87389ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:22.595652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.103785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-86251401-088a-4141-a1a1-5df7002e4382\" ","response":"range_response_count:1 size:3700"}
{"level":"info","ts":"2026-02-05T17:34:22.595781Z","caller":"traceutil/trace.go:171","msg":"trace[668582849] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-86251401-088a-4141-a1a1-5df7002e4382; range_end:; response_count:1; response_revision:926; }","duration":"168.225917ms","start":"2026-02-05T17:34:22.427526Z","end":"2026-02-05T17:34:22.595752Z","steps":["trace[668582849] 'agreement among raft nodes before linearized reading'  (duration: 159.404181ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:32.193256Z","caller":"traceutil/trace.go:171","msg":"trace[1418225604] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"226.29536ms","start":"2026-02-05T17:34:31.966935Z","end":"2026-02-05T17:34:32.193231Z","steps":["trace[1418225604] 'read index received'  (duration: 226.085996ms)","trace[1418225604] 'applied index is now lower than readState.Index'  (duration: 208.274µs)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:32.193557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.573844ms","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-05T17:34:32.193654Z","caller":"traceutil/trace.go:171","msg":"trace[467085065] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:970; }","duration":"226.733037ms","start":"2026-02-05T17:34:31.966886Z","end":"2026-02-05T17:34:32.193619Z","steps":["trace[467085065] 'agreement among raft nodes before linearized reading'  (duration: 226.467603ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:32.194002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.240929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:32.194046Z","caller":"traceutil/trace.go:171","msg":"trace[556255280] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:970; }","duration":"150.28885ms","start":"2026-02-05T17:34:32.043745Z","end":"2026-02-05T17:34:32.194034Z","steps":["trace[556255280] 'agreement among raft nodes before linearized reading'  (duration: 150.218949ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:32.194302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.133504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:32.195876Z","caller":"traceutil/trace.go:171","msg":"trace[557196611] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:970; }","duration":"144.706072ms","start":"2026-02-05T17:34:32.051141Z","end":"2026-02-05T17:34:32.195847Z","steps":["trace[557196611] 'agreement among raft nodes before linearized reading'  (duration: 143.103953ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:32.39464Z","caller":"traceutil/trace.go:171","msg":"trace[476233574] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"199.012465ms","start":"2026-02-05T17:34:32.195601Z","end":"2026-02-05T17:34:32.394614Z","steps":["trace[476233574] 'process raft request'  (duration: 197.306655ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:32.908344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.735196ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17707762509948789448 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:966 > 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-05T17:34:32.908453Z","caller":"traceutil/trace.go:171","msg":"trace[296206818] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"710.327995ms","start":"2026-02-05T17:34:32.198099Z","end":"2026-02-05T17:34:32.908427Z","steps":["trace[296206818] 'process raft request'  (duration: 345.440507ms)","trace[296206818] 'compare'  (duration: 364.621733ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:32.90859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:32.198078Z","time spent":"710.441147ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:966 > 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\" > >"}
{"level":"info","ts":"2026-02-05T17:34:32.909917Z","caller":"traceutil/trace.go:171","msg":"trace[991855830] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"513.439138ms","start":"2026-02-05T17:34:32.396462Z","end":"2026-02-05T17:34:32.909901Z","steps":["trace[991855830] 'read index received'  (duration: 147.021923ms)","trace[991855830] 'applied index is now lower than readState.Index'  (duration: 366.414765ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:32.910035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.56404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-02-05T17:34:32.910092Z","caller":"traceutil/trace.go:171","msg":"trace[484207185] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:972; }","duration":"513.617921ms","start":"2026-02-05T17:34:32.39644Z","end":"2026-02-05T17:34:32.910057Z","steps":["trace[484207185] 'agreement among raft nodes before linearized reading'  (duration: 513.55049ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:32.91012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:32.396429Z","time spent":"513.685143ms","remote":"127.0.0.1:36596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "}
{"level":"warn","ts":"2026-02-05T17:34:32.910238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.04411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:32.91029Z","caller":"traceutil/trace.go:171","msg":"trace[1577659292] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"489.092731ms","start":"2026-02-05T17:34:32.42118Z","end":"2026-02-05T17:34:32.910273Z","steps":["trace[1577659292] 'agreement among raft nodes before linearized reading'  (duration: 489.019749ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:32.910327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:32.421148Z","time spent":"489.172021ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-02-05T17:34:32.910465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.300734ms","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-05T17:34:32.910498Z","caller":"traceutil/trace.go:171","msg":"trace[1948812733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"255.362105ms","start":"2026-02-05T17:34:32.655127Z","end":"2026-02-05T17:34:32.910489Z","steps":["trace[1948812733] 'agreement among raft nodes before linearized reading'  (duration: 255.260714ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:33.809545Z","caller":"traceutil/trace.go:171","msg":"trace[1112886432] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1018; }","duration":"126.672241ms","start":"2026-02-05T17:34:33.682851Z","end":"2026-02-05T17:34:33.809523Z","steps":["trace[1112886432] 'read index received'  (duration: 118.281824ms)","trace[1112886432] 'applied index is now lower than readState.Index'  (duration: 8.389757ms)"],"step_count":2}
{"level":"warn","ts":"2026-02-05T17:34:33.809721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.852864ms","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-05T17:34:33.809746Z","caller":"traceutil/trace.go:171","msg":"trace[829856828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:975; }","duration":"126.922365ms","start":"2026-02-05T17:34:33.682816Z","end":"2026-02-05T17:34:33.809738Z","steps":["trace[829856828] 'agreement among raft nodes before linearized reading'  (duration: 126.782243ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:34:33.810106Z","caller":"traceutil/trace.go:171","msg":"trace[1632975739] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"129.088893ms","start":"2026-02-05T17:34:33.681007Z","end":"2026-02-05T17:34:33.810096Z","steps":["trace[1632975739] 'process raft request'  (duration: 120.187977ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.538407Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17707762509948789524,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-02-05T17:34:41.97387Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.019095262s","expected-duration":"1s"}
{"level":"info","ts":"2026-02-05T17:34:41.974435Z","caller":"traceutil/trace.go:171","msg":"trace[369702862] linearizableReadLoop","detail":"{readStateIndex:1045; appliedIndex:1044; }","duration":"936.196189ms","start":"2026-02-05T17:34:41.038215Z","end":"2026-02-05T17:34:41.974411Z","steps":["trace[369702862] 'read index received'  (duration: 935.976865ms)","trace[369702862] 'applied index is now lower than readState.Index'  (duration: 218.334µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:34:41.974635Z","caller":"traceutil/trace.go:171","msg":"trace[882084363] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"1.019920706s","start":"2026-02-05T17:34:40.954699Z","end":"2026-02-05T17:34:41.97462Z","steps":["trace[882084363] 'process raft request'  (duration: 1.01955875s)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.974966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:40.954679Z","time spent":"1.020203231s","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:993 > 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\" > >"}
{"level":"warn","ts":"2026-02-05T17:34:41.975009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.978277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-02-05T17:34:41.975354Z","caller":"traceutil/trace.go:171","msg":"trace[2115350197] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1000; }","duration":"612.262172ms","start":"2026-02-05T17:34:41.362951Z","end":"2026-02-05T17:34:41.975213Z","steps":["trace[2115350197] 'agreement among raft nodes before linearized reading'  (duration: 611.931107ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.97546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:41.362933Z","time spent":"612.492236ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "}
{"level":"warn","ts":"2026-02-05T17:34:41.975962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.739605ms","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-05T17:34:41.976004Z","caller":"traceutil/trace.go:171","msg":"trace[1397057788] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1000; }","duration":"937.807536ms","start":"2026-02-05T17:34:41.038185Z","end":"2026-02-05T17:34:41.975992Z","steps":["trace[1397057788] 'agreement among raft nodes before linearized reading'  (duration: 937.691484ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.976169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:41.038172Z","time spent":"937.986659ms","remote":"127.0.0.1:36716","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-05T17:34:41.9827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.206493ms","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-05T17:34:41.982757Z","caller":"traceutil/trace.go:171","msg":"trace[1903722450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"395.301705ms","start":"2026-02-05T17:34:41.587442Z","end":"2026-02-05T17:34:41.982744Z","steps":["trace[1903722450] 'agreement among raft nodes before linearized reading'  (duration: 395.143632ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.982948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:41.587427Z","time spent":"395.515238ms","remote":"127.0.0.1:36716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-02-05T17:34:41.983165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.671011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-02-05T17:34:41.983184Z","caller":"traceutil/trace.go:171","msg":"trace[1642150955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"558.703791ms","start":"2026-02-05T17:34:41.424476Z","end":"2026-02-05T17:34:41.983179Z","steps":["trace[1642150955] 'agreement among raft nodes before linearized reading'  (duration: 558.65345ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:41.983261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-05T17:34:41.424468Z","time spent":"558.785753ms","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-02-05T17:34:52.279844Z","caller":"traceutil/trace.go:171","msg":"trace[2103616230] linearizableReadLoop","detail":"{readStateIndex:1087; appliedIndex:1086; }","duration":"113.756811ms","start":"2026-02-05T17:34:52.166054Z","end":"2026-02-05T17:34:52.279811Z","steps":["trace[2103616230] 'read index received'  (duration: 111.225941ms)","trace[2103616230] 'applied index is now lower than readState.Index'  (duration: 2.52976ms)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:34:52.280398Z","caller":"traceutil/trace.go:171","msg":"trace[1841570323] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"136.479837ms","start":"2026-02-05T17:34:52.143902Z","end":"2026-02-05T17:34:52.280381Z","steps":["trace[1841570323] 'process raft request'  (duration: 133.463199ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:34:52.281236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.161723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation\" ","response":"range_response_count:1 size:541"}
{"level":"info","ts":"2026-02-05T17:34:52.281288Z","caller":"traceutil/trace.go:171","msg":"trace[613505986] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation; range_end:; response_count:1; response_revision:1038; }","duration":"115.241814ms","start":"2026-02-05T17:34:52.166031Z","end":"2026-02-05T17:34:52.281273Z","steps":["trace[613505986] 'agreement among raft nodes before linearized reading'  (duration: 115.130433ms)"],"step_count":1}
{"level":"info","ts":"2026-02-05T17:35:18.5592Z","caller":"traceutil/trace.go:171","msg":"trace[724412647] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1162; }","duration":"144.026215ms","start":"2026-02-05T17:35:18.415136Z","end":"2026-02-05T17:35:18.559162Z","steps":["trace[724412647] 'read index received'  (duration: 143.450707ms)","trace[724412647] 'applied index is now lower than readState.Index'  (duration: 574.538µs)"],"step_count":2}
{"level":"info","ts":"2026-02-05T17:35:18.55996Z","caller":"traceutil/trace.go:171","msg":"trace[723625062] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"161.232855ms","start":"2026-02-05T17:35:18.398712Z","end":"2026-02-05T17:35:18.559944Z","steps":["trace[723625062] 'process raft request'  (duration: 159.925937ms)"],"step_count":1}
{"level":"warn","ts":"2026-02-05T17:35:18.56086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.706228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-kbmp2\" ","response":"range_response_count:1 size:4847"}
{"level":"info","ts":"2026-02-05T17:35:18.561173Z","caller":"traceutil/trace.go:171","msg":"trace[1041897870] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-kbmp2; range_end:; response_count:1; response_revision:1109; }","duration":"146.038314ms","start":"2026-02-05T17:35:18.415118Z","end":"2026-02-05T17:35:18.561156Z","steps":["trace[1041897870] 'agreement among raft nodes before linearized reading'  (duration: 144.145207ms)"],"step_count":1}