{"level":"warn","ts":"2026-03-01T01:21:31.098462Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-01T01:21:31.098536Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.52:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.52:2380","--initial-cluster=instance=https://162.253.55.52:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.52:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.52: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-03-01T01:21:31.09859Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-01T01:21:31.098597Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-01T01:21:31.098641Z","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-03-01T01:21:31.099266Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"]}
{"level":"info","ts":"2026-03-01T01:21:31.099337Z","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://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.52: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-03-01T01:21:31.10444Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.911579ms"}
{"level":"info","ts":"2026-03-01T01:21:31.111118Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b11e7fc5714be64b","cluster-id":"9349e4f32a52a90a"}
{"level":"info","ts":"2026-03-01T01:21:31.111185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=()"}
{"level":"info","ts":"2026-03-01T01:21:31.111211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 0"}
{"level":"info","ts":"2026-03-01T01:21:31.111225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b11e7fc5714be64b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-01T01:21:31.111242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became follower at term 1"}
{"level":"info","ts":"2026-03-01T01:21:31.111275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"warn","ts":"2026-03-01T01:21:31.116798Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-01T01:21:31.118002Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-01T01:21:31.119074Z","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-03-01T01:21:31.120556Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b11e7fc5714be64b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-01T01:21:31.120653Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b11e7fc5714be64b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-01T01:21:31.120745Z","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-03-01T01:21:31.1208Z","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-03-01T01:21:31.12081Z","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-03-01T01:21:31.13406Z","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-03-01T01:21:31.134247Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-01T01:21:31.134348Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.52:2380"}
{"level":"info","ts":"2026-03-01T01:21:31.134341Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-01T01:21:31.134282Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b11e7fc5714be64b","initial-advertise-peer-urls":["https://162.253.55.52:2380"],"listen-peer-urls":["https://162.253.55.52:2380"],"advertise-client-urls":["https://162.253.55.52:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.52:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-01T01:21:31.135046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b switched to configuration voters=(12762778880000648779)"}
{"level":"info","ts":"2026-03-01T01:21:31.13516Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","added-peer-id":"b11e7fc5714be64b","added-peer-peer-urls":["https://162.253.55.52:2380"]}
{"level":"info","ts":"2026-03-01T01:21:32.012477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b is starting a new election at term 1"}
{"level":"info","ts":"2026-03-01T01:21:32.012544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-01T01:21:32.012594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgPreVoteResp from b11e7fc5714be64b at term 1"}
{"level":"info","ts":"2026-03-01T01:21:32.012634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became candidate at term 2"}
{"level":"info","ts":"2026-03-01T01:21:32.012647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b received MsgVoteResp from b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-01T01:21:32.012671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b11e7fc5714be64b became leader at term 2"}
{"level":"info","ts":"2026-03-01T01:21:32.012689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b11e7fc5714be64b elected leader b11e7fc5714be64b at term 2"}
{"level":"info","ts":"2026-03-01T01:21:32.013807Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T01:21:32.014573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b11e7fc5714be64b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.52:2379]}","request-path":"/0/members/b11e7fc5714be64b/attributes","cluster-id":"9349e4f32a52a90a","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-01T01:21:32.01475Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-01T01:21:32.01482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-01T01:21:32.014988Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-01T01:21:32.01508Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-01T01:21:32.01615Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9349e4f32a52a90a","local-member-id":"b11e7fc5714be64b","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T01:21:32.016314Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T01:21:32.016349Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-01T01:21:32.018511Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-03-01T01:21:32.024079Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.52:2379"}
{"level":"info","ts":"2026-03-01T01:21:40.125515Z","caller":"traceutil/trace.go:171","msg":"trace[1908806573] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"167.198366ms","start":"2026-03-01T01:21:39.958297Z","end":"2026-03-01T01:21:40.125495Z","steps":["trace[1908806573] 'process raft request'  (duration: 167.063623ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:21:40.383287Z","caller":"traceutil/trace.go:171","msg":"trace[434504002] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"250.634664ms","start":"2026-03-01T01:21:40.132634Z","end":"2026-03-01T01:21:40.383269Z","steps":["trace[434504002] 'process raft request'  (duration: 250.363528ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:21:41.055594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.985825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-03-01T01:21:41.055681Z","caller":"traceutil/trace.go:171","msg":"trace[566637862] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:335; }","duration":"571.16302ms","start":"2026-03-01T01:21:40.484497Z","end":"2026-03-01T01:21:41.055661Z","steps":["trace[566637862] 'range keys from in-memory index tree'  (duration: 570.837271ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:21:41.055723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:21:40.484477Z","time spent":"571.236391ms","remote":"127.0.0.1:59136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"warn","ts":"2026-03-01T01:21:41.055709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.37498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-01T01:21:41.055811Z","caller":"traceutil/trace.go:171","msg":"trace[931553747] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:335; }","duration":"185.526852ms","start":"2026-03-01T01:21:40.870265Z","end":"2026-03-01T01:21:41.055791Z","steps":["trace[931553747] 'range keys from in-memory index tree'  (duration: 185.124293ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:21:41.305099Z","caller":"traceutil/trace.go:171","msg":"trace[1509069970] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"245.38685ms","start":"2026-03-01T01:21:41.05969Z","end":"2026-03-01T01:21:41.305076Z","steps":["trace[1509069970] 'process raft request'  (duration: 245.224836ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:21:41.306381Z","caller":"traceutil/trace.go:171","msg":"trace[1951803128] transaction","detail":"{read_only:false; response_revision:337; number_of_response:1; }","duration":"246.632067ms","start":"2026-03-01T01:21:41.05973Z","end":"2026-03-01T01:21:41.306362Z","steps":["trace[1951803128] 'process raft request'  (duration: 246.541635ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:01.662821Z","caller":"traceutil/trace.go:171","msg":"trace[78622390] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"260.929454ms","start":"2026-03-01T01:22:01.401876Z","end":"2026-03-01T01:22:01.662805Z","steps":["trace[78622390] 'process raft request'  (duration: 260.793341ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:07.714884Z","caller":"traceutil/trace.go:171","msg":"trace[906917223] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"241.773719ms","start":"2026-03-01T01:22:07.473084Z","end":"2026-03-01T01:22:07.714857Z","steps":["trace[906917223] 'process raft request'  (duration: 241.638806ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:07.859957Z","caller":"traceutil/trace.go:171","msg":"trace[418551638] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"141.096368ms","start":"2026-03-01T01:22:07.718834Z","end":"2026-03-01T01:22:07.859931Z","steps":["trace[418551638] 'process raft request'  (duration: 140.883264ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:07.875039Z","caller":"traceutil/trace.go:171","msg":"trace[136733193] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"155.875974ms","start":"2026-03-01T01:22:07.719144Z","end":"2026-03-01T01:22:07.87502Z","steps":["trace[136733193] 'process raft request'  (duration: 155.70174ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:07.875237Z","caller":"traceutil/trace.go:171","msg":"trace[1271046266] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"156.055398ms","start":"2026-03-01T01:22:07.719167Z","end":"2026-03-01T01:22:07.875223Z","steps":["trace[1271046266] 'process raft request'  (duration: 155.787702ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:08.210321Z","caller":"traceutil/trace.go:171","msg":"trace[539281954] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"100.438646ms","start":"2026-03-01T01:22:08.10986Z","end":"2026-03-01T01:22:08.210298Z","steps":["trace[539281954] 'process raft request'  (duration: 100.287603ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:09.303416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"930.625648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:09.303492Z","caller":"traceutil/trace.go:171","msg":"trace[743561153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:534; }","duration":"930.74653ms","start":"2026-03-01T01:22:08.372728Z","end":"2026-03-01T01:22:09.303474Z","steps":["trace[743561153] 'range keys from in-memory index tree'  (duration: 930.507615ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:09.303529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:08.372702Z","time spent":"930.819741ms","remote":"127.0.0.1:59016","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-03-01T01:22:10.368304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.280821ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991339420 > lease_revoke:<id:664b9ca6fc7deaf0>","response":"size:29"}
{"level":"info","ts":"2026-03-01T01:22:14.35604Z","caller":"traceutil/trace.go:171","msg":"trace[668061832] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"106.736356ms","start":"2026-03-01T01:22:14.249281Z","end":"2026-03-01T01:22:14.356018Z","steps":["trace[668061832] 'process raft request'  (duration: 105.080739ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:28.944987Z","caller":"traceutil/trace.go:171","msg":"trace[1689445553] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"204.321002ms","start":"2026-03-01T01:22:28.740648Z","end":"2026-03-01T01:22:28.944969Z","steps":["trace[1689445553] 'process raft request'  (duration: 204.207219ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:29.836672Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529492991339771,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-01T01:22:30.161574Z","caller":"traceutil/trace.go:171","msg":"trace[2060809477] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:743; }","duration":"825.606019ms","start":"2026-03-01T01:22:29.335949Z","end":"2026-03-01T01:22:30.161555Z","steps":["trace[2060809477] 'read index received'  (duration: 825.405934ms)","trace[2060809477] 'applied index is now lower than readState.Index'  (duration: 198.865µs)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:30.161644Z","caller":"traceutil/trace.go:171","msg":"trace[1184281429] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"986.837754ms","start":"2026-03-01T01:22:29.174763Z","end":"2026-03-01T01:22:30.1616Z","steps":["trace[1184281429] 'process raft request'  (duration: 986.688131ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.161807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.828925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:30.161835Z","caller":"traceutil/trace.go:171","msg":"trace[837225062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"789.934387ms","start":"2026-03-01T01:22:29.371891Z","end":"2026-03-01T01:22:30.161826Z","steps":["trace[837225062] 'agreement among raft nodes before linearized reading'  (duration: 789.780274ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.1618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"825.766563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-01T01:22:30.161862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:29.371877Z","time spent":"789.980349ms","remote":"127.0.0.1:59018","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-03-01T01:22:30.161889Z","caller":"traceutil/trace.go:171","msg":"trace[1814118273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:723; }","duration":"825.958617ms","start":"2026-03-01T01:22:29.335908Z","end":"2026-03-01T01:22:30.161867Z","steps":["trace[1814118273] 'agreement among raft nodes before linearized reading'  (duration: 825.727102ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.161935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:29.335888Z","time spent":"826.037969ms","remote":"127.0.0.1:59016","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-03-01T01:22:30.161953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.347597ms","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-03-01T01:22:30.16201Z","caller":"traceutil/trace.go:171","msg":"trace[1599069458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:723; }","duration":"205.440128ms","start":"2026-03-01T01:22:29.956555Z","end":"2026-03-01T01:22:30.161996Z","steps":["trace[1599069458] 'agreement among raft nodes before linearized reading'  (duration: 205.274895ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.162085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.395761ms","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-03-01T01:22:30.16214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.220331ms","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-03-01T01:22:30.162144Z","caller":"traceutil/trace.go:171","msg":"trace[1493150121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:723; }","duration":"180.473244ms","start":"2026-03-01T01:22:29.98165Z","end":"2026-03-01T01:22:30.162124Z","steps":["trace[1493150121] 'agreement among raft nodes before linearized reading'  (duration: 180.356381ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:30.162162Z","caller":"traceutil/trace.go:171","msg":"trace[1305746826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:723; }","duration":"217.269051ms","start":"2026-03-01T01:22:29.944887Z","end":"2026-03-01T01:22:30.162156Z","steps":["trace[1305746826] 'agreement among raft nodes before linearized reading'  (duration: 217.186699ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.161952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.188786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-03-01T01:22:30.162273Z","caller":"traceutil/trace.go:171","msg":"trace[945270932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:723; }","duration":"185.549345ms","start":"2026-03-01T01:22:29.97671Z","end":"2026-03-01T01:22:30.162259Z","steps":["trace[945270932] 'agreement among raft nodes before linearized reading'  (duration: 185.053293ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.162303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:29.174734Z","time spent":"987.024629ms","remote":"127.0.0.1:59096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":723,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-t5dhb.1898930fbcd13fd8\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-t5dhb.1898930fbcd13fd8\" value_size:635 lease:7371157456136562641 >> failure:<>"}
{"level":"warn","ts":"2026-03-01T01:22:30.595787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.320527ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991339775 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:720 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T01:22:30.595959Z","caller":"traceutil/trace.go:171","msg":"trace[1885567239] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"430.720222ms","start":"2026-03-01T01:22:30.165215Z","end":"2026-03-01T01:22:30.595936Z","steps":["trace[1885567239] 'process raft request'  (duration: 51.074688ms)","trace[1885567239] 'compare'  (duration: 379.210734ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:30.596151Z","caller":"traceutil/trace.go:171","msg":"trace[1654011636] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"430.495397ms","start":"2026-03-01T01:22:30.16563Z","end":"2026-03-01T01:22:30.596125Z","steps":["trace[1654011636] 'process raft request'  (duration: 430.255261ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:30.596167Z","caller":"traceutil/trace.go:171","msg":"trace[236947555] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"429.637066ms","start":"2026-03-01T01:22:30.166522Z","end":"2026-03-01T01:22:30.596159Z","steps":["trace[236947555] 'process raft request'  (duration: 429.41211ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.596205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:30.165604Z","time spent":"430.571068ms","remote":"127.0.0.1:59270","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:719 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:30.596211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:30.166515Z","time spent":"429.675916ms","remote":"127.0.0.1:59270","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:718 > 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-03-01T01:22:30.596258Z","caller":"traceutil/trace.go:171","msg":"trace[701611077] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"429.333068ms","start":"2026-03-01T01:22:30.166892Z","end":"2026-03-01T01:22:30.596225Z","steps":["trace[701611077] 'process raft request'  (duration: 429.068632ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.596413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:30.166877Z","time spent":"429.453161ms","remote":"127.0.0.1:59270","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:721 > 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-03-01T01:22:30.596392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:30.165198Z","time spent":"430.807024ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:720 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:30.826763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.743433ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991339779 > lease_revoke:<id:664b9ca6fc7dec28>","response":"size:29"}
{"level":"info","ts":"2026-03-01T01:22:30.826859Z","caller":"traceutil/trace.go:171","msg":"trace[50047220] linearizableReadLoop","detail":"{readStateIndex:749; appliedIndex:744; }","duration":"454.486068ms","start":"2026-03-01T01:22:30.372355Z","end":"2026-03-01T01:22:30.826841Z","steps":["trace[50047220] 'read index received'  (duration: 214.604449ms)","trace[50047220] 'applied index is now lower than readState.Index'  (duration: 239.880199ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:22:30.826962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.56967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:30.826998Z","caller":"traceutil/trace.go:171","msg":"trace[610415160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:727; }","duration":"454.671152ms","start":"2026-03-01T01:22:30.37232Z","end":"2026-03-01T01:22:30.826991Z","steps":["trace[610415160] 'agreement among raft nodes before linearized reading'  (duration: 454.567259ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:30.827029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:30.372303Z","time spent":"454.719934ms","remote":"127.0.0.1:59016","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-03-01T01:22:34.726627Z","caller":"traceutil/trace.go:171","msg":"trace[1019039424] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:755; }","duration":"101.367367ms","start":"2026-03-01T01:22:34.625242Z","end":"2026-03-01T01:22:34.726609Z","steps":["trace[1019039424] 'read index received'  (duration: 71.638809ms)","trace[1019039424] 'applied index is now lower than readState.Index'  (duration: 29.727798ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:34.726707Z","caller":"traceutil/trace.go:171","msg":"trace[295354347] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"102.001362ms","start":"2026-03-01T01:22:34.624678Z","end":"2026-03-01T01:22:34.726679Z","steps":["trace[295354347] 'process raft request'  (duration: 101.881899ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:34.726767Z","caller":"traceutil/trace.go:171","msg":"trace[111113339] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"100.607449ms","start":"2026-03-01T01:22:34.626152Z","end":"2026-03-01T01:22:34.72676Z","steps":["trace[111113339] 'process raft request'  (duration: 100.433825ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:34.72674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.47521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-01T01:22:34.726896Z","caller":"traceutil/trace.go:171","msg":"trace[1182046636] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:737; }","duration":"101.653544ms","start":"2026-03-01T01:22:34.62523Z","end":"2026-03-01T01:22:34.726883Z","steps":["trace[1182046636] 'agreement among raft nodes before linearized reading'  (duration: 101.445999ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:34.727227Z","caller":"traceutil/trace.go:171","msg":"trace[2096168034] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"102.549915ms","start":"2026-03-01T01:22:34.624665Z","end":"2026-03-01T01:22:34.727215Z","steps":["trace[2096168034] 'process raft request'  (duration: 101.814377ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.170579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.180622866s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:36.170688Z","caller":"traceutil/trace.go:171","msg":"trace[543827550] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:738; }","duration":"1.180738569s","start":"2026-03-01T01:22:34.989926Z","end":"2026-03-01T01:22:36.170664Z","steps":["trace[543827550] 'range keys from in-memory index tree'  (duration: 1.180607216s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.17069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110232158s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.52\" ","response":"range_response_count:1 size:133"}
{"level":"info","ts":"2026-03-01T01:22:36.170745Z","caller":"traceutil/trace.go:171","msg":"trace[648150944] range","detail":"{range_begin:/registry/masterleases/162.253.55.52; range_end:; response_count:1; response_revision:738; }","duration":"1.110324889s","start":"2026-03-01T01:22:35.060407Z","end":"2026-03-01T01:22:36.170732Z","steps":["trace[648150944] 'range keys from in-memory index tree'  (duration: 1.110072903s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.170772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:35.060391Z","time spent":"1.110375551s","remote":"127.0.0.1:59048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/162.253.55.52\" "}
{"level":"warn","ts":"2026-03-01T01:22:36.17092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203414249s","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-03-01T01:22:36.170945Z","caller":"traceutil/trace.go:171","msg":"trace[80795354] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:738; }","duration":"1.203468931s","start":"2026-03-01T01:22:34.967469Z","end":"2026-03-01T01:22:36.170938Z","steps":["trace[80795354] 'range keys from in-memory index tree'  (duration: 1.203301077s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.170973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:34.967456Z","time spent":"1.203506052s","remote":"127.0.0.1:59270","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-03-01T01:22:36.489955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:35.837166Z","time spent":"652.785958ms","remote":"127.0.0.1:59096","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"info","ts":"2026-03-01T01:22:36.82889Z","caller":"traceutil/trace.go:171","msg":"trace[1710384494] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:761; }","duration":"456.292861ms","start":"2026-03-01T01:22:36.372576Z","end":"2026-03-01T01:22:36.828869Z","steps":["trace[1710384494] 'read index received'  (duration: 117.535433ms)","trace[1710384494] 'applied index is now lower than readState.Index'  (duration: 338.756548ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:36.828998Z","caller":"traceutil/trace.go:171","msg":"trace[1671696022] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"654.12625ms","start":"2026-03-01T01:22:36.17486Z","end":"2026-03-01T01:22:36.828986Z","steps":["trace[1671696022] 'process raft request'  (duration: 653.862504ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.829022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:36.171811Z","time spent":"657.203874ms","remote":"127.0.0.1:59048","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-01T01:22:36.829105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:36.174844Z","time spent":"654.179091ms","remote":"127.0.0.1:59270","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:733 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:36.829123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.514938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:36.829225Z","caller":"traceutil/trace.go:171","msg":"trace[344089460] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"456.64793ms","start":"2026-03-01T01:22:36.372539Z","end":"2026-03-01T01:22:36.829187Z","steps":["trace[344089460] 'agreement among raft nodes before linearized reading'  (duration: 456.499936ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.829295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:36.372524Z","time spent":"456.761673ms","remote":"127.0.0.1:59016","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-03-01T01:22:36.842908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.621952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-01T01:22:36.842927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.470302ms","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-03-01T01:22:36.842957Z","caller":"traceutil/trace.go:171","msg":"trace[1434870845] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:740; }","duration":"111.707224ms","start":"2026-03-01T01:22:36.73124Z","end":"2026-03-01T01:22:36.842947Z","steps":["trace[1434870845] 'agreement among raft nodes before linearized reading'  (duration: 111.54653ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:36.842983Z","caller":"traceutil/trace.go:171","msg":"trace[1466999338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:740; }","duration":"112.552475ms","start":"2026-03-01T01:22:36.730417Z","end":"2026-03-01T01:22:36.842969Z","steps":["trace[1466999338] 'agreement among raft nodes before linearized reading'  (duration: 112.397461ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.84312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.52482ms","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-03-01T01:22:36.843152Z","caller":"traceutil/trace.go:171","msg":"trace[725654964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:740; }","duration":"111.594682ms","start":"2026-03-01T01:22:36.731549Z","end":"2026-03-01T01:22:36.843144Z","steps":["trace[725654964] 'agreement among raft nodes before linearized reading'  (duration: 111.51683ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.843297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.118003ms","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-03-01T01:22:36.843325Z","caller":"traceutil/trace.go:171","msg":"trace[377781967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"143.184715ms","start":"2026-03-01T01:22:36.700134Z","end":"2026-03-01T01:22:36.843319Z","steps":["trace[377781967] 'agreement among raft nodes before linearized reading'  (duration: 143.112263ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:36.843453Z","caller":"traceutil/trace.go:171","msg":"trace[116449363] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"351.696197ms","start":"2026-03-01T01:22:36.491052Z","end":"2026-03-01T01:22:36.842748Z","steps":["trace[116449363] 'process raft request'  (duration: 351.552174ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.843577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:36.491031Z","time spent":"352.475576ms","remote":"127.0.0.1:59096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":813,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/coredns-7c96b6546b-t5dhb.1898931149f0c220\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/coredns-7c96b6546b-t5dhb.1898931149f0c220\" value_size:725 lease:7371157456136564007 >> failure:<>"}
{"level":"info","ts":"2026-03-01T01:22:36.995864Z","caller":"traceutil/trace.go:171","msg":"trace[46295738] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:765; }","duration":"121.170119ms","start":"2026-03-01T01:22:36.874668Z","end":"2026-03-01T01:22:36.995838Z","steps":["trace[46295738] 'read index received'  (duration: 92.474336ms)","trace[46295738] 'applied index is now lower than readState.Index'  (duration: 28.694933ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:36.996105Z","caller":"traceutil/trace.go:171","msg":"trace[1552154587] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"148.482021ms","start":"2026-03-01T01:22:36.847581Z","end":"2026-03-01T01:22:36.996063Z","steps":["trace[1552154587] 'process raft request'  (duration: 148.140023ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:36.9962Z","caller":"traceutil/trace.go:171","msg":"trace[777881204] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"148.531122ms","start":"2026-03-01T01:22:36.847658Z","end":"2026-03-01T01:22:36.996189Z","steps":["trace[777881204] 'process raft request'  (duration: 148.110252ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:36.996484Z","caller":"traceutil/trace.go:171","msg":"trace[1629048169] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"149.804373ms","start":"2026-03-01T01:22:36.846662Z","end":"2026-03-01T01:22:36.996466Z","steps":["trace[1629048169] 'process raft request'  (duration: 120.533605ms)","trace[1629048169] 'compare'  (duration: 28.403987ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:22:36.996589Z","caller":"traceutil/trace.go:171","msg":"trace[699263283] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"135.918632ms","start":"2026-03-01T01:22:36.86066Z","end":"2026-03-01T01:22:36.996579Z","steps":["trace[699263283] 'process raft request'  (duration: 135.142063ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:36.996153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.456776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"}
{"level":"info","ts":"2026-03-01T01:22:36.996726Z","caller":"traceutil/trace.go:171","msg":"trace[2052759799] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:745; }","duration":"122.079522ms","start":"2026-03-01T01:22:36.874637Z","end":"2026-03-01T01:22:36.996717Z","steps":["trace[2052759799] 'agreement among raft nodes before linearized reading'  (duration: 121.336694ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:38.699205Z","caller":"traceutil/trace.go:171","msg":"trace[553665786] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:769; }","duration":"326.986988ms","start":"2026-03-01T01:22:38.372196Z","end":"2026-03-01T01:22:38.699183Z","steps":["trace[553665786] 'read index received'  (duration: 326.848414ms)","trace[553665786] 'applied index is now lower than readState.Index'  (duration: 137.654µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:22:38.699354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.140081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:38.699321Z","caller":"traceutil/trace.go:171","msg":"trace[301617410] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"466.043404ms","start":"2026-03-01T01:22:38.233247Z","end":"2026-03-01T01:22:38.699291Z","steps":["trace[301617410] 'process raft request'  (duration: 465.804709ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:38.699425Z","caller":"traceutil/trace.go:171","msg":"trace[1577406418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"327.208072ms","start":"2026-03-01T01:22:38.372175Z","end":"2026-03-01T01:22:38.699383Z","steps":["trace[1577406418] 'agreement among raft nodes before linearized reading'  (duration: 327.09578ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:38.699464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:38.37209Z","time spent":"327.366816ms","remote":"127.0.0.1:59016","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-03-01T01:22:38.699518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:38.233219Z","time spent":"466.184157ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:717 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-03-01T01:22:38.705014Z","caller":"traceutil/trace.go:171","msg":"trace[717009810] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"119.628922ms","start":"2026-03-01T01:22:38.585371Z","end":"2026-03-01T01:22:38.705Z","steps":["trace[717009810] 'process raft request'  (duration: 119.257684ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:53.116153Z","caller":"traceutil/trace.go:171","msg":"trace[1141707299] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"219.206498ms","start":"2026-03-01T01:22:52.896925Z","end":"2026-03-01T01:22:53.116132Z","steps":["trace[1141707299] 'process raft request'  (duration: 218.948972ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.363852Z","caller":"traceutil/trace.go:171","msg":"trace[704930218] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"269.541608ms","start":"2026-03-01T01:22:55.09429Z","end":"2026-03-01T01:22:55.363831Z","steps":["trace[704930218] 'read index received'  (duration: 269.385935ms)","trace[704930218] 'applied index is now lower than readState.Index'  (duration: 154.483µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:22:55.363933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.062677Z","time spent":"301.250013ms","remote":"127.0.0.1:59048","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-03-01T01:22:55.363992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.691101ms","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-03-01T01:22:55.364033Z","caller":"traceutil/trace.go:171","msg":"trace[1641475998] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:795; }","duration":"269.814494ms","start":"2026-03-01T01:22:55.094207Z","end":"2026-03-01T01:22:55.364021Z","steps":["trace[1641475998] 'agreement among raft nodes before linearized reading'  (duration: 269.727492ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.417512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.006588ms","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-03-01T01:22:55.417577Z","caller":"traceutil/trace.go:171","msg":"trace[749602655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:796; }","duration":"241.10576ms","start":"2026-03-01T01:22:55.176453Z","end":"2026-03-01T01:22:55.417559Z","steps":["trace[749602655] 'agreement among raft nodes before linearized reading'  (duration: 240.930016ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.417644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.275904ms","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-03-01T01:22:55.417725Z","caller":"traceutil/trace.go:171","msg":"trace[1913509902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:796; }","duration":"241.366136ms","start":"2026-03-01T01:22:55.176333Z","end":"2026-03-01T01:22:55.417699Z","steps":["trace[1913509902] 'agreement among raft nodes before linearized reading'  (duration: 241.192462ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.417903Z","caller":"traceutil/trace.go:171","msg":"trace[770804703] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"133.732759ms","start":"2026-03-01T01:22:55.284098Z","end":"2026-03-01T01:22:55.41783Z","steps":["trace[770804703] 'process raft request'  (duration: 133.049493ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.418003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.734186ms","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-03-01T01:22:55.418058Z","caller":"traceutil/trace.go:171","msg":"trace[272298927] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:796; }","duration":"296.824568ms","start":"2026-03-01T01:22:55.12122Z","end":"2026-03-01T01:22:55.418044Z","steps":["trace[272298927] 'agreement among raft nodes before linearized reading'  (duration: 296.679484ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.418062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.463058ms","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-03-01T01:22:55.418156Z","caller":"traceutil/trace.go:171","msg":"trace[403081339] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:796; }","duration":"241.586573ms","start":"2026-03-01T01:22:55.176541Z","end":"2026-03-01T01:22:55.418127Z","steps":["trace[403081339] 'agreement among raft nodes before linearized reading'  (duration: 241.331466ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.418229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.295059ms","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-03-01T01:22:55.418274Z","caller":"traceutil/trace.go:171","msg":"trace[535798023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:796; }","duration":"242.372501ms","start":"2026-03-01T01:22:55.175892Z","end":"2026-03-01T01:22:55.418264Z","steps":["trace[535798023] 'agreement among raft nodes before linearized reading'  (duration: 242.271999ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.418221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.966733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-01T01:22:55.418405Z","caller":"traceutil/trace.go:171","msg":"trace[802801109] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:796; }","duration":"136.145417ms","start":"2026-03-01T01:22:55.282211Z","end":"2026-03-01T01:22:55.418356Z","steps":["trace[802801109] 'agreement among raft nodes before linearized reading'  (duration: 135.86847ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.683908Z","caller":"traceutil/trace.go:171","msg":"trace[1130149135] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"318.949946ms","start":"2026-03-01T01:22:55.364941Z","end":"2026-03-01T01:22:55.683891Z","steps":["trace[1130149135] 'process raft request'  (duration: 318.828843ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.68394Z","caller":"traceutil/trace.go:171","msg":"trace[1713533970] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:825; }","duration":"266.595347ms","start":"2026-03-01T01:22:55.417319Z","end":"2026-03-01T01:22:55.683914Z","steps":["trace[1713533970] 'read index received'  (duration: 266.584047ms)","trace[1713533970] 'applied index is now lower than readState.Index'  (duration: 9.23µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:22:55.684023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.364922Z","time spent":"319.042067ms","remote":"127.0.0.1:59048","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/162.253.55.52\" mod_revision:773 > success:<request_put:<key:\"/registry/masterleases/162.253.55.52\" value_size:66 lease:7371157456136564166 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.52\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:55.684086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.001521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:22:55.684152Z","caller":"traceutil/trace.go:171","msg":"trace[802509053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"312.084342ms","start":"2026-03-01T01:22:55.372031Z","end":"2026-03-01T01:22:55.684115Z","steps":["trace[802509053] 'agreement among raft nodes before linearized reading'  (duration: 311.961969ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.684181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.372015Z","time spent":"312.160214ms","remote":"127.0.0.1:59018","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-03-01T01:22:55.72381Z","caller":"traceutil/trace.go:171","msg":"trace[2161488] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"302.425592ms","start":"2026-03-01T01:22:55.421368Z","end":"2026-03-01T01:22:55.723793Z","steps":["trace[2161488] 'process raft request'  (duration: 301.736055ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.724061Z","caller":"traceutil/trace.go:171","msg":"trace[2030620588] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"301.796577ms","start":"2026-03-01T01:22:55.422249Z","end":"2026-03-01T01:22:55.724045Z","steps":["trace[2030620588] 'process raft request'  (duration: 300.994877ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.724194Z","caller":"traceutil/trace.go:171","msg":"trace[1480403802] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"301.872529ms","start":"2026-03-01T01:22:55.422314Z","end":"2026-03-01T01:22:55.724187Z","steps":["trace[1480403802] 'process raft request'  (duration: 300.946476ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.724252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.422306Z","time spent":"301.91588ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:795 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:55.724253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.422234Z","time spent":"301.90291ms","remote":"127.0.0.1:59270","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:791 > 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-03-01T01:22:55.724098Z","caller":"traceutil/trace.go:171","msg":"trace[721543231] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"302.234928ms","start":"2026-03-01T01:22:55.42185Z","end":"2026-03-01T01:22:55.724085Z","steps":["trace[721543231] 'process raft request'  (duration: 301.341076ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:22:55.724421Z","caller":"traceutil/trace.go:171","msg":"trace[1584618387] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"302.424572ms","start":"2026-03-01T01:22:55.421974Z","end":"2026-03-01T01:22:55.724399Z","steps":["trace[1584618387] 'process raft request'  (duration: 301.246644ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:22:55.724448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.42183Z","time spent":"302.587416ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:794 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-03-01T01:22:55.724524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.421958Z","time spent":"302.520164ms","remote":"127.0.0.1:59270","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:792 > 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-03-01T01:22:55.724821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:22:55.421345Z","time spent":"302.518595ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:793 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-01T01:23:08.390565Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16594529492991340162,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-03-01T01:23:08.541222Z","caller":"traceutil/trace.go:171","msg":"trace[435986536] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"729.721291ms","start":"2026-03-01T01:23:07.811462Z","end":"2026-03-01T01:23:08.541183Z","steps":["trace[435986536] 'process raft request'  (duration: 729.485286ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.541683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:07.811443Z","time spent":"730.138712ms","remote":"127.0.0.1:59270","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:881 > 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-03-01T01:23:08.807113Z","caller":"traceutil/trace.go:171","msg":"trace[1693335944] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:913; }","duration":"917.531302ms","start":"2026-03-01T01:23:07.889564Z","end":"2026-03-01T01:23:08.807095Z","steps":["trace[1693335944] 'read index received'  (duration: 651.314573ms)","trace[1693335944] 'applied index is now lower than readState.Index'  (duration: 266.216029ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:23:08.807335Z","caller":"traceutil/trace.go:171","msg":"trace[1438089582] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"918.656008ms","start":"2026-03-01T01:23:07.888669Z","end":"2026-03-01T01:23:08.807325Z","steps":["trace[1438089582] 'process raft request'  (duration: 918.260399ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.807413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:07.888651Z","time spent":"918.704919ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:878 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-03-01T01:23:08.807539Z","caller":"traceutil/trace.go:171","msg":"trace[821670666] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"918.809571ms","start":"2026-03-01T01:23:07.888723Z","end":"2026-03-01T01:23:08.807532Z","steps":["trace[821670666] 'process raft request'  (duration: 918.31865ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.807576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:07.888719Z","time spent":"918.835473ms","remote":"127.0.0.1:59270","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:882 > 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-03-01T01:23:08.807661Z","caller":"traceutil/trace.go:171","msg":"trace[1030835656] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"918.542305ms","start":"2026-03-01T01:23:07.889112Z","end":"2026-03-01T01:23:08.807654Z","steps":["trace[1030835656] 'process raft request'  (duration: 917.957731ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.807696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:07.889099Z","time spent":"918.578177ms","remote":"127.0.0.1:59270","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:879 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-03-01T01:23:08.807834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"918.267779ms","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-03-01T01:23:08.807857Z","caller":"traceutil/trace.go:171","msg":"trace[688449733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:886; }","duration":"918.30397ms","start":"2026-03-01T01:23:07.889545Z","end":"2026-03-01T01:23:08.807849Z","steps":["trace[688449733] 'agreement among raft nodes before linearized reading'  (duration: 918.215308ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.80788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:07.88954Z","time spent":"918.3353ms","remote":"127.0.0.1:59270","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-03-01T01:23:08.807974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.71672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:23:08.807992Z","caller":"traceutil/trace.go:171","msg":"trace[783032349] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:886; }","duration":"435.771722ms","start":"2026-03-01T01:23:08.372215Z","end":"2026-03-01T01:23:08.807986Z","steps":["trace[783032349] 'agreement among raft nodes before linearized reading'  (duration: 435.743401ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:08.808006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:08.372195Z","time spent":"435.808102ms","remote":"127.0.0.1:59016","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-03-01T01:23:28.984325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.044873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:23:28.984443Z","caller":"traceutil/trace.go:171","msg":"trace[912960446] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:960; }","duration":"107.214927ms","start":"2026-03-01T01:23:28.877205Z","end":"2026-03-01T01:23:28.98442Z","steps":["trace[912960446] 'count revisions from in-memory index tree'  (duration: 106.933691ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:29.579945Z","caller":"traceutil/trace.go:171","msg":"trace[1534214609] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"112.102379ms","start":"2026-03-01T01:23:29.46782Z","end":"2026-03-01T01:23:29.579923Z","steps":["trace[1534214609] 'process raft request'  (duration: 62.097795ms)","trace[1534214609] 'compare'  (duration: 49.804379ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:23:30.583174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.93271ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991340366 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.1898931dcd82a559\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1898931dcd82a559\" value_size:692 lease:7371157456136564007 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-01T01:23:30.583381Z","caller":"traceutil/trace.go:171","msg":"trace[496589425] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"675.394472ms","start":"2026-03-01T01:23:29.907974Z","end":"2026-03-01T01:23:30.583369Z","steps":["trace[496589425] 'process raft request'  (duration: 675.347681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:30.583436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:29.90795Z","time spent":"675.455233ms","remote":"127.0.0.1:59270","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:916 > 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-03-01T01:23:30.583575Z","caller":"traceutil/trace.go:171","msg":"trace[913444482] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"998.978532ms","start":"2026-03-01T01:23:29.584589Z","end":"2026-03-01T01:23:30.583567Z","steps":["trace[913444482] 'process raft request'  (duration: 193.592991ms)","trace[913444482] 'compare'  (duration: 804.841598ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:23:30.58361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:29.584572Z","time spent":"999.024944ms","remote":"127.0.0.1:59096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":772,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/rbd-csi-ceph-com.1898931dcd82a559\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/rbd-csi-ceph-com.1898931dcd82a559\" value_size:692 lease:7371157456136564007 >> failure:<>"}
{"level":"info","ts":"2026-03-01T01:23:30.583776Z","caller":"traceutil/trace.go:171","msg":"trace[545320223] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"964.575534ms","start":"2026-03-01T01:23:29.619193Z","end":"2026-03-01T01:23:30.583769Z","steps":["trace[545320223] 'process raft request'  (duration: 964.060582ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:30.583818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:29.619175Z","time spent":"964.622367ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:966 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:406 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"info","ts":"2026-03-01T01:23:30.583882Z","caller":"traceutil/trace.go:171","msg":"trace[718725358] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"963.779057ms","start":"2026-03-01T01:23:29.620065Z","end":"2026-03-01T01:23:30.583844Z","steps":["trace[718725358] 'process raft request'  (duration: 963.229553ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:30.583887Z","caller":"traceutil/trace.go:171","msg":"trace[231616788] linearizableReadLoop","detail":"{readStateIndex:1005; appliedIndex:1002; }","duration":"828.713453ms","start":"2026-03-01T01:23:29.755141Z","end":"2026-03-01T01:23:30.583855Z","steps":["trace[231616788] 'read index received'  (duration: 23.043824ms)","trace[231616788] 'applied index is now lower than readState.Index'  (duration: 805.666809ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:23:30.584014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"828.869137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-01T01:23:30.584019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:29.619215Z","time spent":"964.732419ms","remote":"127.0.0.1:59096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":835,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tgnbh.1898931dcc650792\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-69cb97fb6-tgnbh.1898931dcc650792\" value_size:731 lease:7371157456136564007 >> failure:<>"}
{"level":"info","ts":"2026-03-01T01:23:30.584036Z","caller":"traceutil/trace.go:171","msg":"trace[1003029614] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:971; }","duration":"828.920228ms","start":"2026-03-01T01:23:29.75511Z","end":"2026-03-01T01:23:30.58403Z","steps":["trace[1003029614] 'agreement among raft nodes before linearized reading'  (duration: 828.876497ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:30.58406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:29.755094Z","time spent":"828.961439ms","remote":"127.0.0.1:59364","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":14,"response size":31,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T01:23:31.015037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.728344ms","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991340371 > lease_revoke:<id:664b9ca6fc7deebd>","response":"size:29"}
{"level":"info","ts":"2026-03-01T01:23:31.015149Z","caller":"traceutil/trace.go:171","msg":"trace[1678326665] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"431.1734ms","start":"2026-03-01T01:23:30.583957Z","end":"2026-03-01T01:23:31.015131Z","steps":["trace[1678326665] 'read index received'  (duration: 205.286612ms)","trace[1678326665] 'applied index is now lower than readState.Index'  (duration: 225.883088ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:23:31.015271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.058774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:23:31.015349Z","caller":"traceutil/trace.go:171","msg":"trace[1978798583] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:971; }","duration":"643.209387ms","start":"2026-03-01T01:23:30.372121Z","end":"2026-03-01T01:23:31.015331Z","steps":["trace[1978798583] 'agreement among raft nodes before linearized reading'  (duration: 643.079424ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:31.015383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.024524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-03-01T01:23:31.015393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:30.3721Z","time spent":"643.284859ms","remote":"127.0.0.1:59016","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-03-01T01:23:31.015429Z","caller":"traceutil/trace.go:171","msg":"trace[459605272] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:971; }","duration":"229.116407ms","start":"2026-03-01T01:23:30.786301Z","end":"2026-03-01T01:23:31.015418Z","steps":["trace[459605272] 'agreement among raft nodes before linearized reading'  (duration: 229.028805ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:31.015969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.620741ms","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-03-01T01:23:31.016012Z","caller":"traceutil/trace.go:171","msg":"trace[884326256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:971; }","duration":"352.691393ms","start":"2026-03-01T01:23:30.663308Z","end":"2026-03-01T01:23:31.015999Z","steps":["trace[884326256] 'agreement among raft nodes before linearized reading'  (duration: 351.911594ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:31.016041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:30.663291Z","time spent":"352.743113ms","remote":"127.0.0.1:59270","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":"info","ts":"2026-03-01T01:23:31.219667Z","caller":"traceutil/trace.go:171","msg":"trace[1386412690] linearizableReadLoop","detail":"{readStateIndex:1009; appliedIndex:1007; }","duration":"191.233324ms","start":"2026-03-01T01:23:31.028412Z","end":"2026-03-01T01:23:31.219645Z","steps":["trace[1386412690] 'read index received'  (duration: 57.826633ms)","trace[1386412690] 'applied index is now lower than readState.Index'  (duration: 133.405541ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:23:31.219735Z","caller":"traceutil/trace.go:171","msg":"trace[1971657921] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"200.217421ms","start":"2026-03-01T01:23:31.019479Z","end":"2026-03-01T01:23:31.219696Z","steps":["trace[1971657921] 'process raft request'  (duration: 200.006215ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:31.219894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.45836ms","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-03-01T01:23:31.219928Z","caller":"traceutil/trace.go:171","msg":"trace[2128814668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:973; }","duration":"191.530182ms","start":"2026-03-01T01:23:31.028388Z","end":"2026-03-01T01:23:31.219919Z","steps":["trace[2128814668] 'agreement among raft nodes before linearized reading'  (duration: 191.384969ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:31.219965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.472497ms","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-03-01T01:23:31.220023Z","caller":"traceutil/trace.go:171","msg":"trace[1249032774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:973; }","duration":"146.58175ms","start":"2026-03-01T01:23:31.073426Z","end":"2026-03-01T01:23:31.220008Z","steps":["trace[1249032774] 'agreement among raft nodes before linearized reading'  (duration: 146.388395ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:31.346263Z","caller":"traceutil/trace.go:171","msg":"trace[283034698] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"121.318512ms","start":"2026-03-01T01:23:31.224919Z","end":"2026-03-01T01:23:31.346237Z","steps":["trace[283034698] 'process raft request'  (duration: 74.990446ms)","trace[283034698] 'compare'  (duration: 46.158932ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:23:31.3464Z","caller":"traceutil/trace.go:171","msg":"trace[1731943778] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"121.097286ms","start":"2026-03-01T01:23:31.225286Z","end":"2026-03-01T01:23:31.346383Z","steps":["trace[1731943778] 'process raft request'  (duration: 120.903882ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:33.290393Z","caller":"traceutil/trace.go:171","msg":"trace[2127707252] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"196.943892ms","start":"2026-03-01T01:23:33.093424Z","end":"2026-03-01T01:23:33.290368Z","steps":["trace[2127707252] 'process raft request'  (duration: 196.756848ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:33.487425Z","caller":"traceutil/trace.go:171","msg":"trace[1702278619] linearizableReadLoop","detail":"{readStateIndex:1015; appliedIndex:1014; }","duration":"136.568588ms","start":"2026-03-01T01:23:33.350839Z","end":"2026-03-01T01:23:33.487408Z","steps":["trace[1702278619] 'read index received'  (duration: 136.437905ms)","trace[1702278619] 'applied index is now lower than readState.Index'  (duration: 130.143µs)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:23:33.487501Z","caller":"traceutil/trace.go:171","msg":"trace[847437748] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"191.257905ms","start":"2026-03-01T01:23:33.296211Z","end":"2026-03-01T01:23:33.487469Z","steps":["trace[847437748] 'process raft request'  (duration: 191.104861ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:33.487628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.772733ms","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-03-01T01:23:33.487648Z","caller":"traceutil/trace.go:171","msg":"trace[1876917099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:979; }","duration":"136.841505ms","start":"2026-03-01T01:23:33.350801Z","end":"2026-03-01T01:23:33.487642Z","steps":["trace[1876917099] 'agreement among raft nodes before linearized reading'  (duration: 136.687681ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:33.487703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.297722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:23:33.487803Z","caller":"traceutil/trace.go:171","msg":"trace[1953039474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"114.437455ms","start":"2026-03-01T01:23:33.373342Z","end":"2026-03-01T01:23:33.48778Z","steps":["trace[1953039474] 'agreement among raft nodes before linearized reading'  (duration: 114.257161ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:33.487715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.6223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-03-01T01:23:33.487883Z","caller":"traceutil/trace.go:171","msg":"trace[1694861847] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:979; }","duration":"136.838745ms","start":"2026-03-01T01:23:33.35103Z","end":"2026-03-01T01:23:33.487869Z","steps":["trace[1694861847] 'agreement among raft nodes before linearized reading'  (duration: 136.520577ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:33.636962Z","caller":"traceutil/trace.go:171","msg":"trace[632337634] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"144.236412ms","start":"2026-03-01T01:23:33.492696Z","end":"2026-03-01T01:23:33.636933Z","steps":["trace[632337634] 'process raft request'  (duration: 144.179611ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:33.637123Z","caller":"traceutil/trace.go:171","msg":"trace[1206297487] transaction","detail":"{read_only:false; response_revision:980; number_of_response:1; }","duration":"145.455831ms","start":"2026-03-01T01:23:33.491648Z","end":"2026-03-01T01:23:33.637104Z","steps":["trace[1206297487] 'process raft request'  (duration: 143.554776ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:37.572713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.38344345s","expected-duration":"100ms","prefix":"","request":"header:<ID:16594529492991340441 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-01T01:23:37.572776Z","caller":"traceutil/trace.go:171","msg":"trace[2141554756] linearizableReadLoop","detail":"{readStateIndex:1041; appliedIndex:1040; }","duration":"1.47025766s","start":"2026-03-01T01:23:36.102508Z","end":"2026-03-01T01:23:37.572766Z","steps":["trace[2141554756] 'read index received'  (duration: 86.656096ms)","trace[2141554756] 'applied index is now lower than readState.Index'  (duration: 1.383600714s)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:23:37.572913Z","caller":"traceutil/trace.go:171","msg":"trace[139847901] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"1.473503408s","start":"2026-03-01T01:23:36.099403Z","end":"2026-03-01T01:23:37.572906Z","steps":["trace[139847901] 'process raft request'  (duration: 89.809252ms)","trace[139847901] 'compare'  (duration: 1.383160763s)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:23:37.572943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:36.099388Z","time spent":"1.4735397s","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:946 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:599 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"warn","ts":"2026-03-01T01:23:37.573113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.729552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:23:37.573129Z","caller":"traceutil/trace.go:171","msg":"trace[363904528] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1003; }","duration":"521.781903ms","start":"2026-03-01T01:23:37.051343Z","end":"2026-03-01T01:23:37.573125Z","steps":["trace[363904528] 'agreement among raft nodes before linearized reading'  (duration: 521.748762ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:37.573143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:37.051325Z","time spent":"521.815045ms","remote":"127.0.0.1:59302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T01:23:37.573116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201130309s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-03-01T01:23:37.573134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.758415ms","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-03-01T01:23:37.573181Z","caller":"traceutil/trace.go:171","msg":"trace[1827901145] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1003; }","duration":"166.832396ms","start":"2026-03-01T01:23:37.406337Z","end":"2026-03-01T01:23:37.57317Z","steps":["trace[1827901145] 'agreement among raft nodes before linearized reading'  (duration: 166.697903ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:37.573186Z","caller":"traceutil/trace.go:171","msg":"trace[804700191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"1.201243812s","start":"2026-03-01T01:23:36.371922Z","end":"2026-03-01T01:23:37.573165Z","steps":["trace[804700191] 'agreement among raft nodes before linearized reading'  (duration: 1.201108819s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:37.573224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:36.371901Z","time spent":"1.201315294s","remote":"127.0.0.1:59016","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-03-01T01:23:37.57326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.657184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-01T01:23:37.573268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.470758283s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-01T01:23:37.573277Z","caller":"traceutil/trace.go:171","msg":"trace[1489515630] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1003; }","duration":"171.707796ms","start":"2026-03-01T01:23:37.401563Z","end":"2026-03-01T01:23:37.573271Z","steps":["trace[1489515630] 'agreement among raft nodes before linearized reading'  (duration: 171.642873ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:23:37.573281Z","caller":"traceutil/trace.go:171","msg":"trace[1645109646] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1003; }","duration":"1.470774053s","start":"2026-03-01T01:23:36.102503Z","end":"2026-03-01T01:23:37.573277Z","steps":["trace[1645109646] 'agreement among raft nodes before linearized reading'  (duration: 1.470747872s)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:37.573295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:36.102462Z","time spent":"1.470828605s","remote":"127.0.0.1:59426","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T01:23:37.573428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.119846ms","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-03-01T01:23:37.573442Z","caller":"traceutil/trace.go:171","msg":"trace[1627449022] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1003; }","duration":"572.135577ms","start":"2026-03-01T01:23:37.001303Z","end":"2026-03-01T01:23:37.573439Z","steps":["trace[1627449022] 'agreement among raft nodes before linearized reading'  (duration: 572.110876ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:23:37.573465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-01T01:23:37.001237Z","time spent":"572.224268ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":4,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "}
{"level":"warn","ts":"2026-03-01T01:26:16.493183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.072383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:534"}
{"level":"info","ts":"2026-03-01T01:26:16.493277Z","caller":"traceutil/trace.go:171","msg":"trace[1803418243] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1671; }","duration":"147.211437ms","start":"2026-03-01T01:26:16.346044Z","end":"2026-03-01T01:26:16.493255Z","steps":["trace[1803418243] 'range keys from in-memory index tree'  (duration: 146.856489ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:26:16.493387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.191189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"}
{"level":"info","ts":"2026-03-01T01:26:16.493457Z","caller":"traceutil/trace.go:171","msg":"trace[521741669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1671; }","duration":"129.28114ms","start":"2026-03-01T01:26:16.364162Z","end":"2026-03-01T01:26:16.493443Z","steps":["trace[521741669] 'range keys from in-memory index tree'  (duration: 129.008814ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:26:16.493203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.017764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-03-01T01:26:16.49363Z","caller":"traceutil/trace.go:171","msg":"trace[108784921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1671; }","duration":"129.464215ms","start":"2026-03-01T01:26:16.364133Z","end":"2026-03-01T01:26:16.493597Z","steps":["trace[108784921] 'range keys from in-memory index tree'  (duration: 128.87739ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:26:44.698751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.574462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-03-01T01:26:44.698803Z","caller":"traceutil/trace.go:171","msg":"trace[1353497463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1815; }","duration":"289.664565ms","start":"2026-03-01T01:26:44.409128Z","end":"2026-03-01T01:26:44.698792Z","steps":["trace[1353497463] 'range keys from in-memory index tree'  (duration: 289.501251ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:26:44.920172Z","caller":"traceutil/trace.go:171","msg":"trace[616536065] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"217.040161ms","start":"2026-03-01T01:26:44.703111Z","end":"2026-03-01T01:26:44.920151Z","steps":["trace[616536065] 'process raft request'  (duration: 216.981089ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:26:44.920263Z","caller":"traceutil/trace.go:171","msg":"trace[118569587] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"217.134763ms","start":"2026-03-01T01:26:44.70305Z","end":"2026-03-01T01:26:44.920185Z","steps":["trace[118569587] 'process raft request'  (duration: 134.279175ms)","trace[118569587] 'compare'  (duration: 82.649293ms)"],"step_count":2}
{"level":"info","ts":"2026-03-01T01:26:44.920491Z","caller":"traceutil/trace.go:171","msg":"trace[278176978] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"217.290367ms","start":"2026-03-01T01:26:44.703164Z","end":"2026-03-01T01:26:44.920455Z","steps":["trace[278176978] 'process raft request'  (duration: 216.959419ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:26:44.920519Z","caller":"traceutil/trace.go:171","msg":"trace[1814091583] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"215.592457ms","start":"2026-03-01T01:26:44.704899Z","end":"2026-03-01T01:26:44.920491Z","steps":["trace[1814091583] 'process raft request'  (duration: 215.477494ms)"],"step_count":1}
{"level":"info","ts":"2026-03-01T01:26:45.326573Z","caller":"traceutil/trace.go:171","msg":"trace[249055451] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1897; }","duration":"248.594764ms","start":"2026-03-01T01:26:45.07795Z","end":"2026-03-01T01:26:45.326545Z","steps":["trace[249055451] 'read index received'  (duration: 243.936893ms)","trace[249055451] 'applied index is now lower than readState.Index'  (duration: 4.656131ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-01T01:26:45.326797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.148187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:26:45.326872Z","caller":"traceutil/trace.go:171","msg":"trace[835734586] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1821; }","duration":"169.26786ms","start":"2026-03-01T01:26:45.157584Z","end":"2026-03-01T01:26:45.326852Z","steps":["trace[835734586] 'agreement among raft nodes before linearized reading'  (duration: 169.132337ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-01T01:26:45.327007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.029964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-01T01:26:45.327091Z","caller":"traceutil/trace.go:171","msg":"trace[1492564144] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1821; }","duration":"249.146277ms","start":"2026-03-01T01:26:45.077925Z","end":"2026-03-01T01:26:45.327071Z","steps":["trace[1492564144] 'agreement among raft nodes before linearized reading'  (duration: 249.000993ms)"],"step_count":1}