{"level":"warn","ts":"2026-08-04T21:35:59.275605Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:59.275727Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.142:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.142:2380","--initial-cluster=instance=https://199.19.213.142:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.142:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.142: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-08-04T21:35:59.275936Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-04T21:35:59.275959Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.142:2380"]} {"level":"info","ts":"2026-08-04T21:35:59.27599Z","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-08-04T21:35:59.277277Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.142:2379"]} {"level":"info","ts":"2026-08-04T21:35:59.277389Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.142:2380"],"listen-peer-urls":["https://199.19.213.142:2380"],"advertise-client-urls":["https://199.19.213.142:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.142:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.142: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-08-04T21:35:59.280556Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.881619ms"} {"level":"info","ts":"2026-08-04T21:35:59.290683Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"54fca804e66e40f4","cluster-id":"374317481b3c77b9"} {"level":"info","ts":"2026-08-04T21:35:59.290814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 switched to configuration voters=()"} {"level":"info","ts":"2026-08-04T21:35:59.290857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 became follower at term 0"} {"level":"info","ts":"2026-08-04T21:35:59.290886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 54fca804e66e40f4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-04T21:35:59.290905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 became follower at term 1"} {"level":"info","ts":"2026-08-04T21:35:59.290976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 switched to configuration voters=(6123954332316352756)"} {"level":"warn","ts":"2026-08-04T21:35:59.298635Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-04T21:35:59.299723Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-04T21:35:59.300563Z","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-08-04T21:35:59.302431Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"54fca804e66e40f4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-04T21:35:59.303267Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"54fca804e66e40f4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-04T21:35:59.303473Z","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-08-04T21:35:59.303541Z","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-08-04T21:35:59.303985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 switched to configuration voters=(6123954332316352756)"} {"level":"info","ts":"2026-08-04T21:35:59.304133Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"374317481b3c77b9","local-member-id":"54fca804e66e40f4","added-peer-id":"54fca804e66e40f4","added-peer-peer-urls":["https://199.19.213.142:2380"]} {"level":"info","ts":"2026-08-04T21:35:59.304184Z","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-08-04T21:35:59.307978Z","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-08-04T21:35:59.308176Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.142:2380"} {"level":"info","ts":"2026-08-04T21:35:59.308241Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.142:2380"} {"level":"info","ts":"2026-08-04T21:35:59.308414Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"54fca804e66e40f4","initial-advertise-peer-urls":["https://199.19.213.142:2380"],"listen-peer-urls":["https://199.19.213.142:2380"],"advertise-client-urls":["https://199.19.213.142:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.142:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-04T21:35:59.308499Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-04T21:36:00.29179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 is starting a new election at term 1"} {"level":"info","ts":"2026-08-04T21:36:00.291849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-04T21:36:00.291867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 received MsgPreVoteResp from 54fca804e66e40f4 at term 1"} {"level":"info","ts":"2026-08-04T21:36:00.291878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 became candidate at term 2"} {"level":"info","ts":"2026-08-04T21:36:00.291941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 received MsgVoteResp from 54fca804e66e40f4 at term 2"} {"level":"info","ts":"2026-08-04T21:36:00.291952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"54fca804e66e40f4 became leader at term 2"} {"level":"info","ts":"2026-08-04T21:36:00.291962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 54fca804e66e40f4 elected leader 54fca804e66e40f4 at term 2"} {"level":"info","ts":"2026-08-04T21:36:00.301286Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"54fca804e66e40f4","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.142:2379]}","request-path":"/0/members/54fca804e66e40f4/attributes","cluster-id":"374317481b3c77b9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-04T21:36:00.30142Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:36:00.301453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-04T21:36:00.301638Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:36:00.30188Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-04T21:36:00.301971Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-04T21:36:00.303127Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.142:2379"} {"level":"info","ts":"2026-08-04T21:36:00.30449Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-04T21:36:00.308Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"374317481b3c77b9","local-member-id":"54fca804e66e40f4","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:36:00.308123Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:36:00.308155Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-04T21:36:03.860251Z","caller":"traceutil/trace.go:171","msg":"trace[1651090225] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"412.78774ms","start":"2026-08-04T21:36:03.447423Z","end":"2026-08-04T21:36:03.860211Z","steps":["trace[1651090225] 'process raft request' (duration: 391.882939ms)","trace[1651090225] 'compare' (duration: 20.505152ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:03.861542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:03.447405Z","time spent":"413.636521ms","remote":"127.0.0.1:44240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1342,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:04.41089Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4680541622884056304,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T21:36:04.912175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4680541622884056304,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-04T21:36:04.945948Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.038990742s","expected-duration":"1s"} {"level":"info","ts":"2026-08-04T21:36:04.946394Z","caller":"traceutil/trace.go:171","msg":"trace[1300825775] linearizableReadLoop","detail":"{readStateIndex:208; appliedIndex:206; }","duration":"1.035927129s","start":"2026-08-04T21:36:03.910443Z","end":"2026-08-04T21:36:04.94637Z","steps":["trace[1300825775] 'read index received' (duration: 1.035714944s)","trace[1300825775] 'applied index is now lower than readState.Index' (duration: 211.125µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:36:04.946516Z","caller":"traceutil/trace.go:171","msg":"trace[402727429] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"1.051731308s","start":"2026-08-04T21:36:03.89474Z","end":"2026-08-04T21:36:04.946471Z","steps":["trace[402727429] 'process raft request' (duration: 1.051594124s)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:04.946553Z","caller":"traceutil/trace.go:171","msg":"trace[1484343529] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"1.080553149s","start":"2026-08-04T21:36:03.865949Z","end":"2026-08-04T21:36:04.946503Z","steps":["trace[1484343529] 'process raft request' (duration: 1.080264892s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:04.9466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036166075s","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-08-04T21:36:04.946689Z","caller":"traceutil/trace.go:171","msg":"trace[453068365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:203; }","duration":"1.036303688s","start":"2026-08-04T21:36:03.910371Z","end":"2026-08-04T21:36:04.946675Z","steps":["trace[453068365] 'agreement among raft nodes before linearized reading' (duration: 1.036132813s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:04.946703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:03.865922Z","time spent":"1.080701222s","remote":"127.0.0.1:44480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":330,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:04.946696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:03.894715Z","time spent":"1.051885982s","remote":"127.0.0.1:44314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:04.946723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:03.910321Z","time spent":"1.03639268s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:36:04.946785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.989538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:36:04.946884Z","caller":"traceutil/trace.go:171","msg":"trace[509307097] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:203; }","duration":"298.153962ms","start":"2026-08-04T21:36:04.648696Z","end":"2026-08-04T21:36:04.946857Z","steps":["trace[509307097] 'agreement among raft nodes before linearized reading' (duration: 297.866175ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.042986Z","caller":"traceutil/trace.go:171","msg":"trace[1805151470] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"248.637444ms","start":"2026-08-04T21:36:38.794325Z","end":"2026-08-04T21:36:39.042962Z","steps":["trace[1805151470] 'process raft request' (duration: 248.482221ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.158012Z","caller":"traceutil/trace.go:171","msg":"trace[415416575] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"344.961945ms","start":"2026-08-04T21:36:38.813013Z","end":"2026-08-04T21:36:39.157975Z","steps":["trace[415416575] 'process raft request' (duration: 344.706978ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.15836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.812987Z","time spent":"345.254842ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.15856Z","caller":"traceutil/trace.go:171","msg":"trace[1180704748] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"328.241523ms","start":"2026-08-04T21:36:38.83031Z","end":"2026-08-04T21:36:39.158552Z","steps":["trace[1180704748] 'process raft request' (duration: 327.771482ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.158554Z","caller":"traceutil/trace.go:171","msg":"trace[92996581] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"331.789849ms","start":"2026-08-04T21:36:38.826663Z","end":"2026-08-04T21:36:39.158452Z","steps":["trace[92996581] 'process raft request' (duration: 331.355669ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.158643Z","caller":"traceutil/trace.go:171","msg":"trace[1637646224] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"208.761998ms","start":"2026-08-04T21:36:38.949862Z","end":"2026-08-04T21:36:39.158624Z","steps":["trace[1637646224] 'process raft request' (duration: 208.699297ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.158685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.830298Z","time spent":"328.311646ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158608Z","caller":"traceutil/trace.go:171","msg":"trace[1937693182] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"335.887817ms","start":"2026-08-04T21:36:38.822527Z","end":"2026-08-04T21:36:39.158415Z","steps":["trace[1937693182] 'process raft request' (duration: 335.363465ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.158793Z","caller":"traceutil/trace.go:171","msg":"trace[1312468580] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"319.388131ms","start":"2026-08-04T21:36:38.839396Z","end":"2026-08-04T21:36:39.158784Z","steps":["trace[1312468580] 'process raft request' (duration: 318.883889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.158784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.826645Z","time spent":"332.040545ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158808Z","caller":"traceutil/trace.go:171","msg":"trace[93236297] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"304.7602ms","start":"2026-08-04T21:36:38.854036Z","end":"2026-08-04T21:36:39.158796Z","steps":["trace[93236297] 'process raft request' (duration: 304.31243ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.158857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.854019Z","time spent":"304.817312ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:39.15886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.839385Z","time spent":"319.439243ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158474Z","caller":"traceutil/trace.go:171","msg":"trace[889266574] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"331.890181ms","start":"2026-08-04T21:36:38.826574Z","end":"2026-08-04T21:36:39.158464Z","steps":["trace[889266574] 'process raft request' (duration: 331.393769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.159017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.826564Z","time spent":"332.371483ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:39.159035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.82251Z","time spent":"336.274996ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158374Z","caller":"traceutil/trace.go:171","msg":"trace[1670801942] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"335.436256ms","start":"2026-08-04T21:36:38.82291Z","end":"2026-08-04T21:36:39.158346Z","steps":["trace[1670801942] 'process raft request' (duration: 335.018726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.159137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.822893Z","time spent":"336.214785ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158391Z","caller":"traceutil/trace.go:171","msg":"trace[1590892280] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"339.867942ms","start":"2026-08-04T21:36:38.818474Z","end":"2026-08-04T21:36:39.158342Z","steps":["trace[1590892280] 'process raft request' (duration: 339.373501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.159289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.818465Z","time spent":"340.771504ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.158523Z","caller":"traceutil/trace.go:171","msg":"trace[1445976134] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"322.875744ms","start":"2026-08-04T21:36:38.835634Z","end":"2026-08-04T21:36:39.15851Z","steps":["trace[1445976134] 'process raft request' (duration: 322.519246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:39.159384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:38.835625Z","time spent":"323.722345ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:36:39.160684Z","caller":"traceutil/trace.go:171","msg":"trace[1762554828] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"111.039724ms","start":"2026-08-04T21:36:39.049625Z","end":"2026-08-04T21:36:39.160665Z","steps":["trace[1762554828] 'process raft request' (duration: 110.543132ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.160841Z","caller":"traceutil/trace.go:171","msg":"trace[451681311] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"111.103375ms","start":"2026-08-04T21:36:39.049727Z","end":"2026-08-04T21:36:39.160831Z","steps":["trace[451681311] 'process raft request' (duration: 110.535611ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:39.160928Z","caller":"traceutil/trace.go:171","msg":"trace[1681937798] transaction","detail":"{read_only:false; number_of_response:1; response_revision:540; }","duration":"110.278215ms","start":"2026-08-04T21:36:39.050642Z","end":"2026-08-04T21:36:39.16092Z","steps":["trace[1681937798] 'process raft request' (duration: 109.677161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:41.331922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.465712ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:36:41.332042Z","caller":"traceutil/trace.go:171","msg":"trace[714016627] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"143.321698ms","start":"2026-08-04T21:36:41.188705Z","end":"2026-08-04T21:36:41.332027Z","steps":["trace[714016627] 'read index received' (duration: 39.041µs)","trace[714016627] 'applied index is now lower than readState.Index' (duration: 143.281627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:41.332214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.217556ms","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-08-04T21:36:41.332252Z","caller":"traceutil/trace.go:171","msg":"trace[1496142568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"108.293818ms","start":"2026-08-04T21:36:41.223948Z","end":"2026-08-04T21:36:41.332242Z","steps":["trace[1496142568] 'agreement among raft nodes before linearized reading' (duration: 108.165195ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:41.332243Z","caller":"traceutil/trace.go:171","msg":"trace[922056577] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"461.737995ms","start":"2026-08-04T21:36:40.870478Z","end":"2026-08-04T21:36:41.332216Z","steps":["trace[922056577] 'process raft request' (duration: 209.621788ms)","trace[922056577] 'compare' (duration: 251.285677ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:41.332463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:40.870459Z","time spent":"461.90447ms","remote":"127.0.0.1:44202","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:36:41.332729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.022334ms","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-08-04T21:36:41.332783Z","caller":"traceutil/trace.go:171","msg":"trace[1620590792] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:604; }","duration":"144.107117ms","start":"2026-08-04T21:36:41.188662Z","end":"2026-08-04T21:36:41.33277Z","steps":["trace[1620590792] 'agreement among raft nodes before linearized reading' (duration: 143.42593ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:45.223818Z","caller":"traceutil/trace.go:171","msg":"trace[1527969717] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"291.237766ms","start":"2026-08-04T21:36:44.932553Z","end":"2026-08-04T21:36:45.22379Z","steps":["trace[1527969717] 'process raft request' (duration: 289.73421ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:46.775728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.189153694s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:36:46.775896Z","caller":"traceutil/trace.go:171","msg":"trace[344840325] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"1.356695302s","start":"2026-08-04T21:36:45.419177Z","end":"2026-08-04T21:36:46.775872Z","steps":["trace[344840325] 'read index received' (duration: 167.258382ms)","trace[344840325] 'applied index is now lower than readState.Index' (duration: 1.18943525s)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:36:46.775946Z","caller":"traceutil/trace.go:171","msg":"trace[1037917398] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.495937103s","start":"2026-08-04T21:36:45.279951Z","end":"2026-08-04T21:36:46.775888Z","steps":["trace[1037917398] 'process raft request' (duration: 306.496913ms)","trace[1037917398] 'compare' (duration: 1.188099058s)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:36:46.776106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.279921Z","time spent":"1.496100896s","remote":"127.0.0.1:44342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:36:46.776236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.357055341s","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-08-04T21:36:46.776459Z","caller":"traceutil/trace.go:171","msg":"trace[2137515716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:624; }","duration":"1.357176114s","start":"2026-08-04T21:36:45.419086Z","end":"2026-08-04T21:36:46.776262Z","steps":["trace[2137515716] 'agreement among raft nodes before linearized reading' (duration: 1.356913087s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:46.776507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.083694163s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-04T21:36:46.776511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.419035Z","time spent":"1.35746578s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-04T21:36:46.776535Z","caller":"traceutil/trace.go:171","msg":"trace[694420277] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"1.083757595s","start":"2026-08-04T21:36:45.692769Z","end":"2026-08-04T21:36:46.776527Z","steps":["trace[694420277] 'agreement among raft nodes before linearized reading' (duration: 1.083450578s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:46.776517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100300642s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T21:36:46.776561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.692751Z","time spent":"1.083805697s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:36:46.776674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060376474s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hdf4b\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-08-04T21:36:46.776717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295869553s","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-08-04T21:36:46.776752Z","caller":"traceutil/trace.go:171","msg":"trace[1673727052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"1.295924294s","start":"2026-08-04T21:36:45.480817Z","end":"2026-08-04T21:36:46.776741Z","steps":["trace[1673727052] 'agreement among raft nodes before linearized reading' (duration: 1.295832112s)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:46.776759Z","caller":"traceutil/trace.go:171","msg":"trace[990532500] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hdf4b; range_end:; response_count:1; response_revision:624; }","duration":"1.060567289s","start":"2026-08-04T21:36:45.716169Z","end":"2026-08-04T21:36:46.776736Z","steps":["trace[990532500] 'agreement among raft nodes before linearized reading' (duration: 1.060412455s)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:46.776595Z","caller":"traceutil/trace.go:171","msg":"trace[323501657] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.100406374s","start":"2026-08-04T21:36:45.676165Z","end":"2026-08-04T21:36:46.776571Z","steps":["trace[323501657] 'agreement among raft nodes before linearized reading' (duration: 1.100305632s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:46.77679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.480804Z","time spent":"1.295979475s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:36:46.776804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.716129Z","time spent":"1.060665661s","remote":"127.0.0.1:44314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-hdf4b\" "} {"level":"warn","ts":"2026-08-04T21:36:46.776824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.676139Z","time spent":"1.100672081s","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-04T21:36:46.777192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.355528054s","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-08-04T21:36:46.777266Z","caller":"traceutil/trace.go:171","msg":"trace[1335705463] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"1.35661477s","start":"2026-08-04T21:36:45.420634Z","end":"2026-08-04T21:36:46.777249Z","steps":["trace[1335705463] 'agreement among raft nodes before linearized reading' (duration: 1.355389151s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:36:46.77731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:36:45.420606Z","time spent":"1.356693603s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T21:36:48.290076Z","caller":"traceutil/trace.go:171","msg":"trace[225423624] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"290.257452ms","start":"2026-08-04T21:36:47.999793Z","end":"2026-08-04T21:36:48.29005Z","steps":["trace[225423624] 'process raft request' (duration: 290.047447ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:36:48.305608Z","caller":"traceutil/trace.go:171","msg":"trace[1299712235] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"136.29802ms","start":"2026-08-04T21:36:48.16929Z","end":"2026-08-04T21:36:48.305588Z","steps":["trace[1299712235] 'process raft request' (duration: 135.846999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:02.776879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.189486ms","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-08-04T21:37:02.776972Z","caller":"traceutil/trace.go:171","msg":"trace[874044250] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"386.343399ms","start":"2026-08-04T21:37:02.390611Z","end":"2026-08-04T21:37:02.776955Z","steps":["trace[874044250] 'range keys from in-memory index tree' (duration: 385.684754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:02.777031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:02.390581Z","time spent":"386.426542ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-04T21:37:07.09488Z","caller":"traceutil/trace.go:171","msg":"trace[1582994439] transaction","detail":"{read_only:false; response_revision:857; number_of_response:1; }","duration":"164.550392ms","start":"2026-08-04T21:37:06.930308Z","end":"2026-08-04T21:37:07.094858Z","steps":["trace[1582994439] 'process raft request' (duration: 164.234184ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:07.095405Z","caller":"traceutil/trace.go:171","msg":"trace[1203267364] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"165.054824ms","start":"2026-08-04T21:37:06.93031Z","end":"2026-08-04T21:37:07.095364Z","steps":["trace[1203267364] 'process raft request' (duration: 164.415859ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:07.095794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.246149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/envoy-oidc-hmac\" ","response":"range_response_count:1 size:452"} {"level":"info","ts":"2026-08-04T21:37:07.09587Z","caller":"traceutil/trace.go:171","msg":"trace[152055906] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/envoy-oidc-hmac; range_end:; response_count:1; response_revision:858; }","duration":"165.331452ms","start":"2026-08-04T21:37:06.930504Z","end":"2026-08-04T21:37:07.095835Z","steps":["trace[152055906] 'agreement among raft nodes before linearized reading' (duration: 164.949792ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:07.095261Z","caller":"traceutil/trace.go:171","msg":"trace[1548309776] linearizableReadLoop","detail":"{readStateIndex:891; appliedIndex:887; }","duration":"164.424249ms","start":"2026-08-04T21:37:06.930526Z","end":"2026-08-04T21:37:07.09495Z","steps":["trace[1548309776] 'read index received' (duration: 84.193622ms)","trace[1548309776] 'applied index is now lower than readState.Index' (duration: 80.228377ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:37:07.095418Z","caller":"traceutil/trace.go:171","msg":"trace[629313102] transaction","detail":"{read_only:false; response_revision:856; number_of_response:1; }","duration":"164.384638ms","start":"2026-08-04T21:37:06.930263Z","end":"2026-08-04T21:37:07.094647Z","steps":["trace[629313102] 'process raft request' (duration: 114.646533ms)","trace[629313102] 'compare' (duration: 49.394647ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:37:07.097105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.525111ms","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-08-04T21:37:07.09805Z","caller":"traceutil/trace.go:171","msg":"trace[2102031251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:858; }","duration":"110.533395ms","start":"2026-08-04T21:37:06.987495Z","end":"2026-08-04T21:37:07.098028Z","steps":["trace[2102031251] 'agreement among raft nodes before linearized reading' (duration: 109.405858ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:35.068181Z","caller":"traceutil/trace.go:171","msg":"trace[900385862] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"111.324194ms","start":"2026-08-04T21:37:34.956817Z","end":"2026-08-04T21:37:35.068141Z","steps":["trace[900385862] 'process raft request' (duration: 111.074008ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:37.686947Z","caller":"traceutil/trace.go:171","msg":"trace[589619876] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"607.947323ms","start":"2026-08-04T21:37:37.078984Z","end":"2026-08-04T21:37:37.686932Z","steps":["trace[589619876] 'process raft request' (duration: 607.854391ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:37:37.686964Z","caller":"traceutil/trace.go:171","msg":"trace[247647680] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"495.201115ms","start":"2026-08-04T21:37:37.191728Z","end":"2026-08-04T21:37:37.68693Z","steps":["trace[247647680] 'read index received' (duration: 495.188545ms)","trace[247647680] 'applied index is now lower than readState.Index' (duration: 10.97µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:37:37.687069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:37.078951Z","time spent":"608.054865ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:37:37.687185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.452091ms","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-08-04T21:37:37.687282Z","caller":"traceutil/trace.go:171","msg":"trace[891684043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"495.595994ms","start":"2026-08-04T21:37:37.19167Z","end":"2026-08-04T21:37:37.687266Z","steps":["trace[891684043] 'agreement among raft nodes before linearized reading' (duration: 495.364769ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:37.687333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:37.191648Z","time spent":"495.673857ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:37:37.689125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.005141ms","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-08-04T21:37:37.689163Z","caller":"traceutil/trace.go:171","msg":"trace[490103631] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"210.578238ms","start":"2026-08-04T21:37:37.478571Z","end":"2026-08-04T21:37:37.68915Z","steps":["trace[490103631] 'process raft request' (duration: 210.181129ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:37.689354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.091623ms","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-08-04T21:37:37.689422Z","caller":"traceutil/trace.go:171","msg":"trace[1221148716] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"423.174265ms","start":"2026-08-04T21:37:37.266232Z","end":"2026-08-04T21:37:37.689406Z","steps":["trace[1221148716] 'agreement among raft nodes before linearized reading' (duration: 422.96537ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:37.689459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:37.266142Z","time spent":"423.311688ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:37:37.689354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.423253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-04T21:37:37.689598Z","caller":"traceutil/trace.go:171","msg":"trace[1078689712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1013; }","duration":"421.691649ms","start":"2026-08-04T21:37:37.267869Z","end":"2026-08-04T21:37:37.68956Z","steps":["trace[1078689712] 'agreement among raft nodes before linearized reading' (duration: 421.338511ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:37.689778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:37.267852Z","time spent":"421.861643ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T21:37:37.689215Z","caller":"traceutil/trace.go:171","msg":"trace[1433502110] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1013; }","duration":"433.100273ms","start":"2026-08-04T21:37:37.256089Z","end":"2026-08-04T21:37:37.689189Z","steps":["trace[1433502110] 'agreement among raft nodes before linearized reading' (duration: 432.811556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:37:37.689869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:37:37.256018Z","time spent":"433.83204ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-04T21:38:02.014854Z","caller":"traceutil/trace.go:171","msg":"trace[137573622] linearizableReadLoop","detail":"{readStateIndex:1136; appliedIndex:1135; }","duration":"180.040234ms","start":"2026-08-04T21:38:01.834775Z","end":"2026-08-04T21:38:02.014815Z","steps":["trace[137573622] 'read index received' (duration: 179.84565ms)","trace[137573622] 'applied index is now lower than readState.Index' (duration: 193.534µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:02.014914Z","caller":"traceutil/trace.go:171","msg":"trace[1146286207] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"216.995343ms","start":"2026-08-04T21:38:01.797875Z","end":"2026-08-04T21:38:02.01487Z","steps":["trace[1146286207] 'process raft request' (duration: 216.771287ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.015504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.70108ms","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-08-04T21:38:02.016099Z","caller":"traceutil/trace.go:171","msg":"trace[1488242890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1091; }","duration":"176.315485ms","start":"2026-08-04T21:38:01.839764Z","end":"2026-08-04T21:38:02.01608Z","steps":["trace[1488242890] 'agreement among raft nodes before linearized reading' (duration: 175.592317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.016078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.903462ms","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-08-04T21:38:02.016301Z","caller":"traceutil/trace.go:171","msg":"trace[1408634614] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1091; }","duration":"113.183279ms","start":"2026-08-04T21:38:01.903101Z","end":"2026-08-04T21:38:02.016284Z","steps":["trace[1408634614] 'agreement among raft nodes before linearized reading' (duration: 112.442591ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.015598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.712972ms","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-08-04T21:38:02.016412Z","caller":"traceutil/trace.go:171","msg":"trace[2024396631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1091; }","duration":"174.605094ms","start":"2026-08-04T21:38:01.84176Z","end":"2026-08-04T21:38:02.016365Z","steps":["trace[2024396631] 'agreement among raft nodes before linearized reading' (duration: 173.392784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.015996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.423274ms","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-08-04T21:38:02.016473Z","caller":"traceutil/trace.go:171","msg":"trace[1833778416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1091; }","duration":"181.769146ms","start":"2026-08-04T21:38:01.834693Z","end":"2026-08-04T21:38:02.016462Z","steps":["trace[1833778416] 'agreement among raft nodes before linearized reading' (duration: 180.303561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.016721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.102114ms","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-08-04T21:38:02.016964Z","caller":"traceutil/trace.go:171","msg":"trace[790213398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1091; }","duration":"177.35106ms","start":"2026-08-04T21:38:01.839476Z","end":"2026-08-04T21:38:02.016827Z","steps":["trace[790213398] 'agreement among raft nodes before linearized reading' (duration: 175.634088ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.756893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.224849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:02.756996Z","caller":"traceutil/trace.go:171","msg":"trace[1807279921] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"735.604889ms","start":"2026-08-04T21:38:02.021372Z","end":"2026-08-04T21:38:02.756977Z","steps":["trace[1807279921] 'process raft request' (duration: 433.219176ms)","trace[1807279921] 'compare' (duration: 302.116067ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:02.757054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.021348Z","time spent":"735.677631ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:02.99282Z","caller":"traceutil/trace.go:171","msg":"trace[1657003872] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"971.104236ms","start":"2026-08-04T21:38:02.021671Z","end":"2026-08-04T21:38:02.992776Z","steps":["trace[1657003872] 'process raft request' (duration: 970.763028ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:02.992876Z","caller":"traceutil/trace.go:171","msg":"trace[1039314627] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"970.961953ms","start":"2026-08-04T21:38:02.021877Z","end":"2026-08-04T21:38:02.992839Z","steps":["trace[1039314627] 'process raft request' (duration: 970.814129ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:02.993022Z","caller":"traceutil/trace.go:171","msg":"trace[88542191] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"971.30556ms","start":"2026-08-04T21:38:02.02169Z","end":"2026-08-04T21:38:02.992995Z","steps":["trace[88542191] 'process raft request' (duration: 970.923091ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.993042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.021864Z","time spent":"971.091056ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:02.993038Z","caller":"traceutil/trace.go:171","msg":"trace[592490992] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"967.762936ms","start":"2026-08-04T21:38:02.025245Z","end":"2026-08-04T21:38:02.993008Z","steps":["trace[592490992] 'process raft request' (duration: 967.492219ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:02.992807Z","caller":"traceutil/trace.go:171","msg":"trace[2103375647] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1136; }","duration":"557.073041ms","start":"2026-08-04T21:38:02.435704Z","end":"2026-08-04T21:38:02.992777Z","steps":["trace[2103375647] 'read index received' (duration: 18.897704ms)","trace[2103375647] 'applied index is now lower than readState.Index' (duration: 538.172627ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:02.993142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.021654Z","time spent":"971.424313ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:02.993189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.025214Z","time spent":"967.889009ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:02.993217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.366798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:02.993341Z","caller":"traceutil/trace.go:171","msg":"trace[91303721] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1096; }","duration":"557.680485ms","start":"2026-08-04T21:38:02.435648Z","end":"2026-08-04T21:38:02.993328Z","steps":["trace[91303721] 'agreement among raft nodes before linearized reading' (duration: 557.240965ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:02.993416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.43562Z","time spent":"557.780738ms","remote":"127.0.0.1:44440","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:38:02.993348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:02.021664Z","time spent":"971.26093ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:05.380178Z","caller":"traceutil/trace.go:171","msg":"trace[248563330] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"614.016674ms","start":"2026-08-04T21:38:04.765941Z","end":"2026-08-04T21:38:05.379957Z","steps":["trace[248563330] 'process raft request' (duration: 613.86464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.380335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.765917Z","time spent":"614.336382ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:05.948623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.551233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:05.948744Z","caller":"traceutil/trace.go:171","msg":"trace[1060087596] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1144; }","duration":"950.121056ms","start":"2026-08-04T21:38:04.998605Z","end":"2026-08-04T21:38:05.948726Z","steps":["trace[1060087596] 'read index received' (duration: 381.269087ms)","trace[1060087596] 'applied index is now lower than readState.Index' (duration: 568.850919ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:05.948784Z","caller":"traceutil/trace.go:171","msg":"trace[1880007175] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"993.884949ms","start":"2026-08-04T21:38:04.95487Z","end":"2026-08-04T21:38:05.948755Z","steps":["trace[1880007175] 'process raft request' (duration: 647.10803ms)","trace[1880007175] 'compare' (duration: 346.41345ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:05.948942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.954849Z","time spent":"994.002471ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:05.949085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.473174ms","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-08-04T21:38:05.949122Z","caller":"traceutil/trace.go:171","msg":"trace[48421522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1100; }","duration":"950.537256ms","start":"2026-08-04T21:38:04.998573Z","end":"2026-08-04T21:38:05.94911Z","steps":["trace[48421522] 'agreement among raft nodes before linearized reading' (duration: 950.238499ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.949158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.99856Z","time spent":"950.589347ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-04T21:38:05.949246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.77741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:38:05.949282Z","caller":"traceutil/trace.go:171","msg":"trace[2002743739] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1100; }","duration":"826.893803ms","start":"2026-08-04T21:38:05.122378Z","end":"2026-08-04T21:38:05.949272Z","steps":["trace[2002743739] 'agreement among raft nodes before linearized reading' (duration: 826.834972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.949314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:05.122362Z","time spent":"826.943714ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":29,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:38:05.949382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.7029ms","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-08-04T21:38:05.949426Z","caller":"traceutil/trace.go:171","msg":"trace[911726523] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1100; }","duration":"950.791172ms","start":"2026-08-04T21:38:04.998623Z","end":"2026-08-04T21:38:05.949414Z","steps":["trace[911726523] 'agreement among raft nodes before linearized reading' (duration: 950.579937ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.949459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.998603Z","time spent":"950.849113ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-04T21:38:05.949462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.122501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-04T21:38:05.949602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.927876ms","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-08-04T21:38:05.949638Z","caller":"traceutil/trace.go:171","msg":"trace[1079174307] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1100; }","duration":"951.004988ms","start":"2026-08-04T21:38:04.998623Z","end":"2026-08-04T21:38:05.949628Z","steps":["trace[1079174307] 'agreement among raft nodes before linearized reading' (duration: 950.911635ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.949665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.998608Z","time spent":"951.050788ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:05.949708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"950.795762ms","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-08-04T21:38:05.949753Z","caller":"traceutil/trace.go:171","msg":"trace[754443225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1100; }","duration":"950.825593ms","start":"2026-08-04T21:38:04.998904Z","end":"2026-08-04T21:38:05.949729Z","steps":["trace[754443225] 'agreement among raft nodes before linearized reading' (duration: 950.735931ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:05.94978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:04.998883Z","time spent":"950.890875ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-04T21:38:05.949602Z","caller":"traceutil/trace.go:171","msg":"trace[1781511488] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1100; }","duration":"274.297046ms","start":"2026-08-04T21:38:05.675296Z","end":"2026-08-04T21:38:05.949593Z","steps":["trace[1781511488] 'agreement among raft nodes before linearized reading' (duration: 274.145082ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:06.271099Z","caller":"traceutil/trace.go:171","msg":"trace[2067838376] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"234.799656ms","start":"2026-08-04T21:38:06.036268Z","end":"2026-08-04T21:38:06.271068Z","steps":["trace[2067838376] 'process raft request' (duration: 234.612321ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:07.59121Z","caller":"traceutil/trace.go:171","msg":"trace[101279504] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"202.96287ms","start":"2026-08-04T21:38:07.388224Z","end":"2026-08-04T21:38:07.591187Z","steps":["trace[101279504] 'process raft request' (duration: 202.368816ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:08.397417Z","caller":"traceutil/trace.go:171","msg":"trace[263674169] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1152; }","duration":"410.43828ms","start":"2026-08-04T21:38:07.986956Z","end":"2026-08-04T21:38:08.397395Z","steps":["trace[263674169] 'read index received' (duration: 410.393668ms)","trace[263674169] 'applied index is now lower than readState.Index' (duration: 43.782µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:08.397543Z","caller":"traceutil/trace.go:171","msg":"trace[1325164784] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"415.423269ms","start":"2026-08-04T21:38:07.98209Z","end":"2026-08-04T21:38:08.397513Z","steps":["trace[1325164784] 'process raft request' (duration: 415.191714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.397646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.667285ms","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-08-04T21:38:08.397682Z","caller":"traceutil/trace.go:171","msg":"trace[1291181948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1107; }","duration":"410.734166ms","start":"2026-08-04T21:38:07.986938Z","end":"2026-08-04T21:38:08.397672Z","steps":["trace[1291181948] 'agreement among raft nodes before linearized reading' (duration: 410.563382ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.3977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:07.982059Z","time spent":"415.556333ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:08.397716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:07.986925Z","time spent":"410.782098ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:08.402693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.781324ms","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-08-04T21:38:08.402735Z","caller":"traceutil/trace.go:171","msg":"trace[2024128512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1108; }","duration":"414.859886ms","start":"2026-08-04T21:38:07.987865Z","end":"2026-08-04T21:38:08.402725Z","steps":["trace[2024128512] 'agreement among raft nodes before linearized reading' (duration: 414.739643ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.40277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:07.987849Z","time spent":"414.904288ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-04T21:38:08.402773Z","caller":"traceutil/trace.go:171","msg":"trace[157507496] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"125.909478ms","start":"2026-08-04T21:38:08.276843Z","end":"2026-08-04T21:38:08.402753Z","steps":["trace[157507496] 'process raft request' (duration: 125.698922ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.402901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.759034ms","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-08-04T21:38:08.402957Z","caller":"traceutil/trace.go:171","msg":"trace[414927344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1108; }","duration":"414.842616ms","start":"2026-08-04T21:38:07.9881Z","end":"2026-08-04T21:38:08.402943Z","steps":["trace[414927344] 'agreement among raft nodes before linearized reading' (duration: 414.663052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.402996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:07.98809Z","time spent":"414.898487ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:08.403015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.073532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:38:08.403124Z","caller":"traceutil/trace.go:171","msg":"trace[924210998] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1108; }","duration":"388.427381ms","start":"2026-08-04T21:38:08.014666Z","end":"2026-08-04T21:38:08.403094Z","steps":["trace[924210998] 'agreement among raft nodes before linearized reading' (duration: 388.016881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:08.403192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:08.014654Z","time spent":"388.522843ms","remote":"127.0.0.1:44674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":29,"response size":29,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:38:08.59912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.950274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:08.599199Z","caller":"traceutil/trace.go:171","msg":"trace[2078758169] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"197.397017ms","start":"2026-08-04T21:38:08.401787Z","end":"2026-08-04T21:38:08.599184Z","steps":["trace[2078758169] 'process raft request' (duration: 55.322161ms)","trace[2078758169] 'compare' (duration: 141.754908ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:08.622823Z","caller":"traceutil/trace.go:171","msg":"trace[1084295476] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"215.337068ms","start":"2026-08-04T21:38:08.407448Z","end":"2026-08-04T21:38:08.622785Z","steps":["trace[1084295476] 'process raft request' (duration: 215.268247ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:08.622838Z","caller":"traceutil/trace.go:171","msg":"trace[1444267468] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"215.382409ms","start":"2026-08-04T21:38:08.407426Z","end":"2026-08-04T21:38:08.622808Z","steps":["trace[1444267468] 'process raft request' (duration: 215.173104ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:22.625799Z","caller":"traceutil/trace.go:171","msg":"trace[726061455] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"173.638745ms","start":"2026-08-04T21:38:22.452135Z","end":"2026-08-04T21:38:22.625774Z","steps":["trace[726061455] 'read index received' (duration: 173.467241ms)","trace[726061455] 'applied index is now lower than readState.Index' (duration: 170.544µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:22.625953Z","caller":"traceutil/trace.go:171","msg":"trace[416929638] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"180.91209ms","start":"2026-08-04T21:38:22.444982Z","end":"2026-08-04T21:38:22.625894Z","steps":["trace[416929638] 'process raft request' (duration: 180.640143ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:22.626033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.881481ms","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-08-04T21:38:22.626081Z","caller":"traceutil/trace.go:171","msg":"trace[1199457498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1204; }","duration":"173.971573ms","start":"2026-08-04T21:38:22.452095Z","end":"2026-08-04T21:38:22.626067Z","steps":["trace[1199457498] 'agreement among raft nodes before linearized reading' (duration: 173.777218ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:23.876672Z","caller":"traceutil/trace.go:171","msg":"trace[2141170714] linearizableReadLoop","detail":"{readStateIndex:1260; appliedIndex:1259; }","duration":"213.026423ms","start":"2026-08-04T21:38:23.66362Z","end":"2026-08-04T21:38:23.876646Z","steps":["trace[2141170714] 'read index received' (duration: 212.89334ms)","trace[2141170714] 'applied index is now lower than readState.Index' (duration: 131.663µs)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:23.876795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:23.314278Z","time spent":"562.513956ms","remote":"127.0.0.1:44186","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-04T21:38:23.877208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.579636ms","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-08-04T21:38:23.877243Z","caller":"traceutil/trace.go:171","msg":"trace[934698871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1208; }","duration":"213.663308ms","start":"2026-08-04T21:38:23.663569Z","end":"2026-08-04T21:38:23.877232Z","steps":["trace[934698871] 'agreement among raft nodes before linearized reading' (duration: 213.522665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:23.877442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.559041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:23.877472Z","caller":"traceutil/trace.go:171","msg":"trace[476867114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1208; }","duration":"202.626233ms","start":"2026-08-04T21:38:23.674836Z","end":"2026-08-04T21:38:23.877463Z","steps":["trace[476867114] 'agreement among raft nodes before linearized reading' (duration: 202.582961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:24.379735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4680541622884058470,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T21:38:24.721661Z","caller":"traceutil/trace.go:171","msg":"trace[1987766200] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"842.797156ms","start":"2026-08-04T21:38:23.87884Z","end":"2026-08-04T21:38:24.721637Z","steps":["trace[1987766200] 'process raft request' (duration: 841.990376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:24.721795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:23.878806Z","time spent":"842.919789ms","remote":"127.0.0.1:44186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:24.730649Z","caller":"traceutil/trace.go:171","msg":"trace[472978002] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"849.408595ms","start":"2026-08-04T21:38:23.881221Z","end":"2026-08-04T21:38:24.73063Z","steps":["trace[472978002] 'process raft request' (duration: 849.289102ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:24.730766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:23.881204Z","time spent":"849.501997ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:24.730794Z","caller":"traceutil/trace.go:171","msg":"trace[573184739] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1260; }","duration":"851.737251ms","start":"2026-08-04T21:38:23.879045Z","end":"2026-08-04T21:38:24.730783Z","steps":["trace[573184739] 'read index received' (duration: 841.73988ms)","trace[573184739] 'applied index is now lower than readState.Index' (duration: 9.996651ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:24.730981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.456251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:38:24.73101Z","caller":"traceutil/trace.go:171","msg":"trace[1691965840] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1211; }","duration":"136.522833ms","start":"2026-08-04T21:38:24.594477Z","end":"2026-08-04T21:38:24.731Z","steps":["trace[1691965840] 'agreement among raft nodes before linearized reading' (duration: 136.474882ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:24.7312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.168661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:24.731227Z","caller":"traceutil/trace.go:171","msg":"trace[1521541952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1211; }","duration":"852.235593ms","start":"2026-08-04T21:38:23.878984Z","end":"2026-08-04T21:38:24.731219Z","steps":["trace[1521541952] 'agreement among raft nodes before linearized reading' (duration: 852.196002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:24.731245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:23.878934Z","time spent":"852.306845ms","remote":"127.0.0.1:44158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T21:38:43.116633Z","caller":"traceutil/trace.go:171","msg":"trace[1630205573] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"281.975861ms","start":"2026-08-04T21:38:42.834628Z","end":"2026-08-04T21:38:43.116604Z","steps":["trace[1630205573] 'read index received' (duration: 281.807377ms)","trace[1630205573] 'applied index is now lower than readState.Index' (duration: 167.234µs)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:43.116721Z","caller":"traceutil/trace.go:171","msg":"trace[1285072511] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"282.448942ms","start":"2026-08-04T21:38:42.834219Z","end":"2026-08-04T21:38:43.116668Z","steps":["trace[1285072511] 'process raft request' (duration: 282.204956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.11687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.221076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-04T21:38:43.116903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.147407ms","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-08-04T21:38:43.116952Z","caller":"traceutil/trace.go:171","msg":"trace[489831559] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1289; }","duration":"282.35085ms","start":"2026-08-04T21:38:42.834584Z","end":"2026-08-04T21:38:43.116935Z","steps":["trace[489831559] 'agreement among raft nodes before linearized reading' (duration: 282.123874ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:43.116962Z","caller":"traceutil/trace.go:171","msg":"trace[843505336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1289; }","duration":"275.266299ms","start":"2026-08-04T21:38:42.841678Z","end":"2026-08-04T21:38:43.116945Z","steps":["trace[843505336] 'agreement among raft nodes before linearized reading' (duration: 275.079314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.116976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.91623ms","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-08-04T21:38:43.117022Z","caller":"traceutil/trace.go:171","msg":"trace[332400502] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1289; }","duration":"223.001252ms","start":"2026-08-04T21:38:42.894007Z","end":"2026-08-04T21:38:43.117008Z","steps":["trace[332400502] 'agreement among raft nodes before linearized reading' (duration: 222.876509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.117166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.709756ms","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-08-04T21:38:43.117222Z","caller":"traceutil/trace.go:171","msg":"trace[1910609739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1289; }","duration":"269.785517ms","start":"2026-08-04T21:38:42.84742Z","end":"2026-08-04T21:38:43.117205Z","steps":["trace[1910609739] 'agreement among raft nodes before linearized reading' (duration: 269.647624ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.117228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.641188ms","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-08-04T21:38:43.117282Z","caller":"traceutil/trace.go:171","msg":"trace[1818840239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1289; }","duration":"270.72455ms","start":"2026-08-04T21:38:42.846546Z","end":"2026-08-04T21:38:43.11727Z","steps":["trace[1818840239] 'agreement among raft nodes before linearized reading' (duration: 270.554136ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.117279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.933541ms","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-08-04T21:38:43.117337Z","caller":"traceutil/trace.go:171","msg":"trace[1530862316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1289; }","duration":"223.035433ms","start":"2026-08-04T21:38:42.894289Z","end":"2026-08-04T21:38:43.117324Z","steps":["trace[1530862316] 'agreement among raft nodes before linearized reading' (duration: 222.799787ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:43.47187Z","caller":"traceutil/trace.go:171","msg":"trace[796172512] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"350.759855ms","start":"2026-08-04T21:38:43.121078Z","end":"2026-08-04T21:38:43.471838Z","steps":["trace[796172512] 'process raft request' (duration: 258.791493ms)","trace[796172512] 'compare' (duration: 91.710445ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:43.47226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:43.121057Z","time spent":"350.887437ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:43.494488Z","caller":"traceutil/trace.go:171","msg":"trace[988459082] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"373.094201ms","start":"2026-08-04T21:38:43.121307Z","end":"2026-08-04T21:38:43.494401Z","steps":["trace[988459082] 'process raft request' (duration: 373.021009ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:43.494505Z","caller":"traceutil/trace.go:171","msg":"trace[1045428413] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"373.179013ms","start":"2026-08-04T21:38:43.121306Z","end":"2026-08-04T21:38:43.494485Z","steps":["trace[1045428413] 'process raft request' (duration: 372.899856ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.494639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:43.121288Z","time spent":"373.277026ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:43.49463Z","caller":"traceutil/trace.go:171","msg":"trace[2101338562] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"373.119942ms","start":"2026-08-04T21:38:43.121491Z","end":"2026-08-04T21:38:43.494611Z","steps":["trace[2101338562] 'process raft request' (duration: 372.877276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.494642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:43.121288Z","time spent":"373.269026ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:43.494718Z","caller":"traceutil/trace.go:171","msg":"trace[744476529] linearizableReadLoop","detail":"{readStateIndex:1349; appliedIndex:1344; }","duration":"179.817444ms","start":"2026-08-04T21:38:43.31488Z","end":"2026-08-04T21:38:43.494698Z","steps":["trace[744476529] 'read index received' (duration: 64.954812ms)","trace[744476529] 'applied index is now lower than readState.Index' (duration: 114.861812ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:43.494742Z","caller":"traceutil/trace.go:171","msg":"trace[1120164425] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"373.01655ms","start":"2026-08-04T21:38:43.12171Z","end":"2026-08-04T21:38:43.494727Z","steps":["trace[1120164425] 'process raft request' (duration: 372.862156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:43.494737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:43.121481Z","time spent":"373.198504ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:43.494803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:43.121702Z","time spent":"373.071331ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:43.494924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.045489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.142\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-04T21:38:43.494977Z","caller":"traceutil/trace.go:171","msg":"trace[1513202637] range","detail":"{range_begin:/registry/masterleases/199.19.213.142; range_end:; response_count:1; response_revision:1294; }","duration":"180.145702ms","start":"2026-08-04T21:38:43.314815Z","end":"2026-08-04T21:38:43.494961Z","steps":["trace[1513202637] 'agreement among raft nodes before linearized reading' (duration: 179.941947ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:45.556229Z","caller":"traceutil/trace.go:171","msg":"trace[396823707] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"433.810771ms","start":"2026-08-04T21:38:45.122391Z","end":"2026-08-04T21:38:45.556202Z","steps":["trace[396823707] 'process raft request' (duration: 432.059889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:45.556374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:45.122358Z","time spent":"433.942564ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:45.800632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.55505ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:45.800905Z","caller":"traceutil/trace.go:171","msg":"trace[1093806422] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"238.741451ms","start":"2026-08-04T21:38:45.56214Z","end":"2026-08-04T21:38:45.800882Z","steps":["trace[1093806422] 'process raft request' (duration: 238.613418ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:45.800934Z","caller":"traceutil/trace.go:171","msg":"trace[507756859] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"238.752661ms","start":"2026-08-04T21:38:45.562106Z","end":"2026-08-04T21:38:45.800859Z","steps":["trace[507756859] 'process raft request' (duration: 134.861573ms)","trace[507756859] 'compare' (duration: 103.301124ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:45.801173Z","caller":"traceutil/trace.go:171","msg":"trace[1373653947] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"238.950676ms","start":"2026-08-04T21:38:45.562199Z","end":"2026-08-04T21:38:45.80115Z","steps":["trace[1373653947] 'process raft request' (duration: 238.633708ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:45.801371Z","caller":"traceutil/trace.go:171","msg":"trace[1551286821] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"238.225098ms","start":"2026-08-04T21:38:45.563129Z","end":"2026-08-04T21:38:45.801354Z","steps":["trace[1551286821] 'process raft request' (duration: 237.948041ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:45.801496Z","caller":"traceutil/trace.go:171","msg":"trace[1967974896] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"153.976622ms","start":"2026-08-04T21:38:45.647505Z","end":"2026-08-04T21:38:45.801482Z","steps":["trace[1967974896] 'process raft request' (duration: 153.792948ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:46.503243Z","caller":"traceutil/trace.go:171","msg":"trace[332082553] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"635.274305ms","start":"2026-08-04T21:38:45.86795Z","end":"2026-08-04T21:38:46.503224Z","steps":["trace[332082553] 'process raft request' (duration: 635.146772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:46.503358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:45.867934Z","time spent":"635.374799ms","remote":"127.0.0.1:44224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-04T21:38:46.999954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.053531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:47.000209Z","caller":"traceutil/trace.go:171","msg":"trace[525731751] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"1.130933975s","start":"2026-08-04T21:38:45.869246Z","end":"2026-08-04T21:38:47.00018Z","steps":["trace[525731751] 'process raft request' (duration: 957.371231ms)","trace[525731751] 'compare' (duration: 172.492868ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:47.000336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:45.869224Z","time spent":"1.131052708s","remote":"127.0.0.1:44224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:38:47.000575Z","caller":"traceutil/trace.go:171","msg":"trace[1039710099] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"1.129106511s","start":"2026-08-04T21:38:45.871442Z","end":"2026-08-04T21:38:47.000548Z","steps":["trace[1039710099] 'process raft request' (duration: 1.128932237s)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:47.000788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:45.871417Z","time spent":"1.129273525s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:47.329963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.902898ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:38:47.330147Z","caller":"traceutil/trace.go:171","msg":"trace[720690359] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1361; }","duration":"655.418031ms","start":"2026-08-04T21:38:46.674713Z","end":"2026-08-04T21:38:47.330131Z","steps":["trace[720690359] 'read index received' (duration: 151.917444ms)","trace[720690359] 'applied index is now lower than readState.Index' (duration: 503.499647ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:47.330289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.557534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:38:47.330324Z","caller":"traceutil/trace.go:171","msg":"trace[831133754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1309; }","duration":"655.634706ms","start":"2026-08-04T21:38:46.67468Z","end":"2026-08-04T21:38:47.330314Z","steps":["trace[831133754] 'agreement among raft nodes before linearized reading' (duration: 655.541504ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:47.330355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:46.674664Z","time spent":"655.684317ms","remote":"127.0.0.1:44156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-04T21:38:47.330353Z","caller":"traceutil/trace.go:171","msg":"trace[753978587] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"823.506992ms","start":"2026-08-04T21:38:46.506812Z","end":"2026-08-04T21:38:47.330319Z","steps":["trace[753978587] 'process raft request' (duration: 598.181594ms)","trace[753978587] 'compare' (duration: 224.778145ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:38:47.330459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:46.506788Z","time spent":"823.608745ms","remote":"127.0.0.1:44224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-04T21:38:47.330285Z","caller":"traceutil/trace.go:171","msg":"trace[1334765833] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"711.233232ms","start":"2026-08-04T21:38:46.619017Z","end":"2026-08-04T21:38:47.33025Z","steps":["trace[1334765833] 'process raft request' (duration: 711.046838ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:47.330671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:46.618996Z","time spent":"711.573601ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:47.33082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.836531ms","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-08-04T21:38:47.330997Z","caller":"traceutil/trace.go:171","msg":"trace[2010495951] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1309; }","duration":"424.055066ms","start":"2026-08-04T21:38:46.906864Z","end":"2026-08-04T21:38:47.330919Z","steps":["trace[2010495951] 'agreement among raft nodes before linearized reading' (duration: 423.476703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:47.331061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:46.906815Z","time spent":"424.232812ms","remote":"127.0.0.1:44600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-08-04T21:38:55.892624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.210166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-08-04T21:38:55.892704Z","caller":"traceutil/trace.go:171","msg":"trace[1550117537] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1371; }","duration":"455.331589ms","start":"2026-08-04T21:38:55.437357Z","end":"2026-08-04T21:38:55.892688Z","steps":["trace[1550117537] 'range keys from in-memory index tree' (duration: 455.040802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:55.892744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.437338Z","time spent":"455.39776ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-08-04T21:38:56.151663Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4680541622884058809,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-04T21:38:56.186384Z","caller":"traceutil/trace.go:171","msg":"trace[687884488] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"566.182295ms","start":"2026-08-04T21:38:55.620174Z","end":"2026-08-04T21:38:56.186356Z","steps":["trace[687884488] 'process raft request' (duration: 566.017831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.186706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.620155Z","time spent":"566.41723ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:38:56.603216Z","caller":"traceutil/trace.go:171","msg":"trace[1744107321] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1429; }","duration":"952.557425ms","start":"2026-08-04T21:38:55.650633Z","end":"2026-08-04T21:38:56.60319Z","steps":["trace[1744107321] 'read index received' (duration: 535.679781ms)","trace[1744107321] 'applied index is now lower than readState.Index' (duration: 416.863924ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:38:56.603364Z","caller":"traceutil/trace.go:171","msg":"trace[1024594028] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"706.008097ms","start":"2026-08-04T21:38:55.897301Z","end":"2026-08-04T21:38:56.603309Z","steps":["trace[1024594028] 'process raft request' (duration: 705.202998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.603433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.781301ms","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-08-04T21:38:56.603512Z","caller":"traceutil/trace.go:171","msg":"trace[870462367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1373; }","duration":"952.894774ms","start":"2026-08-04T21:38:55.650593Z","end":"2026-08-04T21:38:56.603488Z","steps":["trace[870462367] 'agreement among raft nodes before linearized reading' (duration: 952.708869ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.60353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.897259Z","time spent":"706.179401ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:38:56.603553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.650571Z","time spent":"952.973635ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:56.603549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.955134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-04T21:38:56.603606Z","caller":"traceutil/trace.go:171","msg":"trace[347596868] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1373; }","duration":"503.065367ms","start":"2026-08-04T21:38:56.100525Z","end":"2026-08-04T21:38:56.60359Z","steps":["trace[347596868] 'agreement among raft nodes before linearized reading' (duration: 502.927464ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.603616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"692.401819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-08-04T21:38:56.603546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.452487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-04T21:38:56.603745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.851305ms","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-08-04T21:38:56.603747Z","caller":"traceutil/trace.go:171","msg":"trace[2042161954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1373; }","duration":"691.689482ms","start":"2026-08-04T21:38:55.91204Z","end":"2026-08-04T21:38:56.60373Z","steps":["trace[2042161954] 'agreement among raft nodes before linearized reading' (duration: 691.446477ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:38:56.603771Z","caller":"traceutil/trace.go:171","msg":"trace[588242802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1373; }","duration":"693.914336ms","start":"2026-08-04T21:38:55.909849Z","end":"2026-08-04T21:38:56.603764Z","steps":["trace[588242802] 'agreement among raft nodes before linearized reading' (duration: 693.845005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.603795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.912023Z","time spent":"691.759875ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:56.603806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.909827Z","time spent":"693.972318ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-04T21:38:56.603463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.600392ms","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-08-04T21:38:56.603907Z","caller":"traceutil/trace.go:171","msg":"trace[621140329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1373; }","duration":"722.103594ms","start":"2026-08-04T21:38:55.881796Z","end":"2026-08-04T21:38:56.6039Z","steps":["trace[621140329] 'agreement among raft nodes before linearized reading' (duration: 721.531111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.603932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.881774Z","time spent":"722.152445ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-04T21:38:56.603648Z","caller":"traceutil/trace.go:171","msg":"trace[585650543] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1373; }","duration":"692.440471ms","start":"2026-08-04T21:38:55.911196Z","end":"2026-08-04T21:38:56.603637Z","steps":["trace[585650543] 'agreement among raft nodes before linearized reading' (duration: 692.368209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:38:56.604032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:55.911191Z","time spent":"692.83195ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-04T21:38:56.603642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:38:56.100501Z","time spent":"503.132349ms","remote":"127.0.0.1:44496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"info","ts":"2026-08-04T21:39:08.781285Z","caller":"traceutil/trace.go:171","msg":"trace[1208136974] linearizableReadLoop","detail":"{readStateIndex:1491; appliedIndex:1489; }","duration":"109.570718ms","start":"2026-08-04T21:39:08.671678Z","end":"2026-08-04T21:39:08.781249Z","steps":["trace[1208136974] 'read index received' (duration: 37.805781ms)","trace[1208136974] 'applied index is now lower than readState.Index' (duration: 71.763787ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:39:08.78133Z","caller":"traceutil/trace.go:171","msg":"trace[412173598] transaction","detail":"{read_only:false; response_revision:1430; number_of_response:1; }","duration":"114.27078ms","start":"2026-08-04T21:39:08.667032Z","end":"2026-08-04T21:39:08.781303Z","steps":["trace[412173598] 'process raft request' (duration: 79.069753ms)","trace[412173598] 'compare' (duration: 34.928171ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:39:08.781491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.784213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-04T21:39:08.781535Z","caller":"traceutil/trace.go:171","msg":"trace[149668220] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1430; }","duration":"109.874025ms","start":"2026-08-04T21:39:08.671648Z","end":"2026-08-04T21:39:08.781522Z","steps":["trace[149668220] 'agreement among raft nodes before linearized reading' (duration: 109.781952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:39:08.781636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.108692ms","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-08-04T21:39:08.781711Z","caller":"traceutil/trace.go:171","msg":"trace[1818147391] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1430; }","duration":"103.211315ms","start":"2026-08-04T21:39:08.678486Z","end":"2026-08-04T21:39:08.781698Z","steps":["trace[1818147391] 'agreement among raft nodes before linearized reading' (duration: 102.99727ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:39:08.781979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.072647ms","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-08-04T21:39:08.782376Z","caller":"traceutil/trace.go:171","msg":"trace[277010063] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1430; }","duration":"102.508238ms","start":"2026-08-04T21:39:08.679849Z","end":"2026-08-04T21:39:08.782357Z","steps":["trace[277010063] 'agreement among raft nodes before linearized reading' (duration: 101.970155ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:39:08.937586Z","caller":"traceutil/trace.go:171","msg":"trace[1583503279] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"148.450043ms","start":"2026-08-04T21:39:08.78911Z","end":"2026-08-04T21:39:08.937561Z","steps":["trace[1583503279] 'process raft request' (duration: 148.405212ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:39:08.937604Z","caller":"traceutil/trace.go:171","msg":"trace[1147863726] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"150.940013ms","start":"2026-08-04T21:39:08.786641Z","end":"2026-08-04T21:39:08.937581Z","steps":["trace[1147863726] 'process raft request' (duration: 150.80125ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:39:08.93759Z","caller":"traceutil/trace.go:171","msg":"trace[1780390246] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"150.928153ms","start":"2026-08-04T21:39:08.786623Z","end":"2026-08-04T21:39:08.937552Z","steps":["trace[1780390246] 'process raft request' (duration: 138.931164ms)","trace[1780390246] 'compare' (duration: 11.772104ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:39:08.937686Z","caller":"traceutil/trace.go:171","msg":"trace[1913003294] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"150.910902ms","start":"2026-08-04T21:39:08.786734Z","end":"2026-08-04T21:39:08.937645Z","steps":["trace[1913003294] 'process raft request' (duration: 150.751229ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:40:47.583933Z","caller":"traceutil/trace.go:171","msg":"trace[168281243] transaction","detail":"{read_only:false; response_revision:1884; number_of_response:1; }","duration":"119.165513ms","start":"2026-08-04T21:40:47.464738Z","end":"2026-08-04T21:40:47.583903Z","steps":["trace[168281243] 'process raft request' (duration: 119.133062ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:40:47.58421Z","caller":"traceutil/trace.go:171","msg":"trace[1724573710] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"119.701295ms","start":"2026-08-04T21:40:47.464453Z","end":"2026-08-04T21:40:47.584155Z","steps":["trace[1724573710] 'process raft request' (duration: 118.417484ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:42:35.293339Z","caller":"traceutil/trace.go:171","msg":"trace[1382529715] transaction","detail":"{read_only:false; response_revision:2378; number_of_response:1; }","duration":"122.55102ms","start":"2026-08-04T21:42:35.17077Z","end":"2026-08-04T21:42:35.293321Z","steps":["trace[1382529715] 'process raft request' (duration: 122.437067ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:42:36.169704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.850041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:42:36.169803Z","caller":"traceutil/trace.go:171","msg":"trace[1744082067] linearizableReadLoop","detail":"{readStateIndex:2482; appliedIndex:2481; }","duration":"275.911179ms","start":"2026-08-04T21:42:35.893876Z","end":"2026-08-04T21:42:36.169787Z","steps":["trace[1744082067] 'read index received' (duration: 114.898074ms)","trace[1744082067] 'applied index is now lower than readState.Index' (duration: 161.011734ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:42:36.169894Z","caller":"traceutil/trace.go:171","msg":"trace[2129034091] transaction","detail":"{read_only:false; response_revision:2380; number_of_response:1; }","duration":"278.116422ms","start":"2026-08-04T21:42:35.891728Z","end":"2026-08-04T21:42:36.169844Z","steps":["trace[2129034091] 'process raft request' (duration: 116.989074ms)","trace[2129034091] 'compare' (duration: 160.601835ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:42:36.170098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.211136ms","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":"warn","ts":"2026-08-04T21:42:36.170203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.61285ms","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-08-04T21:42:36.170222Z","caller":"traceutil/trace.go:171","msg":"trace[1753280029] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2380; }","duration":"276.333498ms","start":"2026-08-04T21:42:35.893845Z","end":"2026-08-04T21:42:36.170179Z","steps":["trace[1753280029] 'agreement among raft nodes before linearized reading' (duration: 276.027651ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:42:36.17029Z","caller":"traceutil/trace.go:171","msg":"trace[1647133570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2380; }","duration":"138.729843ms","start":"2026-08-04T21:42:36.031525Z","end":"2026-08-04T21:42:36.170255Z","steps":["trace[1647133570] 'agreement among raft nodes before linearized reading' (duration: 138.536528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:42:36.448044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.233739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-04T21:42:36.448157Z","caller":"traceutil/trace.go:171","msg":"trace[445720899] transaction","detail":"{read_only:false; response_revision:2381; number_of_response:1; }","duration":"273.10244ms","start":"2026-08-04T21:42:36.175034Z","end":"2026-08-04T21:42:36.448136Z","steps":["trace[445720899] 'process raft request' (duration: 160.682077ms)","trace[445720899] 'compare' (duration: 112.095896ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:42:36.466946Z","caller":"traceutil/trace.go:171","msg":"trace[1548004456] linearizableReadLoop","detail":"{readStateIndex:2484; appliedIndex:2482; }","duration":"201.53539ms","start":"2026-08-04T21:42:36.265392Z","end":"2026-08-04T21:42:36.466927Z","steps":["trace[1548004456] 'read index received' (duration: 70.33824ms)","trace[1548004456] 'applied index is now lower than readState.Index' (duration: 131.19127ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:42:36.467026Z","caller":"traceutil/trace.go:171","msg":"trace[514651853] transaction","detail":"{read_only:false; response_revision:2382; number_of_response:1; }","duration":"290.76508ms","start":"2026-08-04T21:42:36.17624Z","end":"2026-08-04T21:42:36.467006Z","steps":["trace[514651853] 'process raft request' (duration: 290.586826ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:42:36.46717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.769596ms","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-08-04T21:42:36.467212Z","caller":"traceutil/trace.go:171","msg":"trace[1452027441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2382; }","duration":"201.856808ms","start":"2026-08-04T21:42:36.265345Z","end":"2026-08-04T21:42:36.467201Z","steps":["trace[1452027441] 'agreement among raft nodes before linearized reading' (duration: 201.685654ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:42:36.467304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.708018ms","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-08-04T21:42:36.467345Z","caller":"traceutil/trace.go:171","msg":"trace[1931412191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2382; }","duration":"160.791609ms","start":"2026-08-04T21:42:36.306547Z","end":"2026-08-04T21:42:36.467339Z","steps":["trace[1931412191] 'agreement among raft nodes before linearized reading' (duration: 160.652116ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:42:36.467361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.175411ms","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-08-04T21:42:36.467463Z","caller":"traceutil/trace.go:171","msg":"trace[499031684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2382; }","duration":"173.305124ms","start":"2026-08-04T21:42:36.29414Z","end":"2026-08-04T21:42:36.467445Z","steps":["trace[499031684] 'agreement among raft nodes before linearized reading' (duration: 173.042768ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:42:36.572963Z","caller":"traceutil/trace.go:171","msg":"trace[1588825519] transaction","detail":"{read_only:false; response_revision:2383; number_of_response:1; }","duration":"102.107893ms","start":"2026-08-04T21:42:36.470827Z","end":"2026-08-04T21:42:36.572935Z","steps":["trace[1588825519] 'process raft request' (duration: 80.351254ms)","trace[1588825519] 'compare' (duration: 21.609745ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:42:36.574514Z","caller":"traceutil/trace.go:171","msg":"trace[1287823870] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"102.786109ms","start":"2026-08-04T21:42:36.471684Z","end":"2026-08-04T21:42:36.57447Z","steps":["trace[1287823870] 'process raft request' (duration: 101.389935ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:42:36.576869Z","caller":"traceutil/trace.go:171","msg":"trace[1453582583] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"102.739358ms","start":"2026-08-04T21:42:36.471103Z","end":"2026-08-04T21:42:36.573842Z","steps":["trace[1453582583] 'process raft request' (duration: 101.799625ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:43:12.518239Z","caller":"traceutil/trace.go:171","msg":"trace[272503053] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"180.289303ms","start":"2026-08-04T21:43:12.337928Z","end":"2026-08-04T21:43:12.518218Z","steps":["trace[272503053] 'process raft request' (duration: 180.14573ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:43:13.059405Z","caller":"traceutil/trace.go:171","msg":"trace[1349030938] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"299.938172ms","start":"2026-08-04T21:43:12.759443Z","end":"2026-08-04T21:43:13.059381Z","steps":["trace[1349030938] 'process raft request' (duration: 299.86399ms)"],"step_count":1} {"level":"warn","ts":"2026-08-04T21:43:13.059554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:43:12.759434Z","time spent":"300.048004ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-04T21:43:13.059605Z","caller":"traceutil/trace.go:171","msg":"trace[792495574] transaction","detail":"{read_only:false; response_revision:2576; number_of_response:1; }","duration":"299.405149ms","start":"2026-08-04T21:43:12.76017Z","end":"2026-08-04T21:43:13.059575Z","steps":["trace[792495574] 'process raft request' (duration: 299.175973ms)"],"step_count":1} {"level":"info","ts":"2026-08-04T21:43:13.059638Z","caller":"traceutil/trace.go:171","msg":"trace[2052225805] transaction","detail":"{read_only:false; response_revision:2574; number_of_response:1; }","duration":"302.044833ms","start":"2026-08-04T21:43:12.757532Z","end":"2026-08-04T21:43:13.059577Z","steps":["trace[2052225805] 'process raft request' (duration: 267.505053ms)","trace[2052225805] 'compare' (duration: 34.14028ms)"],"step_count":2} {"level":"info","ts":"2026-08-04T21:43:13.059731Z","caller":"traceutil/trace.go:171","msg":"trace[20067205] linearizableReadLoop","detail":"{readStateIndex:2686; appliedIndex:2683; }","duration":"181.566514ms","start":"2026-08-04T21:43:12.878144Z","end":"2026-08-04T21:43:13.05971Z","steps":["trace[20067205] 'read index received' (duration: 146.898831ms)","trace[20067205] 'applied index is now lower than readState.Index' (duration: 34.666283ms)"],"step_count":2} {"level":"warn","ts":"2026-08-04T21:43:13.05985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-04T21:43:12.757516Z","time spent":"302.219376ms","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-04T21:43:13.059959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.800659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-08-04T21:43:13.060159Z","caller":"traceutil/trace.go:171","msg":"trace[1776260406] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2576; }","duration":"182.043995ms","start":"2026-08-04T21:43:12.878095Z","end":"2026-08-04T21:43:13.060139Z","steps":["trace[1776260406] 'agreement among raft nodes before linearized reading' (duration: 181.728838ms)"],"step_count":1}