{"level":"warn","ts":"2026-04-18T09:06:15.676505Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-18T09:06:15.6766Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-04-18T09:06:15.676704Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-04-18T09:06:15.676741Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]}
{"level":"info","ts":"2026-04-18T09:06:15.67677Z","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-04-18T09:06:15.677494Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]}
{"level":"info","ts":"2026-04-18T09:06:15.677574Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-04-18T09:06:15.717045Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"39.184949ms"}
{"level":"info","ts":"2026-04-18T09:06:15.763502Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"}
{"level":"info","ts":"2026-04-18T09:06:15.763613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"}
{"level":"info","ts":"2026-04-18T09:06:15.763667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"}
{"level":"info","ts":"2026-04-18T09:06:15.763684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-04-18T09:06:15.763697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"}
{"level":"info","ts":"2026-04-18T09:06:15.763755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"}
{"level":"warn","ts":"2026-04-18T09:06:15.834684Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-04-18T09:06:15.837946Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-04-18T09:06:15.841794Z","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-04-18T09:06:15.849837Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-04-18T09:06:15.850034Z","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-04-18T09:06:15.850184Z","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-04-18T09:06:15.85019Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-04-18T09:06:15.85028Z","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-04-18T09:06:15.859081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"}
{"level":"info","ts":"2026-04-18T09:06:15.859367Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]}
{"level":"info","ts":"2026-04-18T09:06:15.859921Z","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-04-18T09:06:15.860191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"}
{"level":"info","ts":"2026-04-18T09:06:15.860268Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"}
{"level":"info","ts":"2026-04-18T09:06:15.860709Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-04-18T09:06:15.860745Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-04-18T09:06:16.666293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"}
{"level":"info","ts":"2026-04-18T09:06:16.666377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"}
{"level":"info","ts":"2026-04-18T09:06:16.666413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"}
{"level":"info","ts":"2026-04-18T09:06:16.666432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"}
{"level":"info","ts":"2026-04-18T09:06:16.666445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"}
{"level":"info","ts":"2026-04-18T09:06:16.666461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"}
{"level":"info","ts":"2026-04-18T09:06:16.666475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"}
{"level":"info","ts":"2026-04-18T09:06:16.671563Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-18T09:06:16.675583Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-18T09:06:16.675593Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"}
{"level":"info","ts":"2026-04-18T09:06:16.675647Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-04-18T09:06:16.676026Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-04-18T09:06:16.676172Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-04-18T09:06:16.678658Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-18T09:06:16.678796Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-18T09:06:16.678866Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-04-18T09:06:16.679067Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-04-18T09:06:16.679416Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"}
{"level":"info","ts":"2026-04-18T09:06:18.253222Z","caller":"traceutil/trace.go:171","msg":"trace[1188310089] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"180.162792ms","start":"2026-04-18T09:06:18.07301Z","end":"2026-04-18T09:06:18.253173Z","steps":["trace[1188310089] 'process raft request'  (duration: 179.974886ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.253327Z","caller":"traceutil/trace.go:171","msg":"trace[731484683] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"179.954775ms","start":"2026-04-18T09:06:18.073354Z","end":"2026-04-18T09:06:18.253309Z","steps":["trace[731484683] 'process raft request'  (duration: 179.870132ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.253326Z","caller":"traceutil/trace.go:171","msg":"trace[926127274] linearizableReadLoop","detail":"{readStateIndex:12; appliedIndex:7; }","duration":"178.855729ms","start":"2026-04-18T09:06:18.074439Z","end":"2026-04-18T09:06:18.253295Z","steps":["trace[926127274] 'read index received'  (duration: 178.524549ms)","trace[926127274] 'applied index is now lower than readState.Index'  (duration: 329.92µs)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:18.253466Z","caller":"traceutil/trace.go:171","msg":"trace[257925465] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"180.097269ms","start":"2026-04-18T09:06:18.073357Z","end":"2026-04-18T09:06:18.253455Z","steps":["trace[257925465] 'process raft request'  (duration: 179.904143ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.253491Z","caller":"traceutil/trace.go:171","msg":"trace[625771132] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"180.14024ms","start":"2026-04-18T09:06:18.07331Z","end":"2026-04-18T09:06:18.25345Z","steps":["trace[625771132] 'process raft request'  (duration: 179.848561ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.253268Z","caller":"traceutil/trace.go:171","msg":"trace[2046838003] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"180.173402ms","start":"2026-04-18T09:06:18.073069Z","end":"2026-04-18T09:06:18.253243Z","steps":["trace[2046838003] 'process raft request'  (duration: 180.055298ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:18.253803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.458893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-18T09:06:18.253969Z","caller":"traceutil/trace.go:171","msg":"trace[1077568040] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"182.636577ms","start":"2026-04-18T09:06:18.071272Z","end":"2026-04-18T09:06:18.253908Z","steps":["trace[1077568040] 'agreement among raft nodes before linearized reading'  (duration: 182.294817ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.286011Z","caller":"traceutil/trace.go:171","msg":"trace[1027776046] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"208.639512ms","start":"2026-04-18T09:06:18.077335Z","end":"2026-04-18T09:06:18.285975Z","steps":["trace[1027776046] 'process raft request'  (duration: 208.470487ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:18.286265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.617909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"}
{"level":"info","ts":"2026-04-18T09:06:18.286321Z","caller":"traceutil/trace.go:171","msg":"trace[1381064185] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:11; }","duration":"168.717142ms","start":"2026-04-18T09:06:18.11759Z","end":"2026-04-18T09:06:18.286308Z","steps":["trace[1381064185] 'agreement among raft nodes before linearized reading'  (duration: 168.512576ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.286011Z","caller":"traceutil/trace.go:171","msg":"trace[1792593313] transaction","detail":"{read_only:false; number_of_response:0; response_revision:10; }","duration":"209.967274ms","start":"2026-04-18T09:06:18.075979Z","end":"2026-04-18T09:06:18.285947Z","steps":["trace[1792593313] 'process raft request'  (duration: 209.796649ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.286007Z","caller":"traceutil/trace.go:171","msg":"trace[1579349336] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"209.86322ms","start":"2026-04-18T09:06:18.075983Z","end":"2026-04-18T09:06:18.285847Z","steps":["trace[1579349336] 'process raft request'  (duration: 209.684804ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.468487Z","caller":"traceutil/trace.go:171","msg":"trace[1980867155] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"114.294478ms","start":"2026-04-18T09:06:18.354168Z","end":"2026-04-18T09:06:18.468462Z","steps":["trace[1980867155] 'process raft request'  (duration: 114.250427ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.468511Z","caller":"traceutil/trace.go:171","msg":"trace[140371664] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"117.916802ms","start":"2026-04-18T09:06:18.35057Z","end":"2026-04-18T09:06:18.468487Z","steps":["trace[140371664] 'process raft request'  (duration: 117.731866ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.779149Z","caller":"traceutil/trace.go:171","msg":"trace[1982830515] linearizableReadLoop","detail":"{readStateIndex:50; appliedIndex:48; }","duration":"119.638505ms","start":"2026-04-18T09:06:18.659495Z","end":"2026-04-18T09:06:18.779134Z","steps":["trace[1982830515] 'read index received'  (duration: 113.08219ms)","trace[1982830515] 'applied index is now lower than readState.Index'  (duration: 6.555825ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:18.779242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.734887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-18T09:06:18.779265Z","caller":"traceutil/trace.go:171","msg":"trace[497228352] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:46; }","duration":"119.80442ms","start":"2026-04-18T09:06:18.659452Z","end":"2026-04-18T09:06:18.779257Z","steps":["trace[497228352] 'agreement among raft nodes before linearized reading'  (duration: 119.755269ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.779388Z","caller":"traceutil/trace.go:171","msg":"trace[1012519962] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"131.506986ms","start":"2026-04-18T09:06:18.647873Z","end":"2026-04-18T09:06:18.77938Z","steps":["trace[1012519962] 'process raft request'  (duration: 131.233778ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:18.779195Z","caller":"traceutil/trace.go:171","msg":"trace[636452318] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"132.342024ms","start":"2026-04-18T09:06:18.646823Z","end":"2026-04-18T09:06:18.779165Z","steps":["trace[636452318] 'process raft request'  (duration: 125.765018ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:19.010175Z","caller":"traceutil/trace.go:171","msg":"trace[991767873] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"166.744518ms","start":"2026-04-18T09:06:18.843403Z","end":"2026-04-18T09:06:19.010147Z","steps":["trace[991767873] 'process raft request'  (duration: 87.651095ms)","trace[991767873] 'compare'  (duration: 78.907047ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:19.010453Z","caller":"traceutil/trace.go:171","msg":"trace[1477846969] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:56; }","duration":"158.610524ms","start":"2026-04-18T09:06:18.851813Z","end":"2026-04-18T09:06:19.010423Z","steps":["trace[1477846969] 'read index received'  (duration: 79.332425ms)","trace[1477846969] 'applied index is now lower than readState.Index'  (duration: 79.276298ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:19.010723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.885602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-04-18T09:06:19.010776Z","caller":"traceutil/trace.go:171","msg":"trace[29234582] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:54; }","duration":"158.980655ms","start":"2026-04-18T09:06:18.851783Z","end":"2026-04-18T09:06:19.010763Z","steps":["trace[29234582] 'agreement among raft nodes before linearized reading'  (duration: 158.880852ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:19.010872Z","caller":"traceutil/trace.go:171","msg":"trace[547303242] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"159.591564ms","start":"2026-04-18T09:06:18.851266Z","end":"2026-04-18T09:06:19.010857Z","steps":["trace[547303242] 'process raft request'  (duration: 158.837311ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:19.337626Z","caller":"traceutil/trace.go:171","msg":"trace[2069157048] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"134.585717ms","start":"2026-04-18T09:06:19.202998Z","end":"2026-04-18T09:06:19.337584Z","steps":["trace[2069157048] 'process raft request'  (duration: 73.64592ms)","trace[2069157048] 'compare'  (duration: 60.71158ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:19.337688Z","caller":"traceutil/trace.go:171","msg":"trace[1032215984] transaction","detail":"{read_only:false; response_revision:66; number_of_response:1; }","duration":"127.594401ms","start":"2026-04-18T09:06:19.210069Z","end":"2026-04-18T09:06:19.337664Z","steps":["trace[1032215984] 'process raft request'  (duration: 127.442896ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:19.338073Z","caller":"traceutil/trace.go:171","msg":"trace[1958957227] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"127.717895ms","start":"2026-04-18T09:06:19.210341Z","end":"2026-04-18T09:06:19.338059Z","steps":["trace[1958957227] 'process raft request'  (duration: 127.22074ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:21.02892Z","caller":"traceutil/trace.go:171","msg":"trace[334972709] linearizableReadLoop","detail":"{readStateIndex:180; appliedIndex:179; }","duration":"177.689163ms","start":"2026-04-18T09:06:20.851204Z","end":"2026-04-18T09:06:21.028893Z","steps":["trace[334972709] 'read index received'  (duration: 108.956907ms)","trace[334972709] 'applied index is now lower than readState.Index'  (duration: 68.731296ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:21.028994Z","caller":"traceutil/trace.go:171","msg":"trace[682896819] transaction","detail":"{read_only:false; response_revision:176; number_of_response:1; }","duration":"204.198434ms","start":"2026-04-18T09:06:20.824761Z","end":"2026-04-18T09:06:21.028959Z","steps":["trace[682896819] 'process raft request'  (duration: 135.465628ms)","trace[682896819] 'compare'  (duration: 68.52404ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:21.029076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.853639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-system/system:controller:cloud-provider\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:21.029126Z","caller":"traceutil/trace.go:171","msg":"trace[768942507] range","detail":"{range_begin:/registry/roles/kube-system/system:controller:cloud-provider; range_end:; response_count:0; response_revision:176; }","duration":"177.941681ms","start":"2026-04-18T09:06:20.851169Z","end":"2026-04-18T09:06:21.02911Z","steps":["trace[768942507] 'agreement among raft nodes before linearized reading'  (duration: 177.827047ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:21.748585Z","caller":"traceutil/trace.go:171","msg":"trace[1798031207] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"109.214558ms","start":"2026-04-18T09:06:21.639347Z","end":"2026-04-18T09:06:21.748562Z","steps":["trace[1798031207] 'process raft request'  (duration: 109.053303ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:22.900029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378560805,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:06:23.400896Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378560805,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:06:23.608763Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.280795745s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-18T09:06:23.609124Z","caller":"traceutil/trace.go:171","msg":"trace[1299971352] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"1.281183895s","start":"2026-04-18T09:06:22.327912Z","end":"2026-04-18T09:06:23.609096Z","steps":["trace[1299971352] 'process raft request'  (duration: 1.281035041s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:23.609698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:22.327901Z","time spent":"1.281287149s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/ttl-after-finished-controller\" value_size:134 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:24.699357Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.090435562s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-18T09:06:24.7274Z","caller":"traceutil/trace.go:171","msg":"trace[266435406] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:217; }","duration":"2.327474236s","start":"2026-04-18T09:06:22.399892Z","end":"2026-04-18T09:06:24.727366Z","steps":["trace[266435406] 'read index received'  (duration: 1.209119786s)","trace[266435406] 'applied index is now lower than readState.Index'  (duration: 1.11835337s)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:24.727536Z","caller":"traceutil/trace.go:171","msg":"trace[87000063] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"2.033710455s","start":"2026-04-18T09:06:22.69378Z","end":"2026-04-18T09:06:24.72749Z","steps":["trace[87000063] 'process raft request'  (duration: 2.005761906s)","trace[87000063] 'compare'  (duration: 27.554928ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:24.727712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:22.693752Z","time spent":"2.033879551s","remote":"127.0.0.1:45344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18a76838152a0615\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18a76838152a0615\" value_size:524 lease:5794898655378560736 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:24.727755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.401374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-18T09:06:24.727752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.114532156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:24.727796Z","caller":"traceutil/trace.go:171","msg":"trace[191607646] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:214; }","duration":"779.511708ms","start":"2026-04-18T09:06:23.948273Z","end":"2026-04-18T09:06:24.727785Z","steps":["trace[191607646] 'agreement among raft nodes before linearized reading'  (duration: 779.347443ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:24.727787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.92402907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-18T09:06:24.727792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.327854967s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3602"}
{"level":"warn","ts":"2026-04-18T09:06:24.727828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:23.948236Z","time spent":"779.58519ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.727836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.460307062s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"}
{"level":"info","ts":"2026-04-18T09:06:24.727828Z","caller":"traceutil/trace.go:171","msg":"trace[996528505] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:214; }","duration":"1.11465273s","start":"2026-04-18T09:06:23.613156Z","end":"2026-04-18T09:06:24.727809Z","steps":["trace[996528505] 'agreement among raft nodes before linearized reading'  (duration: 1.114508245s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:24.727854Z","caller":"traceutil/trace.go:171","msg":"trace[1489959499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:214; }","duration":"1.924168153s","start":"2026-04-18T09:06:22.803668Z","end":"2026-04-18T09:06:24.727836Z","steps":["trace[1489959499] 'agreement among raft nodes before linearized reading'  (duration: 1.923939247s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:24.727871Z","caller":"traceutil/trace.go:171","msg":"trace[353017073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:214; }","duration":"1.460378724s","start":"2026-04-18T09:06:23.267479Z","end":"2026-04-18T09:06:24.727858Z","steps":["trace[353017073] 'agreement among raft nodes before linearized reading'  (duration: 1.460329433s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:24.727862Z","caller":"traceutil/trace.go:171","msg":"trace[1849533213] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:214; }","duration":"2.327990571s","start":"2026-04-18T09:06:22.399856Z","end":"2026-04-18T09:06:24.727846Z","steps":["trace[1849533213] 'agreement among raft nodes before linearized reading'  (duration: 2.327741374s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:24.727899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:23.267454Z","time spent":"1.460441146s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.727905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:23.61314Z","time spent":"1.114733992s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.727917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:22.39984Z","time spent":"2.328062943s","remote":"127.0.0.1:45436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3626,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.727921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:22.803646Z","time spent":"1.924256986s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.72777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354841948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:06:24.727973Z","caller":"traceutil/trace.go:171","msg":"trace[995551898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:214; }","duration":"1.355083044s","start":"2026-04-18T09:06:23.372882Z","end":"2026-04-18T09:06:24.727965Z","steps":["trace[995551898] 'agreement among raft nodes before linearized reading'  (duration: 1.354779465s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:24.727997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:23.372863Z","time spent":"1.355129266s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-18T09:06:24.728069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.308964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:24.728092Z","caller":"traceutil/trace.go:171","msg":"trace[1323713196] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:214; }","duration":"707.361936ms","start":"2026-04-18T09:06:24.020722Z","end":"2026-04-18T09:06:24.728084Z","steps":["trace[1323713196] 'agreement among raft nodes before linearized reading'  (duration: 707.326895ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:24.72811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:24.020704Z","time spent":"707.402497ms","remote":"127.0.0.1:45652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":29,"request content":"key:\"/registry/csinodes/instance\" "}
{"level":"info","ts":"2026-04-18T09:06:24.727562Z","caller":"traceutil/trace.go:171","msg":"trace[1610901494] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"1.725050228s","start":"2026-04-18T09:06:23.002476Z","end":"2026-04-18T09:06:24.727526Z","steps":["trace[1610901494] 'process raft request'  (duration: 1.724821362s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:24.728301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:23.002445Z","time spent":"1.725816411s","remote":"127.0.0.1:45514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-vkt2s\" mod_revision:0 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-vkt2s\" value_size:791 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:06:25.182748Z","caller":"traceutil/trace.go:171","msg":"trace[2020700813] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"109.995039ms","start":"2026-04-18T09:06:25.072723Z","end":"2026-04-18T09:06:25.182718Z","steps":["trace[2020700813] 'process raft request'  (duration: 109.933078ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:25.182992Z","caller":"traceutil/trace.go:171","msg":"trace[2091337262] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"111.183384ms","start":"2026-04-18T09:06:25.071765Z","end":"2026-04-18T09:06:25.182948Z","steps":["trace[2091337262] 'process raft request'  (duration: 92.650527ms)","trace[2091337262] 'compare'  (duration: 18.106985ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:25.674874Z","caller":"traceutil/trace.go:171","msg":"trace[11533103] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:273; }","duration":"117.137627ms","start":"2026-04-18T09:06:25.557709Z","end":"2026-04-18T09:06:25.674846Z","steps":["trace[11533103] 'read index received'  (duration: 106.054876ms)","trace[11533103] 'applied index is now lower than readState.Index'  (duration: 11.077951ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:25.675074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.338403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:25.675136Z","caller":"traceutil/trace.go:171","msg":"trace[791640096] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:269; }","duration":"117.431586ms","start":"2026-04-18T09:06:25.557686Z","end":"2026-04-18T09:06:25.675118Z","steps":["trace[791640096] 'agreement among raft nodes before linearized reading'  (duration: 117.274562ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:25.675241Z","caller":"traceutil/trace.go:171","msg":"trace[2134040189] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"144.041947ms","start":"2026-04-18T09:06:25.531164Z","end":"2026-04-18T09:06:25.675206Z","steps":["trace[2134040189] 'process raft request'  (duration: 132.582854ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:25.675293Z","caller":"traceutil/trace.go:171","msg":"trace[1342347595] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"124.851871ms","start":"2026-04-18T09:06:25.550416Z","end":"2026-04-18T09:06:25.675267Z","steps":["trace[1342347595] 'process raft request'  (duration: 124.352187ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:25.938818Z","caller":"traceutil/trace.go:171","msg":"trace[628920178] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"115.049396ms","start":"2026-04-18T09:06:25.823735Z","end":"2026-04-18T09:06:25.938785Z","steps":["trace[628920178] 'process raft request'  (duration: 95.791278ms)","trace[628920178] 'compare'  (duration: 18.860297ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:25.938886Z","caller":"traceutil/trace.go:171","msg":"trace[350754463] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:282; }","duration":"113.780199ms","start":"2026-04-18T09:06:25.825062Z","end":"2026-04-18T09:06:25.938842Z","steps":["trace[350754463] 'read index received'  (duration: 20.165485ms)","trace[350754463] 'applied index is now lower than readState.Index'  (duration: 93.609674ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:25.939061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.993435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"}
{"level":"info","ts":"2026-04-18T09:06:25.939113Z","caller":"traceutil/trace.go:171","msg":"trace[589719042] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:278; }","duration":"114.093599ms","start":"2026-04-18T09:06:25.825004Z","end":"2026-04-18T09:06:25.939098Z","steps":["trace[589719042] 'agreement among raft nodes before linearized reading'  (duration: 113.970496ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:26.794668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.497337ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378560993 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:261 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4148 >> failure:<request_range:<key:\"/registry/minions/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:06:26.794902Z","caller":"traceutil/trace.go:171","msg":"trace[223036285] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"291.283107ms","start":"2026-04-18T09:06:26.503602Z","end":"2026-04-18T09:06:26.794885Z","steps":["trace[223036285] 'process raft request'  (duration: 87.1331ms)","trace[223036285] 'compare'  (duration: 203.352304ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:26.794902Z","caller":"traceutil/trace.go:171","msg":"trace[262794814] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:318; }","duration":"269.897284ms","start":"2026-04-18T09:06:26.524985Z","end":"2026-04-18T09:06:26.794883Z","steps":["trace[262794814] 'read index received'  (duration: 65.674345ms)","trace[262794814] 'applied index is now lower than readState.Index'  (duration: 204.221669ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:26.795032Z","caller":"traceutil/trace.go:171","msg":"trace[449362650] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"289.909918ms","start":"2026-04-18T09:06:26.50511Z","end":"2026-04-18T09:06:26.795019Z","steps":["trace[449362650] 'process raft request'  (duration: 289.675341ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:26.795147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.246265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/attachdetach-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:26.79521Z","caller":"traceutil/trace.go:171","msg":"trace[234086360] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/attachdetach-controller; range_end:; response_count:0; response_revision:313; }","duration":"261.327667ms","start":"2026-04-18T09:06:26.533861Z","end":"2026-04-18T09:06:26.795188Z","steps":["trace[234086360] 'agreement among raft nodes before linearized reading'  (duration: 261.188323ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:26.795228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.236804ms","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:5"}
{"level":"info","ts":"2026-04-18T09:06:26.795252Z","caller":"traceutil/trace.go:171","msg":"trace[24439805] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:313; }","duration":"270.290895ms","start":"2026-04-18T09:06:26.524954Z","end":"2026-04-18T09:06:26.795245Z","steps":["trace[24439805] 'agreement among raft nodes before linearized reading'  (duration: 270.253064ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988558Z","caller":"traceutil/trace.go:171","msg":"trace[1309396062] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"189.864717ms","start":"2026-04-18T09:06:26.798675Z","end":"2026-04-18T09:06:26.98854Z","steps":["trace[1309396062] 'process raft request'  (duration: 189.693062ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988641Z","caller":"traceutil/trace.go:171","msg":"trace[377574071] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"189.874237ms","start":"2026-04-18T09:06:26.798742Z","end":"2026-04-18T09:06:26.988616Z","steps":["trace[377574071] 'process raft request'  (duration: 189.659111ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988652Z","caller":"traceutil/trace.go:171","msg":"trace[1119815306] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"188.20841ms","start":"2026-04-18T09:06:26.800417Z","end":"2026-04-18T09:06:26.988626Z","steps":["trace[1119815306] 'process raft request'  (duration: 188.094526ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988678Z","caller":"traceutil/trace.go:171","msg":"trace[519617670] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"190.29618ms","start":"2026-04-18T09:06:26.798373Z","end":"2026-04-18T09:06:26.988669Z","steps":["trace[519617670] 'process raft request'  (duration: 176.629088ms)","trace[519617670] 'compare'  (duration: 13.177828ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:26.988655Z","caller":"traceutil/trace.go:171","msg":"trace[549026441] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"188.122297ms","start":"2026-04-18T09:06:26.800508Z","end":"2026-04-18T09:06:26.98863Z","steps":["trace[549026441] 'process raft request'  (duration: 188.063305ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988734Z","caller":"traceutil/trace.go:171","msg":"trace[462731416] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"190.124945ms","start":"2026-04-18T09:06:26.798605Z","end":"2026-04-18T09:06:26.98873Z","steps":["trace[462731416] 'process raft request'  (duration: 189.728253ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.98886Z","caller":"traceutil/trace.go:171","msg":"trace[657364516] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"189.557489ms","start":"2026-04-18T09:06:26.799264Z","end":"2026-04-18T09:06:26.988822Z","steps":["trace[657364516] 'process raft request'  (duration: 189.21805ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.988994Z","caller":"traceutil/trace.go:171","msg":"trace[1755508854] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"188.532379ms","start":"2026-04-18T09:06:26.800446Z","end":"2026-04-18T09:06:26.988978Z","steps":["trace[1755508854] 'process raft request'  (duration: 188.100496ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:26.989197Z","caller":"traceutil/trace.go:171","msg":"trace[506875167] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"190.070424ms","start":"2026-04-18T09:06:26.799114Z","end":"2026-04-18T09:06:26.989184Z","steps":["trace[506875167] 'process raft request'  (duration: 189.318112ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:27.641209Z","caller":"traceutil/trace.go:171","msg":"trace[986059417] transaction","detail":"{read_only:false; number_of_response:0; response_revision:328; }","duration":"198.572937ms","start":"2026-04-18T09:06:27.442612Z","end":"2026-04-18T09:06:27.641185Z","steps":["trace[986059417] 'process raft request'  (duration: 186.100912ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:27.706901Z","caller":"traceutil/trace.go:171","msg":"trace[1242231877] transaction","detail":"{read_only:false; number_of_response:0; response_revision:328; }","duration":"264.22646ms","start":"2026-04-18T09:06:27.44265Z","end":"2026-04-18T09:06:27.706876Z","steps":["trace[1242231877] 'process raft request'  (duration: 264.049385ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:27.707012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.910027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-04-18T09:06:27.707051Z","caller":"traceutil/trace.go:171","msg":"trace[625863358] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:329; }","duration":"222.998099ms","start":"2026-04-18T09:06:27.484044Z","end":"2026-04-18T09:06:27.707042Z","steps":["trace[625863358] 'agreement among raft nodes before linearized reading'  (duration: 222.916507ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:27.706911Z","caller":"traceutil/trace.go:171","msg":"trace[1696318491] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:335; }","duration":"222.807334ms","start":"2026-04-18T09:06:27.48408Z","end":"2026-04-18T09:06:27.706888Z","steps":["trace[1696318491] 'read index received'  (duration: 144.704477ms)","trace[1696318491] 'applied index is now lower than readState.Index'  (duration: 78.101907ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:27.707389Z","caller":"traceutil/trace.go:171","msg":"trace[1581755194] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"238.376916ms","start":"2026-04-18T09:06:27.468805Z","end":"2026-04-18T09:06:27.707182Z","steps":["trace[1581755194] 'process raft request'  (duration: 237.984335ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:27.889602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.918027ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561034 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" value_size:139 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:06:27.889953Z","caller":"traceutil/trace.go:171","msg":"trace[578694340] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"176.82368ms","start":"2026-04-18T09:06:27.713095Z","end":"2026-04-18T09:06:27.889919Z","steps":["trace[578694340] 'process raft request'  (duration: 46.522541ms)","trace[578694340] 'compare'  (duration: 129.596209ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:27.891399Z","caller":"traceutil/trace.go:171","msg":"trace[928966431] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"175.204902ms","start":"2026-04-18T09:06:27.716176Z","end":"2026-04-18T09:06:27.891381Z","steps":["trace[928966431] 'process raft request'  (duration: 175.11035ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:29.054848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.749951ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561089 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/admin\" mod_revision:353 > success:<request_put:<key:\"/registry/clusterroles/admin\" value_size:3498 >> failure:<request_range:<key:\"/registry/clusterroles/admin\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:06:29.054934Z","caller":"traceutil/trace.go:171","msg":"trace[1008361238] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:363; }","duration":"270.497191ms","start":"2026-04-18T09:06:28.784425Z","end":"2026-04-18T09:06:29.054922Z","steps":["trace[1008361238] 'read index received'  (duration: 580.666µs)","trace[1008361238] 'applied index is now lower than readState.Index'  (duration: 269.915555ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:29.055039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.520448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-04-18T09:06:29.055059Z","caller":"traceutil/trace.go:171","msg":"trace[2020806374] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:355; }","duration":"220.613251ms","start":"2026-04-18T09:06:28.834439Z","end":"2026-04-18T09:06:29.055052Z","steps":["trace[2020806374] 'agreement among raft nodes before linearized reading'  (duration: 220.566118ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:29.055081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.633146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"}
{"level":"info","ts":"2026-04-18T09:06:29.055172Z","caller":"traceutil/trace.go:171","msg":"trace[360436643] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:355; }","duration":"270.763019ms","start":"2026-04-18T09:06:28.784389Z","end":"2026-04-18T09:06:29.055152Z","steps":["trace[360436643] 'agreement among raft nodes before linearized reading'  (duration: 270.620575ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:29.055411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.580135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-04-18T09:06:29.055506Z","caller":"traceutil/trace.go:171","msg":"trace[1754290277] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:355; }","duration":"170.706759ms","start":"2026-04-18T09:06:28.884784Z","end":"2026-04-18T09:06:29.05549Z","steps":["trace[1754290277] 'agreement among raft nodes before linearized reading'  (duration: 170.564965ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:29.05558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.060073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"info","ts":"2026-04-18T09:06:29.055676Z","caller":"traceutil/trace.go:171","msg":"trace[762457200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:355; }","duration":"122.208277ms","start":"2026-04-18T09:06:28.933444Z","end":"2026-04-18T09:06:29.055652Z","steps":["trace[762457200] 'agreement among raft nodes before linearized reading'  (duration: 121.986451ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:29.055843Z","caller":"traceutil/trace.go:171","msg":"trace[1319265975] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"294.032343ms","start":"2026-04-18T09:06:28.761107Z","end":"2026-04-18T09:06:29.055139Z","steps":["trace[1319265975] 'process raft request'  (duration: 23.920232ms)","trace[1319265975] 'compare'  (duration: 269.643777ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:31.400794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99994162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-18T09:06:31.400929Z","caller":"traceutil/trace.go:171","msg":"trace[1264304409] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000119435s","start":"2026-04-18T09:06:29.40079Z","end":"2026-04-18T09:06:31.400909Z","steps":["trace[1264304409] 'agreement among raft nodes before linearized reading'  (duration: 1.999967831s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.400978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.400772Z","time spent":"2.000197616s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/18 09:06:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-18T09:06:31.678646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.411807404s","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561093 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:322 > 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-04-18T09:06:31.678915Z","caller":"traceutil/trace.go:171","msg":"trace[86645220] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"2.615573387s","start":"2026-04-18T09:06:29.063315Z","end":"2026-04-18T09:06:31.678889Z","steps":["trace[86645220] 'process raft request'  (duration: 2.615425123s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:31.679065Z","caller":"traceutil/trace.go:171","msg":"trace[1320982315] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"2.615652089s","start":"2026-04-18T09:06:29.063389Z","end":"2026-04-18T09:06:31.679041Z","steps":["trace[1320982315] 'process raft request'  (duration: 2.615400773s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.67907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.063303Z","time spent":"2.615681611s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:319 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-04-18T09:06:31.679166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.063376Z","time spent":"2.615752163s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:320 > 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-04-18T09:06:31.679343Z","caller":"traceutil/trace.go:171","msg":"trace[507730923] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"2.615721141s","start":"2026-04-18T09:06:29.063558Z","end":"2026-04-18T09:06:31.679279Z","steps":["trace[507730923] 'process raft request'  (duration: 2.615261928s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.679613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.063553Z","time spent":"2.615935976s","remote":"127.0.0.1:45426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/kube-dns\" mod_revision:0 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/kube-dns\" value_size:539 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:06:31.679652Z","caller":"traceutil/trace.go:171","msg":"trace[483107563] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"2.6149851s","start":"2026-04-18T09:06:29.064653Z","end":"2026-04-18T09:06:31.679638Z","steps":["trace[483107563] 'process raft request'  (duration: 2.614533838s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:31.679696Z","caller":"traceutil/trace.go:171","msg":"trace[1532080331] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"2.614939809s","start":"2026-04-18T09:06:29.06472Z","end":"2026-04-18T09:06:31.67966Z","steps":["trace[1532080331] 'process raft request'  (duration: 2.61461758s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:31.679733Z","caller":"traceutil/trace.go:171","msg":"trace[857838684] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:364; }","duration":"2.596760674s","start":"2026-04-18T09:06:29.082948Z","end":"2026-04-18T09:06:31.679708Z","steps":["trace[857838684] 'read index received'  (duration: 63.732061ms)","trace[857838684] 'applied index is now lower than readState.Index'  (duration: 2.533025303s)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:31.679837Z","caller":"traceutil/trace.go:171","msg":"trace[1734282940] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"2.613689684s","start":"2026-04-18T09:06:29.066138Z","end":"2026-04-18T09:06:31.679828Z","steps":["trace[1734282940] 'process raft request'  (duration: 2.613489699s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.679874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.064713Z","time spent":"2.615081682s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/default/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/default/default\" value_size:108 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:06:31.679916Z","caller":"traceutil/trace.go:171","msg":"trace[1860062298] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"2.615040191s","start":"2026-04-18T09:06:29.064865Z","end":"2026-04-18T09:06:31.679905Z","steps":["trace[1860062298] 'process raft request'  (duration: 2.614668681s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.679935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.066074Z","time spent":"2.613800578s","remote":"127.0.0.1:45730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/controllerrevisions/kube-system/kube-proxy-5dcf78dfbb\" mod_revision:0 > success:<request_put:<key:\"/registry/controllerrevisions/kube-system/kube-proxy-5dcf78dfbb\" value_size:2079 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:31.680024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.064848Z","time spent":"2.615149115s","remote":"127.0.0.1:45546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/kube-dns-mnbdc\" mod_revision:0 > success:<request_put:<key:\"/registry/endpointslices/kube-system/kube-dns-mnbdc\" value_size:991 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:31.679739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.064638Z","time spent":"2.615065912s","remote":"127.0.0.1:45366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-public/cluster-info\" mod_revision:277 > success:<request_put:<key:\"/registry/configmaps/kube-public/cluster-info\" value_size:2109 >> failure:<request_range:<key:\"/registry/configmaps/kube-public/cluster-info\" > >"}
{"level":"info","ts":"2026-04-18T09:06:31.680223Z","caller":"traceutil/trace.go:171","msg":"trace[1645600480] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"2.613603592s","start":"2026-04-18T09:06:29.066609Z","end":"2026-04-18T09:06:31.680213Z","steps":["trace[1645600480] 'process raft request'  (duration: 2.613050176s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.680315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.066603Z","time spent":"2.613655553s","remote":"127.0.0.1:45514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1247,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/certificatesigningrequests/csr-vkt2s\" mod_revision:214 > success:<request_put:<key:\"/registry/certificatesigningrequests/csr-vkt2s\" value_size:1193 >> failure:<request_range:<key:\"/registry/certificatesigningrequests/csr-vkt2s\" > >"}
{"level":"warn","ts":"2026-04-18T09:06:31.680493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.597536206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"info","ts":"2026-04-18T09:06:31.680549Z","caller":"traceutil/trace.go:171","msg":"trace[2043840058] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:365; }","duration":"2.597633538s","start":"2026-04-18T09:06:29.082902Z","end":"2026-04-18T09:06:31.680535Z","steps":["trace[2043840058] 'agreement among raft nodes before linearized reading'  (duration: 2.597518525s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.680587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.082885Z","time spent":"2.597694351s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "}
{"level":"info","ts":"2026-04-18T09:06:31.680938Z","caller":"traceutil/trace.go:171","msg":"trace[866706973] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"2.61787033s","start":"2026-04-18T09:06:29.06304Z","end":"2026-04-18T09:06:31.68091Z","steps":["trace[866706973] 'process raft request'  (duration: 203.718662ms)","trace[866706973] 'compare'  (duration: 2.411667931s)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:31.681129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.547860655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-04-18T09:06:31.68117Z","caller":"traceutil/trace.go:171","msg":"trace[218083585] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:366; }","duration":"2.547935867s","start":"2026-04-18T09:06:29.133223Z","end":"2026-04-18T09:06:31.681159Z","steps":["trace[218083585] 'agreement among raft nodes before linearized reading'  (duration: 2.547846165s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.681194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.133207Z","time spent":"2.547981418s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "}
{"level":"warn","ts":"2026-04-18T09:06:31.681263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.06302Z","time spent":"2.618018834s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:322 > 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-04-18T09:06:31.681345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.673076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-18T09:06:31.681377Z","caller":"traceutil/trace.go:171","msg":"trace[2026173561] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:366; }","duration":"209.734898ms","start":"2026-04-18T09:06:31.471634Z","end":"2026-04-18T09:06:31.681369Z","steps":["trace[2026173561] 'agreement among raft nodes before linearized reading'  (duration: 209.683126ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.681491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.725626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:06:31.681515Z","caller":"traceutil/trace.go:171","msg":"trace[915334801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:366; }","duration":"529.791047ms","start":"2026-04-18T09:06:31.151719Z","end":"2026-04-18T09:06:31.68151Z","steps":["trace[915334801] 'agreement among raft nodes before linearized reading'  (duration: 529.750146ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.681533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:31.15169Z","time spent":"529.839049ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-18T09:06:31.681301Z","caller":"traceutil/trace.go:171","msg":"trace[1767430239] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"276.207107ms","start":"2026-04-18T09:06:31.405085Z","end":"2026-04-18T09:06:31.681292Z","steps":["trace[1767430239] 'process raft request'  (duration: 275.916869ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.682059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.497918715s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-04-18T09:06:31.682119Z","caller":"traceutil/trace.go:171","msg":"trace[1695696984] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:366; }","duration":"2.498020697s","start":"2026-04-18T09:06:29.184085Z","end":"2026-04-18T09:06:31.682106Z","steps":["trace[1695696984] 'agreement among raft nodes before linearized reading'  (duration: 2.497908164s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:31.682155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:29.184062Z","time spent":"2.49808394s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "}
{"level":"info","ts":"2026-04-18T09:06:31.947191Z","caller":"traceutil/trace.go:171","msg":"trace[1674386850] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"160.487888ms","start":"2026-04-18T09:06:31.786651Z","end":"2026-04-18T09:06:31.947139Z","steps":["trace[1674386850] 'process raft request'  (duration: 160.229751ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:33.517898Z","caller":"traceutil/trace.go:171","msg":"trace[1408546417] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"126.228154ms","start":"2026-04-18T09:06:33.391649Z","end":"2026-04-18T09:06:33.517877Z","steps":["trace[1408546417] 'process raft request'  (duration: 126.0735ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:34.205535Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561149,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:06:35.289298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"946.521745ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561151 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:359 > 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-04-18T09:06:35.289489Z","caller":"traceutil/trace.go:171","msg":"trace[2033866037] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:405; }","duration":"1.5841908s","start":"2026-04-18T09:06:33.705279Z","end":"2026-04-18T09:06:35.28947Z","steps":["trace[2033866037] 'read index received'  (duration: 637.371518ms)","trace[2033866037] 'applied index is now lower than readState.Index'  (duration: 946.818122ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:35.289594Z","caller":"traceutil/trace.go:171","msg":"trace[1203021612] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"1.599515549s","start":"2026-04-18T09:06:33.690054Z","end":"2026-04-18T09:06:35.289569Z","steps":["trace[1203021612] 'process raft request'  (duration: 1.599353065s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:35.289693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.264065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"}
{"level":"warn","ts":"2026-04-18T09:06:35.289736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:33.690025Z","time spent":"1.599636001s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:357 > 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-04-18T09:06:35.289744Z","caller":"traceutil/trace.go:171","msg":"trace[989706542] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:397; }","duration":"980.346057ms","start":"2026-04-18T09:06:34.309384Z","end":"2026-04-18T09:06:35.289731Z","steps":["trace[989706542] 'agreement among raft nodes before linearized reading'  (duration: 980.275355ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:35.289785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:34.30936Z","time spent":"980.417359ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4346,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "}
{"level":"info","ts":"2026-04-18T09:06:35.289872Z","caller":"traceutil/trace.go:171","msg":"trace[1015056594] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"1.59995244s","start":"2026-04-18T09:06:33.689905Z","end":"2026-04-18T09:06:35.289858Z","steps":["trace[1015056594] 'process raft request'  (duration: 652.769598ms)","trace[1015056594] 'compare'  (duration: 946.33266ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:35.289919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:33.689888Z","time spent":"1.600008471s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:359 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-04-18T09:06:35.289628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.584341904s","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-04-18T09:06:35.290017Z","caller":"traceutil/trace.go:171","msg":"trace[1697067026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:397; }","duration":"1.584735674s","start":"2026-04-18T09:06:33.705272Z","end":"2026-04-18T09:06:35.290008Z","steps":["trace[1697067026] 'agreement among raft nodes before linearized reading'  (duration: 1.584304743s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:35.290049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:33.705238Z","time spent":"1.584802796s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-04-18T09:06:36.128842Z","caller":"traceutil/trace.go:171","msg":"trace[150795162] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"834.471898ms","start":"2026-04-18T09:06:35.294345Z","end":"2026-04-18T09:06:36.128817Z","steps":["trace[150795162] 'process raft request'  (duration: 834.254543ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:36.128987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:35.294326Z","time spent":"834.587702ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:369 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-18T09:06:36.271889Z","caller":"traceutil/trace.go:171","msg":"trace[467051643] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:407; }","duration":"563.665409ms","start":"2026-04-18T09:06:35.7082Z","end":"2026-04-18T09:06:36.271865Z","steps":["trace[467051643] 'read index received'  (duration: 420.498198ms)","trace[467051643] 'applied index is now lower than readState.Index'  (duration: 143.166281ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:36.271962Z","caller":"traceutil/trace.go:171","msg":"trace[662584542] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"974.124987ms","start":"2026-04-18T09:06:35.297804Z","end":"2026-04-18T09:06:36.271929Z","steps":["trace[662584542] 'process raft request'  (duration: 973.920052ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:36.272079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.850384ms","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-04-18T09:06:36.272123Z","caller":"traceutil/trace.go:171","msg":"trace[854192936] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:399; }","duration":"564.004438ms","start":"2026-04-18T09:06:35.708107Z","end":"2026-04-18T09:06:36.272112Z","steps":["trace[854192936] 'agreement among raft nodes before linearized reading'  (duration: 563.885615ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:36.272159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:35.708073Z","time spent":"564.07676ms","remote":"127.0.0.1:45530","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-04-18T09:06:36.272227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:35.297786Z","time spent":"974.307793ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:334 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:4249 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" > >"}
{"level":"warn","ts":"2026-04-18T09:06:39.672976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.568363ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561194 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:417 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:7029 >> failure:<request_range:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:06:39.673124Z","caller":"traceutil/trace.go:171","msg":"trace[1274648002] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"229.429784ms","start":"2026-04-18T09:06:39.443668Z","end":"2026-04-18T09:06:39.673098Z","steps":["trace[1274648002] 'process raft request'  (duration: 118.629035ms)","trace[1274648002] 'compare'  (duration: 110.41573ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:44.536781Z","caller":"traceutil/trace.go:171","msg":"trace[1234703574] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"177.701772ms","start":"2026-04-18T09:06:44.359059Z","end":"2026-04-18T09:06:44.53676Z","steps":["trace[1234703574] 'process raft request'  (duration: 177.58902ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:45.719508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.327117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-18T09:06:45.719592Z","caller":"traceutil/trace.go:171","msg":"trace[236086338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:431; }","duration":"178.461501ms","start":"2026-04-18T09:06:45.541108Z","end":"2026-04-18T09:06:45.71957Z","steps":["trace[236086338] 'range keys from in-memory index tree'  (duration: 178.201664ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:46.180786Z","caller":"traceutil/trace.go:171","msg":"trace[74367584] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"123.990574ms","start":"2026-04-18T09:06:46.056771Z","end":"2026-04-18T09:06:46.180762Z","steps":["trace[74367584] 'process raft request'  (duration: 123.794109ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:46.69093Z","caller":"traceutil/trace.go:171","msg":"trace[2104050889] linearizableReadLoop","detail":"{readStateIndex:447; appliedIndex:446; }","duration":"400.838929ms","start":"2026-04-18T09:06:46.290021Z","end":"2026-04-18T09:06:46.69086Z","steps":["trace[2104050889] 'read index received'  (duration: 400.721846ms)","trace[2104050889] 'applied index is now lower than readState.Index'  (duration: 115.103µs)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:46.690936Z","caller":"traceutil/trace.go:171","msg":"trace[1412093877] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"502.561522ms","start":"2026-04-18T09:06:46.188338Z","end":"2026-04-18T09:06:46.6909Z","steps":["trace[1412093877] 'process raft request'  (duration: 502.418208ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:46.691074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.188306Z","time spent":"502.702924ms","remote":"127.0.0.1:45724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3678,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-67659f764b\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-67659f764b\" value_size:3618 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:46.69109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.365429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:06:46.691117Z","caller":"traceutil/trace.go:171","msg":"trace[789265436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:434; }","duration":"339.43416ms","start":"2026-04-18T09:06:46.351672Z","end":"2026-04-18T09:06:46.691106Z","steps":["trace[789265436] 'agreement among raft nodes before linearized reading'  (duration: 339.347908ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:46.691142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.351598Z","time spent":"339.538083ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-18T09:06:46.691116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.070094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:06:46.691198Z","caller":"traceutil/trace.go:171","msg":"trace[1386027400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:434; }","duration":"401.196597ms","start":"2026-04-18T09:06:46.28998Z","end":"2026-04-18T09:06:46.691177Z","steps":["trace[1386027400] 'agreement among raft nodes before linearized reading'  (duration: 400.993212ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:46.691253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.289963Z","time spent":"401.282ms","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-18T09:06:47.260603Z","caller":"traceutil/trace.go:171","msg":"trace[490503672] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"566.325027ms","start":"2026-04-18T09:06:46.694255Z","end":"2026-04-18T09:06:47.26058Z","steps":["trace[490503672] 'process raft request'  (duration: 566.179834ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:47.260754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.694234Z","time spent":"566.44589ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:409 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-04-18T09:06:47.274281Z","caller":"traceutil/trace.go:171","msg":"trace[2077521793] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"579.106594ms","start":"2026-04-18T09:06:46.695155Z","end":"2026-04-18T09:06:47.274262Z","steps":["trace[2077521793] 'process raft request'  (duration: 578.791247ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:47.274461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.695134Z","time spent":"579.264078ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:428 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-18T09:06:47.274465Z","caller":"traceutil/trace.go:171","msg":"trace[1672771249] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"578.760605ms","start":"2026-04-18T09:06:46.695681Z","end":"2026-04-18T09:06:47.274442Z","steps":["trace[1672771249] 'process raft request'  (duration: 578.403957ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:47.274594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.695674Z","time spent":"578.876017ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-67659f764b-vpjvt\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-67659f764b-vpjvt\" value_size:3504 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:06:47.274759Z","caller":"traceutil/trace.go:171","msg":"trace[1290196935] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"578.890488ms","start":"2026-04-18T09:06:46.695857Z","end":"2026-04-18T09:06:47.274748Z","steps":["trace[1290196935] 'process raft request'  (duration: 578.599441ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.274809Z","caller":"traceutil/trace.go:171","msg":"trace[1620534432] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"579.066752ms","start":"2026-04-18T09:06:46.69573Z","end":"2026-04-18T09:06:47.274797Z","steps":["trace[1620534432] 'process raft request'  (duration: 578.624922ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:47.274827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.695838Z","time spent":"578.95671ms","remote":"127.0.0.1:45344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns.18a76841114565ba\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns.18a76841114565ba\" value_size:609 lease:5794898655378560736 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:06:47.27487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.695722Z","time spent":"579.118113ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:430 > 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-04-18T09:06:47.274948Z","caller":"traceutil/trace.go:171","msg":"trace[195040830] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"576.318647ms","start":"2026-04-18T09:06:46.698618Z","end":"2026-04-18T09:06:47.274937Z","steps":["trace[195040830] 'process raft request'  (duration: 575.867097ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:47.275025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:06:46.698601Z","time spent":"576.39768ms","remote":"127.0.0.1:45700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/deployments/kube-system/coredns\" mod_revision:433 > success:<request_put:<key:\"/registry/deployments/kube-system/coredns\" value_size:4131 >> failure:<request_range:<key:\"/registry/deployments/kube-system/coredns\" > >"}
{"level":"warn","ts":"2026-04-18T09:06:47.602636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.024983ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561263 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/coredns.18a768413d753ddd\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns.18a768413d753ddd\" value_size:616 lease:5794898655378560736 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:06:47.602902Z","caller":"traceutil/trace.go:171","msg":"trace[1954157718] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"161.797923ms","start":"2026-04-18T09:06:47.44109Z","end":"2026-04-18T09:06:47.602888Z","steps":["trace[1954157718] 'process raft request'  (duration: 161.66872ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.60292Z","caller":"traceutil/trace.go:171","msg":"trace[1450663849] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"162.10653ms","start":"2026-04-18T09:06:47.440788Z","end":"2026-04-18T09:06:47.602895Z","steps":["trace[1450663849] 'process raft request'  (duration: 161.932956ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.602953Z","caller":"traceutil/trace.go:171","msg":"trace[1893848192] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"161.800934ms","start":"2026-04-18T09:06:47.441112Z","end":"2026-04-18T09:06:47.602913Z","steps":["trace[1893848192] 'process raft request'  (duration: 161.681221ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.603024Z","caller":"traceutil/trace.go:171","msg":"trace[1865177681] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"160.819272ms","start":"2026-04-18T09:06:47.442199Z","end":"2026-04-18T09:06:47.603018Z","steps":["trace[1865177681] 'process raft request'  (duration: 160.616936ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.603145Z","caller":"traceutil/trace.go:171","msg":"trace[2094488573] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"158.818005ms","start":"2026-04-18T09:06:47.444309Z","end":"2026-04-18T09:06:47.603127Z","steps":["trace[2094488573] 'process raft request'  (duration: 158.535368ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:47.603332Z","caller":"traceutil/trace.go:171","msg":"trace[930360603] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"164.979227ms","start":"2026-04-18T09:06:47.437893Z","end":"2026-04-18T09:06:47.602872Z","steps":["trace[930360603] 'process raft request'  (duration: 57.660027ms)","trace[930360603] 'compare'  (duration: 106.861219ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:49.398732Z","caller":"traceutil/trace.go:171","msg":"trace[423651738] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"113.540556ms","start":"2026-04-18T09:06:49.285171Z","end":"2026-04-18T09:06:49.398712Z","steps":["trace[423651738] 'process raft request'  (duration: 113.431713ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:55.585842Z","caller":"traceutil/trace.go:171","msg":"trace[301369348] linearizableReadLoop","detail":"{readStateIndex:497; appliedIndex:496; }","duration":"160.583719ms","start":"2026-04-18T09:06:55.425236Z","end":"2026-04-18T09:06:55.58582Z","steps":["trace[301369348] 'read index received'  (duration: 160.427646ms)","trace[301369348] 'applied index is now lower than readState.Index'  (duration: 154.883µs)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:06:55.585879Z","caller":"traceutil/trace.go:171","msg":"trace[781353751] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"189.604835ms","start":"2026-04-18T09:06:55.396241Z","end":"2026-04-18T09:06:55.585846Z","steps":["trace[781353751] 'process raft request'  (duration: 189.466292ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:55.585988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.737522ms","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-04-18T09:06:55.586022Z","caller":"traceutil/trace.go:171","msg":"trace[1035150116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:482; }","duration":"160.827394ms","start":"2026-04-18T09:06:55.425184Z","end":"2026-04-18T09:06:55.586012Z","steps":["trace[1035150116] 'agreement among raft nodes before linearized reading'  (duration: 160.744832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.864412Z","caller":"traceutil/trace.go:171","msg":"trace[1419864275] transaction","detail":"{read_only:false; number_of_response:0; response_revision:545; }","duration":"278.032169ms","start":"2026-04-18T09:06:59.586357Z","end":"2026-04-18T09:06:59.86439Z","steps":["trace[1419864275] 'process raft request'  (duration: 271.218618ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.864442Z","caller":"traceutil/trace.go:171","msg":"trace[82333848] transaction","detail":"{read_only:false; number_of_response:0; response_revision:545; }","duration":"277.916397ms","start":"2026-04-18T09:06:59.586499Z","end":"2026-04-18T09:06:59.864415Z","steps":["trace[82333848] 'process raft request'  (duration: 277.804885ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.864721Z","caller":"traceutil/trace.go:171","msg":"trace[929241699] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"275.881026ms","start":"2026-04-18T09:06:59.58883Z","end":"2026-04-18T09:06:59.864711Z","steps":["trace[929241699] 'process raft request'  (duration: 275.579719ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.864798Z","caller":"traceutil/trace.go:171","msg":"trace[1289662421] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"266.717175ms","start":"2026-04-18T09:06:59.598057Z","end":"2026-04-18T09:06:59.864774Z","steps":["trace[1289662421] 'process raft request'  (duration: 266.629094ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.864848Z","caller":"traceutil/trace.go:171","msg":"trace[1958861064] transaction","detail":"{read_only:false; number_of_response:1; response_revision:545; }","duration":"277.08659ms","start":"2026-04-18T09:06:59.587627Z","end":"2026-04-18T09:06:59.864714Z","steps":["trace[1958861064] 'process raft request'  (duration: 276.727302ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.865012Z","caller":"traceutil/trace.go:171","msg":"trace[991712997] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"271.473344ms","start":"2026-04-18T09:06:59.593472Z","end":"2026-04-18T09:06:59.864946Z","steps":["trace[991712997] 'process raft request'  (duration: 271.024424ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.877833Z","caller":"traceutil/trace.go:171","msg":"trace[1274797945] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"271.942553ms","start":"2026-04-18T09:06:59.605864Z","end":"2026-04-18T09:06:59.877807Z","steps":["trace[1274797945] 'process raft request'  (duration: 271.477093ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.878458Z","caller":"traceutil/trace.go:171","msg":"trace[388546814] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"268.282727ms","start":"2026-04-18T09:06:59.610156Z","end":"2026-04-18T09:06:59.878438Z","steps":["trace[388546814] 'process raft request'  (duration: 267.48498ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.878583Z","caller":"traceutil/trace.go:171","msg":"trace[160983146] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"265.103291ms","start":"2026-04-18T09:06:59.613466Z","end":"2026-04-18T09:06:59.87857Z","steps":["trace[160983146] 'process raft request'  (duration: 264.857405ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.878744Z","caller":"traceutil/trace.go:171","msg":"trace[1918589070] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"261.61279ms","start":"2026-04-18T09:06:59.617123Z","end":"2026-04-18T09:06:59.878736Z","steps":["trace[1918589070] 'process raft request'  (duration: 261.320613ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.878797Z","caller":"traceutil/trace.go:171","msg":"trace[421954417] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"212.207682ms","start":"2026-04-18T09:06:59.666583Z","end":"2026-04-18T09:06:59.87879Z","steps":["trace[421954417] 'process raft request'  (duration: 212.08832ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:06:59.878788Z","caller":"traceutil/trace.go:171","msg":"trace[300490154] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:562; }","duration":"263.612442ms","start":"2026-04-18T09:06:59.615163Z","end":"2026-04-18T09:06:59.878775Z","steps":["trace[300490154] 'read index received'  (duration: 242.456941ms)","trace[300490154] 'applied index is now lower than readState.Index'  (duration: 21.154821ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:06:59.878876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.702543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:06:59.878898Z","caller":"traceutil/trace.go:171","msg":"trace[1593235311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:553; }","duration":"263.755784ms","start":"2026-04-18T09:06:59.615136Z","end":"2026-04-18T09:06:59.878892Z","steps":["trace[1593235311] 'agreement among raft nodes before linearized reading'  (duration: 263.696603ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:59.894522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.754045ms","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-04-18T09:06:59.894584Z","caller":"traceutil/trace.go:171","msg":"trace[1266336181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:554; }","duration":"278.834396ms","start":"2026-04-18T09:06:59.615736Z","end":"2026-04-18T09:06:59.89457Z","steps":["trace[1266336181] 'agreement among raft nodes before linearized reading'  (duration: 278.560801ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:06:59.894675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.015688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:06:59.894704Z","caller":"traceutil/trace.go:171","msg":"trace[1054896119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:554; }","duration":"187.079789ms","start":"2026-04-18T09:06:59.707617Z","end":"2026-04-18T09:06:59.894697Z","steps":["trace[1054896119] 'agreement among raft nodes before linearized reading'  (duration: 187.025438ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:00.665393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.880683ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5794898655378561479 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" mod_revision:574 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" value_size:98578 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-04-18T09:07:00.665583Z","caller":"traceutil/trace.go:171","msg":"trace[29845877] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"352.887803ms","start":"2026-04-18T09:07:00.312675Z","end":"2026-04-18T09:07:00.665563Z","steps":["trace[29845877] 'process raft request'  (duration: 79.749185ms)","trace[29845877] 'compare'  (duration: 272.715559ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:00.665652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:00.312607Z","time spent":"353.011455ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" mod_revision:574 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" value_size:98578 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtrafficpolicies.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-18T09:07:00.72331Z","caller":"traceutil/trace.go:171","msg":"trace[472430169] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"362.794246ms","start":"2026-04-18T09:07:00.360496Z","end":"2026-04-18T09:07:00.72329Z","steps":["trace[472430169] 'process raft request'  (duration: 362.435259ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:00.723406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:00.360472Z","time spent":"362.886567ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoypatchpolicies.gateway.envoyproxy.io\" value_size:19727 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:07:00.723894Z","caller":"traceutil/trace.go:171","msg":"trace[1554353676] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"344.780325ms","start":"2026-04-18T09:07:00.379088Z","end":"2026-04-18T09:07:00.723868Z","steps":["trace[1554353676] 'process raft request'  (duration: 344.056771ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:00.724072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:00.379067Z","time spent":"344.910798ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" mod_revision:581 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" value_size:151118 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" > >"}
{"level":"info","ts":"2026-04-18T09:07:00.880637Z","caller":"traceutil/trace.go:171","msg":"trace[555275920] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"192.386664ms","start":"2026-04-18T09:07:00.688199Z","end":"2026-04-18T09:07:00.880586Z","steps":["trace[555275920] 'process raft request'  (duration: 131.463648ms)","trace[555275920] 'compare'  (duration: 60.693151ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:00.887809Z","caller":"traceutil/trace.go:171","msg":"trace[594150489] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"139.068416ms","start":"2026-04-18T09:07:00.748721Z","end":"2026-04-18T09:07:00.88779Z","steps":["trace[594150489] 'process raft request'  (duration: 138.945234ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:01.045483Z","caller":"traceutil/trace.go:171","msg":"trace[906542475] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"115.253368ms","start":"2026-04-18T09:07:00.930213Z","end":"2026-04-18T09:07:01.045466Z","steps":["trace[906542475] 'process raft request'  (duration: 114.966932ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:01.392861Z","caller":"traceutil/trace.go:171","msg":"trace[1299513275] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"101.759379ms","start":"2026-04-18T09:07:01.291084Z","end":"2026-04-18T09:07:01.392844Z","steps":["trace[1299513275] 'read index received'  (duration: 31.228238ms)","trace[1299513275] 'applied index is now lower than readState.Index'  (duration: 70.530271ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:01.392906Z","caller":"traceutil/trace.go:171","msg":"trace[2083070187] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"207.878676ms","start":"2026-04-18T09:07:01.185001Z","end":"2026-04-18T09:07:01.39288Z","steps":["trace[2083070187] 'process raft request'  (duration: 137.216993ms)","trace[2083070187] 'compare'  (duration: 70.51197ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:01.393005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.867721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:01.393062Z","caller":"traceutil/trace.go:171","msg":"trace[2145941140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"101.988723ms","start":"2026-04-18T09:07:01.291041Z","end":"2026-04-18T09:07:01.39303Z","steps":["trace[2145941140] 'agreement among raft nodes before linearized reading'  (duration: 101.885271ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:01.395991Z","caller":"traceutil/trace.go:171","msg":"trace[1621104217] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"108.6538ms","start":"2026-04-18T09:07:01.287314Z","end":"2026-04-18T09:07:01.395967Z","steps":["trace[1621104217] 'process raft request'  (duration: 108.296693ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:02.744663Z","caller":"traceutil/trace.go:171","msg":"trace[1527235501] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"159.513811ms","start":"2026-04-18T09:07:02.585135Z","end":"2026-04-18T09:07:02.744649Z","steps":["trace[1527235501] 'process raft request'  (duration: 159.415849ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:03.790705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561563,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:04.294768Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561563,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:04.297479Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.505198661s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-18T09:07:04.297954Z","caller":"traceutil/trace.go:171","msg":"trace[1437223615] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"1.505755202s","start":"2026-04-18T09:07:02.792177Z","end":"2026-04-18T09:07:04.297932Z","steps":["trace[1437223615] 'process raft request'  (duration: 1.50563182s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.298088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:02.792155Z","time spent":"1.505860705s","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" mod_revision:634 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" value_size:5473 >> failure:<request_range:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" > >"}
{"level":"info","ts":"2026-04-18T09:07:04.347255Z","caller":"traceutil/trace.go:171","msg":"trace[1723033094] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"1.465143283s","start":"2026-04-18T09:07:02.882082Z","end":"2026-04-18T09:07:04.347225Z","steps":["trace[1723033094] 'process raft request'  (duration: 1.46496756s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:04.347286Z","caller":"traceutil/trace.go:171","msg":"trace[268783415] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.267461034s","start":"2026-04-18T09:07:03.079792Z","end":"2026-04-18T09:07:04.347254Z","steps":["trace[268783415] 'process raft request'  (duration: 1.267371142s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:04.347756Z","caller":"traceutil/trace.go:171","msg":"trace[251377824] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.062661901s","start":"2026-04-18T09:07:03.284651Z","end":"2026-04-18T09:07:04.347313Z","steps":["trace[251377824] 'process raft request'  (duration: 1.062554819s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.347796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:02.882055Z","time spent":"1.465677074s","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" value_size:9240 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:07:04.347842Z","caller":"traceutil/trace.go:171","msg":"trace[855830162] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"863.686545ms","start":"2026-04-18T09:07:03.483596Z","end":"2026-04-18T09:07:04.347283Z","steps":["trace[855830162] 'process raft request'  (duration: 863.637875ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.347943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.284611Z","time spent":"1.063225132s","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" value_size:23189 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:07:04.348267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.483571Z","time spent":"864.620784ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" value_size:12154 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:07:04.348527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.079743Z","time spent":"1.268026985s","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" value_size:3262 >> failure:<>"}
{"level":"info","ts":"2026-04-18T09:07:04.35271Z","caller":"traceutil/trace.go:171","msg":"trace[1736908207] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"446.214342ms","start":"2026-04-18T09:07:03.906477Z","end":"2026-04-18T09:07:04.352692Z","steps":["trace[1736908207] 'process raft request'  (duration: 445.452076ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:04.352987Z","caller":"traceutil/trace.go:171","msg":"trace[1682620514] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:655; }","duration":"1.063176401s","start":"2026-04-18T09:07:03.289642Z","end":"2026-04-18T09:07:04.352818Z","steps":["trace[1682620514] 'read index received'  (duration: 1.008214376s)","trace[1682620514] 'applied index is now lower than readState.Index'  (duration: 54.959925ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:04.353157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.063502657s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:04.353222Z","caller":"traceutil/trace.go:171","msg":"trace[816064316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"1.063598929s","start":"2026-04-18T09:07:03.289607Z","end":"2026-04-18T09:07:04.353206Z","steps":["trace[816064316] 'agreement among raft nodes before linearized reading'  (duration: 1.063417546s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.353258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.289591Z","time spent":"1.0636594s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-18T09:07:04.352594Z","caller":"traceutil/trace.go:171","msg":"trace[1910636549] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"643.740738ms","start":"2026-04-18T09:07:03.708802Z","end":"2026-04-18T09:07:04.352542Z","steps":["trace[1910636549] 'process raft request'  (duration: 639.242218ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.354084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.906445Z","time spent":"447.549318ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" value_size:187148 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:07:04.354334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.708772Z","time spent":"645.408ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" mod_revision:0 > success:<request_put:<key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" value_size:187346 >> failure:<>"}
{"level":"warn","ts":"2026-04-18T09:07:04.355666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.207987ms","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-04-18T09:07:04.355735Z","caller":"traceutil/trace.go:171","msg":"trace[1208534108] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"397.308409ms","start":"2026-04-18T09:07:03.958399Z","end":"2026-04-18T09:07:04.355707Z","steps":["trace[1208534108] 'agreement among raft nodes before linearized reading'  (duration: 397.152416ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.355771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.958378Z","time spent":"397.38267ms","remote":"127.0.0.1:45530","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-04-18T09:07:04.355683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.965672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-18T09:07:04.356166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"802.22855ms","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-04-18T09:07:04.356223Z","caller":"traceutil/trace.go:171","msg":"trace[109754332] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:641; }","duration":"802.323512ms","start":"2026-04-18T09:07:03.553881Z","end":"2026-04-18T09:07:04.356204Z","steps":["trace[109754332] 'agreement among raft nodes before linearized reading'  (duration: 802.182719ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.356249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.553858Z","time spent":"802.385384ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:04.356332Z","caller":"traceutil/trace.go:171","msg":"trace[1230233183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:641; }","duration":"397.435141ms","start":"2026-04-18T09:07:03.958663Z","end":"2026-04-18T09:07:04.356099Z","steps":["trace[1230233183] 'agreement among raft nodes before linearized reading'  (duration: 396.87863ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.356546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.95864Z","time spent":"397.88353ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:04.356062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.569277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-04-18T09:07:04.360925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.143485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:07:04.360967Z","caller":"traceutil/trace.go:171","msg":"trace[2096112304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"402.211607ms","start":"2026-04-18T09:07:03.958745Z","end":"2026-04-18T09:07:04.360956Z","steps":["trace[2096112304] 'agreement among raft nodes before linearized reading'  (duration: 398.281218ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.360991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.95873Z","time spent":"402.255747ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:04.360986Z","caller":"traceutil/trace.go:171","msg":"trace[1891125728] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"437.568297ms","start":"2026-04-18T09:07:03.919438Z","end":"2026-04-18T09:07:04.357006Z","steps":["trace[1891125728] 'agreement among raft nodes before linearized reading'  (duration: 436.482875ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:04.361028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:03.919413Z","time spent":"441.603717ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-18T09:07:04.361201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.332922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"}
{"level":"info","ts":"2026-04-18T09:07:04.361259Z","caller":"traceutil/trace.go:171","msg":"trace[1127621185] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:641; }","duration":"281.489265ms","start":"2026-04-18T09:07:04.079754Z","end":"2026-04-18T09:07:04.361244Z","steps":["trace[1127621185] 'agreement among raft nodes before linearized reading'  (duration: 277.145488ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:04.770517Z","caller":"traceutil/trace.go:171","msg":"trace[1681458658] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"114.261585ms","start":"2026-04-18T09:07:04.65621Z","end":"2026-04-18T09:07:04.770471Z","steps":["trace[1681458658] 'process raft request'  (duration: 113.9802ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:05.994895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.225834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"}
{"level":"warn","ts":"2026-04-18T09:07:05.994955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.94664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"}
{"level":"info","ts":"2026-04-18T09:07:05.995047Z","caller":"traceutil/trace.go:171","msg":"trace[408437562] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:664; }","duration":"315.436558ms","start":"2026-04-18T09:07:05.679586Z","end":"2026-04-18T09:07:05.995023Z","steps":["trace[408437562] 'range keys from in-memory index tree'  (duration: 314.996049ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:05.995088Z","caller":"traceutil/trace.go:171","msg":"trace[1823381721] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:664; }","duration":"116.132753ms","start":"2026-04-18T09:07:05.878911Z","end":"2026-04-18T09:07:05.995043Z","steps":["trace[1823381721] 'range keys from in-memory index tree'  (duration: 115.568753ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:05.995106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:05.679566Z","time spent":"315.5181ms","remote":"127.0.0.1:45320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24268,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "}
{"level":"info","ts":"2026-04-18T09:07:06.291707Z","caller":"traceutil/trace.go:171","msg":"trace[2068275000] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"148.719332ms","start":"2026-04-18T09:07:06.142951Z","end":"2026-04-18T09:07:06.29167Z","steps":["trace[2068275000] 'process raft request'  (duration: 83.035606ms)","trace[2068275000] 'compare'  (duration: 65.471112ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:06.594817Z","caller":"traceutil/trace.go:171","msg":"trace[273093153] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"105.995635ms","start":"2026-04-18T09:07:06.488785Z","end":"2026-04-18T09:07:06.594781Z","steps":["trace[273093153] 'process raft request'  (duration: 58.973014ms)","trace[273093153] 'compare'  (duration: 46.782346ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:07.423595Z","caller":"traceutil/trace.go:171","msg":"trace[956479029] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"126.985895ms","start":"2026-04-18T09:07:07.296587Z","end":"2026-04-18T09:07:07.423573Z","steps":["trace[956479029] 'process raft request'  (duration: 125.369013ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:10.856261Z","caller":"traceutil/trace.go:171","msg":"trace[2028935861] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"131.249597ms","start":"2026-04-18T09:07:10.72499Z","end":"2026-04-18T09:07:10.856239Z","steps":["trace[2028935861] 'process raft request'  (duration: 131.211126ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:10.85633Z","caller":"traceutil/trace.go:171","msg":"trace[131775927] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"207.42353ms","start":"2026-04-18T09:07:10.648874Z","end":"2026-04-18T09:07:10.856298Z","steps":["trace[131775927] 'process raft request'  (duration: 202.477466ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:10.85648Z","caller":"traceutil/trace.go:171","msg":"trace[1855237024] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"206.612284ms","start":"2026-04-18T09:07:10.64984Z","end":"2026-04-18T09:07:10.856452Z","steps":["trace[1855237024] 'process raft request'  (duration: 206.302158ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:10.856513Z","caller":"traceutil/trace.go:171","msg":"trace[789658317] linearizableReadLoop","detail":"{readStateIndex:719; appliedIndex:717; }","duration":"135.595809ms","start":"2026-04-18T09:07:10.720905Z","end":"2026-04-18T09:07:10.856501Z","steps":["trace[789658317] 'read index received'  (duration: 130.460631ms)","trace[789658317] 'applied index is now lower than readState.Index'  (duration: 5.133948ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:10.856676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.511278ms","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-04-18T09:07:10.856711Z","caller":"traceutil/trace.go:171","msg":"trace[1033919688] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:698; }","duration":"209.59841ms","start":"2026-04-18T09:07:10.647103Z","end":"2026-04-18T09:07:10.856701Z","steps":["trace[1033919688] 'agreement among raft nodes before linearized reading'  (duration: 209.434407ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:12.749082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.275090409s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-04-18T09:07:12.749136Z","caller":"traceutil/trace.go:171","msg":"trace[1899867567] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:702; }","duration":"1.275191991s","start":"2026-04-18T09:07:11.473932Z","end":"2026-04-18T09:07:12.749124Z","steps":["trace[1899867567] 'range keys from in-memory index tree'  (duration: 1.274985037s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:12.749161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:11.473911Z","time spent":"1.275244373s","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.53\" "}
{"level":"warn","ts":"2026-04-18T09:07:12.74932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459663558s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:12.749395Z","caller":"traceutil/trace.go:171","msg":"trace[1609461518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"1.4597828s","start":"2026-04-18T09:07:11.289595Z","end":"2026-04-18T09:07:12.749378Z","steps":["trace[1609461518] 'range keys from in-memory index tree'  (duration: 1.459583167s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:12.749433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:11.289575Z","time spent":"1.459850452s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-18T09:07:12.749321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.171086426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hgwg8\" ","response":"range_response_count:1 size:16961"}
{"level":"info","ts":"2026-04-18T09:07:12.749567Z","caller":"traceutil/trace.go:171","msg":"trace[21751762] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hgwg8; range_end:; response_count:1; response_revision:702; }","duration":"1.17138074s","start":"2026-04-18T09:07:11.578173Z","end":"2026-04-18T09:07:12.749553Z","steps":["trace[21751762] 'range keys from in-memory index tree'  (duration: 1.170922092s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:12.749604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:11.578152Z","time spent":"1.171442072s","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-hgwg8\" "}
{"level":"warn","ts":"2026-04-18T09:07:13.25705Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561708,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:13.75785Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561708,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:13.939689Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.188872246s","expected-duration":"1s"}
{"level":"warn","ts":"2026-04-18T09:07:13.940154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.750635Z","time spent":"1.189514957s","remote":"127.0.0.1:45300","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-04-18T09:07:14.757401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000583307s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-04-18T09:07:14.757487Z","caller":"traceutil/trace.go:171","msg":"trace[1815775467] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000724759s","start":"2026-04-18T09:07:12.756743Z","end":"2026-04-18T09:07:14.757467Z","steps":["trace[1815775467] 'agreement among raft nodes before linearized reading'  (duration: 2.000615357s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:14.757535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.756725Z","time spent":"2.00079983s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-18T09:07:14.770398Z","caller":"traceutil/trace.go:171","msg":"trace[863334829] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"2.016928218s","start":"2026-04-18T09:07:12.753449Z","end":"2026-04-18T09:07:14.770377Z","steps":["trace[863334829] 'process raft request'  (duration: 2.016695874s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:14.770564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.75343Z","time spent":"2.01704362s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:695 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-18T09:07:14.770606Z","caller":"traceutil/trace.go:171","msg":"trace[125896376] linearizableReadLoop","detail":"{readStateIndex:727; appliedIndex:724; }","duration":"2.013796988s","start":"2026-04-18T09:07:12.756786Z","end":"2026-04-18T09:07:14.770583Z","steps":["trace[125896376] 'read index received'  (duration: 1.183072357s)","trace[125896376] 'applied index is now lower than readState.Index'  (duration: 830.723131ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:14.770683Z","caller":"traceutil/trace.go:171","msg":"trace[1529440018] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"2.006610626s","start":"2026-04-18T09:07:12.764063Z","end":"2026-04-18T09:07:14.770673Z","steps":["trace[1529440018] 'process raft request'  (duration: 2.006258559s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:14.770732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.764049Z","time spent":"2.006658847s","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/cilium-hgwg8\" mod_revision:522 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-hgwg8\" value_size:17081 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-hgwg8\" > >"}
{"level":"warn","ts":"2026-04-18T09:07:15.270879Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561713,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-18T09:07:15.613623Z","caller":"traceutil/trace.go:171","msg":"trace[402988610] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:727; }","duration":"842.943709ms","start":"2026-04-18T09:07:14.770656Z","end":"2026-04-18T09:07:15.6136Z","steps":["trace[402988610] 'read index received'  (duration: 842.499011ms)","trace[402988610] 'applied index is now lower than readState.Index'  (duration: 442.918µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:15.613831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.753848251s","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-04-18T09:07:15.613869Z","caller":"traceutil/trace.go:171","msg":"trace[1986334607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:705; }","duration":"2.753929344s","start":"2026-04-18T09:07:12.859931Z","end":"2026-04-18T09:07:15.61386Z","steps":["trace[1986334607] 'agreement among raft nodes before linearized reading'  (duration: 2.75375457s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.613865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.745559407s","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-04-18T09:07:15.61395Z","caller":"traceutil/trace.go:171","msg":"trace[1633613554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:705; }","duration":"2.74568831s","start":"2026-04-18T09:07:12.868244Z","end":"2026-04-18T09:07:15.613932Z","steps":["trace[1633613554] 'agreement among raft nodes before linearized reading'  (duration: 2.745476615s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.613978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.752805002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-04-18T09:07:15.613996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.868229Z","time spent":"2.745759141s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:15.614028Z","caller":"traceutil/trace.go:171","msg":"trace[2132992069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:705; }","duration":"2.752849812s","start":"2026-04-18T09:07:12.861147Z","end":"2026-04-18T09:07:15.613997Z","steps":["trace[2132992069] 'agreement among raft nodes before linearized reading'  (duration: 2.752775411s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.614057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.861141Z","time spent":"2.752910053s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:15.613901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.859915Z","time spent":"2.753979014s","remote":"127.0.0.1:45530","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-04-18T09:07:15.614224Z","caller":"traceutil/trace.go:171","msg":"trace[374222627] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"1.673002871s","start":"2026-04-18T09:07:13.94119Z","end":"2026-04-18T09:07:15.614193Z","steps":["trace[374222627] 'process raft request'  (duration: 1.672033762s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.61424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.059611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:15.614269Z","caller":"traceutil/trace.go:171","msg":"trace[210238129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:705; }","duration":"856.238875ms","start":"2026-04-18T09:07:14.758022Z","end":"2026-04-18T09:07:15.614261Z","steps":["trace[210238129] 'agreement among raft nodes before linearized reading'  (duration: 856.197914ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.614292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:14.757998Z","time spent":"856.289345ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-18T09:07:15.614336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:13.941166Z","time spent":"1.673098062s","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/masterleases/199.204.45.53\" mod_revision:606 > success:<request_put:<key:\"/registry/masterleases/199.204.45.53\" value_size:66 lease:5794898655378561707 >> failure:<request_range:<key:\"/registry/masterleases/199.204.45.53\" > >"}
{"level":"warn","ts":"2026-04-18T09:07:15.614193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.753070917s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:07:15.614608Z","caller":"traceutil/trace.go:171","msg":"trace[1267136591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:705; }","duration":"2.753506344s","start":"2026-04-18T09:07:12.861092Z","end":"2026-04-18T09:07:15.614598Z","steps":["trace[1267136591] 'agreement among raft nodes before linearized reading'  (duration: 2.753052466s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.614644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:12.861079Z","time spent":"2.753555226s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:15.795302Z","caller":"traceutil/trace.go:171","msg":"trace[198519477] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"176.854479ms","start":"2026-04-18T09:07:15.618403Z","end":"2026-04-18T09:07:15.795258Z","steps":["trace[198519477] 'process raft request'  (duration: 115.440461ms)","trace[198519477] 'compare'  (duration: 61.233845ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:15.795398Z","caller":"traceutil/trace.go:171","msg":"trace[1026291601] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"176.650036ms","start":"2026-04-18T09:07:15.618727Z","end":"2026-04-18T09:07:15.795377Z","steps":["trace[1026291601] 'process raft request'  (duration: 176.559894ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:15.795584Z","caller":"traceutil/trace.go:171","msg":"trace[1145981384] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"177.097474ms","start":"2026-04-18T09:07:15.618478Z","end":"2026-04-18T09:07:15.795575Z","steps":["trace[1145981384] 'process raft request'  (duration: 176.747948ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:15.795735Z","caller":"traceutil/trace.go:171","msg":"trace[1529217544] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"176.956492ms","start":"2026-04-18T09:07:15.618771Z","end":"2026-04-18T09:07:15.795727Z","steps":["trace[1529217544] 'process raft request'  (duration: 176.563445ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:15.795923Z","caller":"traceutil/trace.go:171","msg":"trace[1243075486] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:728; }","duration":"176.226728ms","start":"2026-04-18T09:07:15.61967Z","end":"2026-04-18T09:07:15.795897Z","steps":["trace[1243075486] 'read index received'  (duration: 114.173848ms)","trace[1243075486] 'applied index is now lower than readState.Index'  (duration: 62.05157ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:15.795951Z","caller":"traceutil/trace.go:171","msg":"trace[1598892101] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"175.249651ms","start":"2026-04-18T09:07:15.620689Z","end":"2026-04-18T09:07:15.795939Z","steps":["trace[1598892101] 'process raft request'  (duration: 175.003365ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.796097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.404972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-04-18T09:07:15.796144Z","caller":"traceutil/trace.go:171","msg":"trace[2133604997] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:710; }","duration":"176.478453ms","start":"2026-04-18T09:07:15.619651Z","end":"2026-04-18T09:07:15.79613Z","steps":["trace[2133604997] 'agreement among raft nodes before linearized reading'  (duration: 176.368331ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:15.796205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.183042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:15.796263Z","caller":"traceutil/trace.go:171","msg":"trace[1027887233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:710; }","duration":"174.255004ms","start":"2026-04-18T09:07:15.62198Z","end":"2026-04-18T09:07:15.796235Z","steps":["trace[1027887233] 'agreement among raft nodes before linearized reading'  (duration: 174.185143ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:17.78745Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561725,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:18.287915Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561725,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:18.788645Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561725,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:19.287115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000143143s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"}
{"level":"info","ts":"2026-04-18T09:07:19.287199Z","caller":"traceutil/trace.go:171","msg":"trace[357996687] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000279865s","start":"2026-04-18T09:07:17.286899Z","end":"2026-04-18T09:07:19.287179Z","steps":["trace[357996687] 'agreement among raft nodes before linearized reading'  (duration: 2.000172293s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.287246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.286872Z","time spent":"2.000364457s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
2026/04/18 09:07:19 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing"
{"level":"warn","ts":"2026-04-18T09:07:19.289325Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378561725,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:19.707121Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.928146058s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-18T09:07:19.70747Z","caller":"traceutil/trace.go:171","msg":"trace[1214940644] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"2.928588105s","start":"2026-04-18T09:07:16.778861Z","end":"2026-04-18T09:07:19.707449Z","steps":["trace[1214940644] 'process raft request'  (duration: 2.928451393s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.707655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:16.778838Z","time spent":"2.928716317s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:703 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-04-18T09:07:19.723516Z","caller":"traceutil/trace.go:171","msg":"trace[2128082724] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"2.099392755s","start":"2026-04-18T09:07:17.624101Z","end":"2026-04-18T09:07:19.723494Z","steps":["trace[2128082724] 'process raft request'  (duration: 2.099252901s)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:19.72365Z","caller":"traceutil/trace.go:171","msg":"trace[451660931] linearizableReadLoop","detail":"{readStateIndex:736; appliedIndex:733; }","duration":"2.436689911s","start":"2026-04-18T09:07:17.286944Z","end":"2026-04-18T09:07:19.723634Z","steps":["trace[451660931] 'read index received'  (duration: 2.420360033s)","trace[451660931] 'applied index is now lower than readState.Index'  (duration: 16.328598ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:19.723673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.624077Z","time spent":"2.099505916s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:676 > 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-04-18T09:07:19.723952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.291573442s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-04-18T09:07:19.723977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.791592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-18T09:07:19.724001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.922972003s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-18T09:07:19.724008Z","caller":"traceutil/trace.go:171","msg":"trace[356009866] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:713; }","duration":"1.291650183s","start":"2026-04-18T09:07:18.432342Z","end":"2026-04-18T09:07:19.723992Z","steps":["trace[356009866] 'agreement among raft nodes before linearized reading'  (duration: 1.291554021s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.724054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:18.432327Z","time spent":"1.291714303s","remote":"127.0.0.1:45460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":42,"response size":31,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-04-18T09:07:19.724129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.382010411s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-04-18T09:07:19.724036Z","caller":"traceutil/trace.go:171","msg":"trace[2072337985] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"436.885504ms","start":"2026-04-18T09:07:19.287132Z","end":"2026-04-18T09:07:19.724018Z","steps":["trace[2072337985] 'agreement among raft nodes before linearized reading'  (duration: 436.782412ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.724281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.124124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-18T09:07:19.724299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:19.287111Z","time spent":"437.170699ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-18T09:07:19.724325Z","caller":"traceutil/trace.go:171","msg":"trace[2022425978] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"524.231296ms","start":"2026-04-18T09:07:19.20008Z","end":"2026-04-18T09:07:19.724312Z","steps":["trace[2022425978] 'agreement among raft nodes before linearized reading'  (duration: 524.166325ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:19.724235Z","caller":"traceutil/trace.go:171","msg":"trace[1043793831] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:713; }","duration":"1.382151694s","start":"2026-04-18T09:07:18.342066Z","end":"2026-04-18T09:07:19.724218Z","steps":["trace[1043793831] 'agreement among raft nodes before linearized reading'  (duration: 1.382014621s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.724365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:19.200048Z","time spent":"524.307537ms","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-04-18T09:07:19.723812Z","caller":"traceutil/trace.go:171","msg":"trace[1567407403] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"385.505257ms","start":"2026-04-18T09:07:19.338296Z","end":"2026-04-18T09:07:19.723802Z","steps":["trace[1567407403] 'process raft request'  (duration: 385.159171ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.72448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:18.342046Z","time spent":"1.382414138s","remote":"127.0.0.1:45692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":31,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "}
{"level":"warn","ts":"2026-04-18T09:07:19.724482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:19.338269Z","time spent":"386.145328ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:694 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-04-18T09:07:19.72405Z","caller":"traceutil/trace.go:171","msg":"trace[646529184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:713; }","duration":"1.923049593s","start":"2026-04-18T09:07:17.800981Z","end":"2026-04-18T09:07:19.724031Z","steps":["trace[646529184] 'agreement among raft nodes before linearized reading'  (duration: 1.922912581s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.724561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.80096Z","time spent":"1.923586973s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:19.72463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.92347842s","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-04-18T09:07:19.724671Z","caller":"traceutil/trace.go:171","msg":"trace[1730847973] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:713; }","duration":"1.923539532s","start":"2026-04-18T09:07:17.801119Z","end":"2026-04-18T09:07:19.724659Z","steps":["trace[1730847973] 'agreement among raft nodes before linearized reading'  (duration: 1.92341255s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.72472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.80111Z","time spent":"1.923601573s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:19.724971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.923887028s","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-04-18T09:07:19.725015Z","caller":"traceutil/trace.go:171","msg":"trace[207853175] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:713; }","duration":"1.92398772s","start":"2026-04-18T09:07:17.801017Z","end":"2026-04-18T09:07:19.725005Z","steps":["trace[207853175] 'agreement among raft nodes before linearized reading'  (duration: 1.923875308s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.725044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.800979Z","time spent":"1.924058411s","remote":"127.0.0.1:45530","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-04-18T09:07:19.72505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.923834337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:07:19.725077Z","caller":"traceutil/trace.go:171","msg":"trace[1609337546] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:713; }","duration":"1.923862167s","start":"2026-04-18T09:07:17.801207Z","end":"2026-04-18T09:07:19.725069Z","steps":["trace[1609337546] 'agreement among raft nodes before linearized reading'  (duration: 1.923565002s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:19.725113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:17.801102Z","time spent":"1.92400634s","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:23.777953Z","caller":"traceutil/trace.go:171","msg":"trace[1622129736] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"121.37355ms","start":"2026-04-18T09:07:23.656553Z","end":"2026-04-18T09:07:23.777926Z","steps":["trace[1622129736] 'process raft request'  (duration: 83.668294ms)","trace[1622129736] 'compare'  (duration: 37.558594ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:34.247016Z","caller":"traceutil/trace.go:171","msg":"trace[1311349233] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:837; }","duration":"415.738218ms","start":"2026-04-18T09:07:33.831253Z","end":"2026-04-18T09:07:34.246991Z","steps":["trace[1311349233] 'read index received'  (duration: 415.636056ms)","trace[1311349233] 'applied index is now lower than readState.Index'  (duration: 101.142µs)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:34.247167Z","caller":"traceutil/trace.go:171","msg":"trace[226713300] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"535.170957ms","start":"2026-04-18T09:07:33.711985Z","end":"2026-04-18T09:07:34.247156Z","steps":["trace[226713300] 'process raft request'  (duration: 534.819611ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:34.247275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.711966Z","time spent":"535.229868ms","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4856,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/coredns-7c96b6546b-kkgmm\" mod_revision:806 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-kkgmm\" value_size:4797 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-7c96b6546b-kkgmm\" > >"}
{"level":"warn","ts":"2026-04-18T09:07:34.247485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.223655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:07:34.247524Z","caller":"traceutil/trace.go:171","msg":"trace[437100342] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"416.297446ms","start":"2026-04-18T09:07:33.831215Z","end":"2026-04-18T09:07:34.247512Z","steps":["trace[437100342] 'agreement among raft nodes before linearized reading'  (duration: 416.170354ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:34.247561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.831196Z","time spent":"416.352568ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-18T09:07:34.247686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.181039ms","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-04-18T09:07:34.247776Z","caller":"traceutil/trace.go:171","msg":"trace[1380370672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"380.320112ms","start":"2026-04-18T09:07:33.867431Z","end":"2026-04-18T09:07:34.247752Z","steps":["trace[1380370672] 'agreement among raft nodes before linearized reading'  (duration: 380.063368ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:34.24783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.867413Z","time spent":"380.403314ms","remote":"127.0.0.1:45530","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-04-18T09:07:34.247906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.665268ms","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-04-18T09:07:34.247943Z","caller":"traceutil/trace.go:171","msg":"trace[98608818] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"320.73161ms","start":"2026-04-18T09:07:33.927201Z","end":"2026-04-18T09:07:34.247933Z","steps":["trace[98608818] 'agreement among raft nodes before linearized reading'  (duration: 320.629208ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:34.247976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.927188Z","time spent":"320.77862ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:34.248035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.795573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-04-18T09:07:34.248096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.051919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-18T09:07:34.248094Z","caller":"traceutil/trace.go:171","msg":"trace[1538550661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"302.938035ms","start":"2026-04-18T09:07:33.945139Z","end":"2026-04-18T09:07:34.248077Z","steps":["trace[1538550661] 'agreement among raft nodes before linearized reading'  (duration: 302.784352ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:34.248129Z","caller":"traceutil/trace.go:171","msg":"trace[1715742501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"377.11982ms","start":"2026-04-18T09:07:33.870999Z","end":"2026-04-18T09:07:34.248118Z","steps":["trace[1715742501] 'agreement among raft nodes before linearized reading'  (duration: 377.041829ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:34.248144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.945114Z","time spent":"303.017897ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:34.248156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:33.870977Z","time spent":"377.172521ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:37.79042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378562055,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:38.291327Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378562055,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:38.791782Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378562055,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-04-18T09:07:39.027987Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.308045485s","expected-duration":"1s"}
{"level":"info","ts":"2026-04-18T09:07:39.028422Z","caller":"traceutil/trace.go:171","msg":"trace[511641405] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"2.308621933s","start":"2026-04-18T09:07:36.719777Z","end":"2026-04-18T09:07:39.028399Z","steps":["trace[511641405] 'process raft request'  (duration: 2.30841032s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.028646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:36.719753Z","time spent":"2.308788196s","remote":"127.0.0.1:45442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s9hm\" mod_revision:789 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s9hm\" value_size:3943 >> failure:<request_range:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7s9hm\" > >"}
{"level":"info","ts":"2026-04-18T09:07:39.081376Z","caller":"traceutil/trace.go:171","msg":"trace[330171436] linearizableReadLoop","detail":"{readStateIndex:862; appliedIndex:860; }","duration":"1.791399583s","start":"2026-04-18T09:07:37.289947Z","end":"2026-04-18T09:07:39.081347Z","steps":["trace[330171436] 'read index received'  (duration: 1.738226086s)","trace[330171436] 'applied index is now lower than readState.Index'  (duration: 53.171967ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:39.081556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.791586316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:39.081635Z","caller":"traceutil/trace.go:171","msg":"trace[429469244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:832; }","duration":"1.791724138s","start":"2026-04-18T09:07:37.289891Z","end":"2026-04-18T09:07:39.081616Z","steps":["trace[429469244] 'agreement among raft nodes before linearized reading'  (duration: 1.791576506s)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.081685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:37.289861Z","time spent":"1.7918156s","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-18T09:07:39.081742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.93046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-04-18T09:07:39.08164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.458786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-04-18T09:07:39.081783Z","caller":"traceutil/trace.go:171","msg":"trace[1731522723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:832; }","duration":"777.007972ms","start":"2026-04-18T09:07:38.304764Z","end":"2026-04-18T09:07:39.081772Z","steps":["trace[1731522723] 'agreement among raft nodes before linearized reading'  (duration: 776.900231ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.081821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:38.304732Z","time spent":"777.081053ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-04-18T09:07:39.081815Z","caller":"traceutil/trace.go:171","msg":"trace[119206040] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:832; }","duration":"784.663209ms","start":"2026-04-18T09:07:38.297123Z","end":"2026-04-18T09:07:39.081786Z","steps":["trace[119206040] 'agreement among raft nodes before linearized reading'  (duration: 784.380235ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.081873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:38.297108Z","time spent":"784.74833ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:39.081916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.964469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-04-18T09:07:39.082002Z","caller":"traceutil/trace.go:171","msg":"trace[1118982368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:832; }","duration":"773.08484ms","start":"2026-04-18T09:07:38.308898Z","end":"2026-04-18T09:07:39.081983Z","steps":["trace[1118982368] 'agreement among raft nodes before linearized reading'  (duration: 772.830896ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.081954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.63705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:07:39.08226Z","caller":"traceutil/trace.go:171","msg":"trace[1685734325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:832; }","duration":"776.017955ms","start":"2026-04-18T09:07:38.306229Z","end":"2026-04-18T09:07:39.082247Z","steps":["trace[1685734325] 'agreement among raft nodes before linearized reading'  (duration: 775.422096ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.082352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:38.306219Z","time spent":"776.122298ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-04-18T09:07:39.082049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:38.308888Z","time spent":"773.152821ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"warn","ts":"2026-04-18T09:07:39.082141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.875863ms","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-04-18T09:07:39.083247Z","caller":"traceutil/trace.go:171","msg":"trace[1659358635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:832; }","duration":"777.035531ms","start":"2026-04-18T09:07:38.306196Z","end":"2026-04-18T09:07:39.083232Z","steps":["trace[1659358635] 'agreement among raft nodes before linearized reading'  (duration: 775.361456ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:39.083292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:07:38.30618Z","time spent":"777.099022ms","remote":"127.0.0.1:45530","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-04-18T09:07:44.7667Z","caller":"traceutil/trace.go:171","msg":"trace[156336143] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"109.733805ms","start":"2026-04-18T09:07:44.656943Z","end":"2026-04-18T09:07:44.766676Z","steps":["trace[156336143] 'process raft request'  (duration: 109.577293ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:44.914418Z","caller":"traceutil/trace.go:171","msg":"trace[1397639355] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"125.148675ms","start":"2026-04-18T09:07:44.789225Z","end":"2026-04-18T09:07:44.914374Z","steps":["trace[1397639355] 'process raft request'  (duration: 78.553621ms)","trace[1397639355] 'compare'  (duration: 46.227879ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:45.276014Z","caller":"traceutil/trace.go:171","msg":"trace[895015867] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"107.728455ms","start":"2026-04-18T09:07:45.16826Z","end":"2026-04-18T09:07:45.275988Z","steps":["trace[895015867] 'process raft request'  (duration: 107.570353ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:45.291635Z","caller":"traceutil/trace.go:171","msg":"trace[934191022] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"123.000452ms","start":"2026-04-18T09:07:45.168608Z","end":"2026-04-18T09:07:45.291608Z","steps":["trace[934191022] 'process raft request'  (duration: 122.8185ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:45.291721Z","caller":"traceutil/trace.go:171","msg":"trace[2057695001] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:927; }","duration":"110.314275ms","start":"2026-04-18T09:07:45.181382Z","end":"2026-04-18T09:07:45.291696Z","steps":["trace[2057695001] 'read index received'  (duration: 94.464879ms)","trace[2057695001] 'applied index is now lower than readState.Index'  (duration: 15.847616ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:07:45.291894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.494337ms","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-04-18T09:07:45.291935Z","caller":"traceutil/trace.go:171","msg":"trace[1152030262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:899; }","duration":"110.569159ms","start":"2026-04-18T09:07:45.181355Z","end":"2026-04-18T09:07:45.291925Z","steps":["trace[1152030262] 'agreement among raft nodes before linearized reading'  (duration: 110.427567ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:45.292051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.380097ms","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-04-18T09:07:45.292138Z","caller":"traceutil/trace.go:171","msg":"trace[1925680146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:899; }","duration":"100.500799ms","start":"2026-04-18T09:07:45.191623Z","end":"2026-04-18T09:07:45.292124Z","steps":["trace[1925680146] 'agreement among raft nodes before linearized reading'  (duration: 100.261465ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:45.291854Z","caller":"traceutil/trace.go:171","msg":"trace[1801370192] transaction","detail":"{read_only:false; response_revision:899; number_of_response:1; }","duration":"120.410924ms","start":"2026-04-18T09:07:45.171362Z","end":"2026-04-18T09:07:45.291773Z","steps":["trace[1801370192] 'process raft request'  (duration: 120.208261ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:48.531266Z","caller":"traceutil/trace.go:171","msg":"trace[1112504082] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"123.68815ms","start":"2026-04-18T09:07:48.407556Z","end":"2026-04-18T09:07:48.531244Z","steps":["trace[1112504082] 'process raft request'  (duration: 82.173116ms)","trace[1112504082] 'compare'  (duration: 41.412913ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:07:48.95343Z","caller":"traceutil/trace.go:171","msg":"trace[324615462] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"113.721726ms","start":"2026-04-18T09:07:48.839687Z","end":"2026-04-18T09:07:48.953408Z","steps":["trace[324615462] 'process raft request'  (duration: 113.617504ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:07:48.953637Z","caller":"traceutil/trace.go:171","msg":"trace[831629456] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"113.431202ms","start":"2026-04-18T09:07:48.840174Z","end":"2026-04-18T09:07:48.953605Z","steps":["trace[831629456] 'process raft request'  (duration: 113.194648ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:07:54.412523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.765155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-04-18T09:07:54.412585Z","caller":"traceutil/trace.go:171","msg":"trace[1884443093] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:996; }","duration":"124.873538ms","start":"2026-04-18T09:07:54.2877Z","end":"2026-04-18T09:07:54.412573Z","steps":["trace[1884443093] 'range keys from in-memory index tree'  (duration: 124.707735ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:08:22.176582Z","caller":"traceutil/trace.go:171","msg":"trace[321099527] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"284.98877ms","start":"2026-04-18T09:08:21.891576Z","end":"2026-04-18T09:08:22.176565Z","steps":["trace[321099527] 'process raft request'  (duration: 229.290524ms)","trace[321099527] 'compare'  (duration: 55.314411ms)"],"step_count":2}
{"level":"info","ts":"2026-04-18T09:08:22.176784Z","caller":"traceutil/trace.go:171","msg":"trace[1032240294] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"284.514184ms","start":"2026-04-18T09:08:21.892265Z","end":"2026-04-18T09:08:22.176779Z","steps":["trace[1032240294] 'process raft request'  (duration: 284.26103ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:08:22.176787Z","caller":"traceutil/trace.go:171","msg":"trace[581614495] linearizableReadLoop","detail":"{readStateIndex:1149; appliedIndex:1147; }","duration":"201.573698ms","start":"2026-04-18T09:08:21.975162Z","end":"2026-04-18T09:08:22.176736Z","steps":["trace[581614495] 'read index received'  (duration: 145.563447ms)","trace[581614495] 'applied index is now lower than readState.Index'  (duration: 56.006311ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:08:22.177007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.79949ms","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-04-18T09:08:22.177139Z","caller":"traceutil/trace.go:171","msg":"trace[1400811343] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1109; }","duration":"202.000792ms","start":"2026-04-18T09:08:21.975119Z","end":"2026-04-18T09:08:22.177119Z","steps":["trace[1400811343] 'agreement among raft nodes before linearized reading'  (duration: 201.765059ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:08:30.362589Z","caller":"traceutil/trace.go:171","msg":"trace[1008600150] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"109.49438ms","start":"2026-04-18T09:08:30.253056Z","end":"2026-04-18T09:08:30.36255Z","steps":["trace[1008600150] 'process raft request'  (duration: 109.297278ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:08:58.034987Z","caller":"traceutil/trace.go:171","msg":"trace[247324263] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"104.55427ms","start":"2026-04-18T09:08:57.930366Z","end":"2026-04-18T09:08:58.034921Z","steps":["trace[247324263] 'process raft request'  (duration: 104.408948ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:09:27.134899Z","caller":"traceutil/trace.go:171","msg":"trace[212060285] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"413.846426ms","start":"2026-04-18T09:09:26.721027Z","end":"2026-04-18T09:09:27.134874Z","steps":["trace[212060285] 'process raft request'  (duration: 413.668884ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:27.135078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:26.721009Z","time spent":"413.979948ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1338 > 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-04-18T09:09:27.224553Z","caller":"traceutil/trace.go:171","msg":"trace[1187641297] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"502.141008ms","start":"2026-04-18T09:09:26.722387Z","end":"2026-04-18T09:09:27.224528Z","steps":["trace[1187641297] 'process raft request'  (duration: 500.487911ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:27.224726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:26.72236Z","time spent":"502.276819ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1339 > 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-04-18T09:09:28.35948Z","caller":"traceutil/trace.go:171","msg":"trace[834181068] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"101.407835ms","start":"2026-04-18T09:09:28.258044Z","end":"2026-04-18T09:09:28.359452Z","steps":["trace[834181068] 'process raft request'  (duration: 101.225443ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:35.79682Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898655378563357,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-04-18T09:09:36.052395Z","caller":"traceutil/trace.go:171","msg":"trace[934355636] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"885.128618ms","start":"2026-04-18T09:09:35.16724Z","end":"2026-04-18T09:09:36.052369Z","steps":["trace[934355636] 'process raft request'  (duration: 884.970916ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:36.052612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:35.167224Z","time spent":"885.319179ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:1376 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-04-18T09:09:36.201471Z","caller":"traceutil/trace.go:171","msg":"trace[66318431] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"725.473219ms","start":"2026-04-18T09:09:35.475962Z","end":"2026-04-18T09:09:36.201435Z","steps":["trace[66318431] 'process raft request'  (duration: 725.222216ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:09:36.201598Z","caller":"traceutil/trace.go:171","msg":"trace[456093180] linearizableReadLoop","detail":"{readStateIndex:1441; appliedIndex:1439; }","duration":"905.018057ms","start":"2026-04-18T09:09:35.296338Z","end":"2026-04-18T09:09:36.201356Z","steps":["trace[456093180] 'read index received'  (duration: 755.86372ms)","trace[456093180] 'applied index is now lower than readState.Index'  (duration: 149.153237ms)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:09:36.201573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.22675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-04-18T09:09:36.20163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:35.475942Z","time spent":"725.60199ms","remote":"127.0.0.1:45530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1378 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-04-18T09:09:36.201703Z","caller":"traceutil/trace.go:171","msg":"trace[1751052053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1385; }","duration":"905.402781ms","start":"2026-04-18T09:09:35.296282Z","end":"2026-04-18T09:09:36.201685Z","steps":["trace[1751052053] 'agreement among raft nodes before linearized reading'  (duration: 905.200339ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:36.201751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:35.296264Z","time spent":"905.477592ms","remote":"127.0.0.1:45278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-04-18T09:09:36.201896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"905.108188ms","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-04-18T09:09:36.201929Z","caller":"traceutil/trace.go:171","msg":"trace[967671270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1385; }","duration":"905.156959ms","start":"2026-04-18T09:09:35.296764Z","end":"2026-04-18T09:09:36.201921Z","steps":["trace[967671270] 'agreement among raft nodes before linearized reading'  (duration: 905.026767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:36.201948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T09:09:35.296755Z","time spent":"905.189219ms","remote":"127.0.0.1:45530","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-04-18T09:09:46.677239Z","caller":"traceutil/trace.go:171","msg":"trace[1950961802] transaction","detail":"{read_only:false; response_revision:1424; number_of_response:1; }","duration":"170.844982ms","start":"2026-04-18T09:09:46.506367Z","end":"2026-04-18T09:09:46.677212Z","steps":["trace[1950961802] 'process raft request'  (duration: 170.72767ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:46.677455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.626673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:kubelet-bootstrap\" ","response":"range_response_count:1 size:492"}
{"level":"info","ts":"2026-04-18T09:09:46.677542Z","caller":"traceutil/trace.go:171","msg":"trace[2026359579] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:kubelet-bootstrap; range_end:; response_count:1; response_revision:1424; }","duration":"134.784035ms","start":"2026-04-18T09:09:46.542738Z","end":"2026-04-18T09:09:46.677522Z","steps":["trace[2026359579] 'agreement among raft nodes before linearized reading'  (duration: 134.626393ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:09:46.677272Z","caller":"traceutil/trace.go:171","msg":"trace[1356821452] linearizableReadLoop","detail":"{readStateIndex:1482; appliedIndex:1482; }","duration":"134.3925ms","start":"2026-04-18T09:09:46.542821Z","end":"2026-04-18T09:09:46.677214Z","steps":["trace[1356821452] 'read index received'  (duration: 134.37623ms)","trace[1356821452] 'applied index is now lower than readState.Index'  (duration: 12.42µs)"],"step_count":2}
{"level":"warn","ts":"2026-04-18T09:09:46.742704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.000872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:get-nodes\" ","response":"range_response_count:1 size:469"}
{"level":"info","ts":"2026-04-18T09:09:46.742786Z","caller":"traceutil/trace.go:171","msg":"trace[1926050902] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:get-nodes; range_end:; response_count:1; response_revision:1424; }","duration":"184.118475ms","start":"2026-04-18T09:09:46.558648Z","end":"2026-04-18T09:09:46.742767Z","steps":["trace[1926050902] 'agreement among raft nodes before linearized reading'  (duration: 183.970713ms)"],"step_count":1}
{"level":"warn","ts":"2026-04-18T09:09:46.743435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.804734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"info","ts":"2026-04-18T09:09:46.743607Z","caller":"traceutil/trace.go:171","msg":"trace[1718669715] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1424; }","duration":"124.007467ms","start":"2026-04-18T09:09:46.61958Z","end":"2026-04-18T09:09:46.743587Z","steps":["trace[1718669715] 'agreement among raft nodes before linearized reading'  (duration: 123.030844ms)"],"step_count":1}
{"level":"info","ts":"2026-04-18T09:09:46.893611Z","caller":"traceutil/trace.go:171","msg":"trace[1709085474] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"144.031994ms","start":"2026-04-18T09:09:46.749536Z","end":"2026-04-18T09:09:46.893568Z","steps":["trace[1709085474] 'process raft request'  (duration: 139.80409ms)"],"step_count":1}