{"level":"warn","ts":"2026-07-24T17:31:24.436362Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T17:31:24.436444Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-07-24T17:31:24.436504Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-24T17:31:24.436514Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-24T17:31:24.43653Z","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-07-24T17:31:24.437169Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-07-24T17:31:24.437234Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-07-24T17:31:24.443786Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.343356ms"} {"level":"info","ts":"2026-07-24T17:31:24.456839Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-07-24T17:31:24.456912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-07-24T17:31:24.456934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-07-24T17:31:24.456947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-24T17:31:24.456957Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-07-24T17:31:24.456991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-07-24T17:31:24.473132Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-24T17:31:24.479239Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-24T17:31:24.481013Z","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-07-24T17:31:24.488171Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-24T17:31:24.488275Z","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-07-24T17:31:24.488355Z","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-07-24T17:31:24.488365Z","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-07-24T17:31:24.488643Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-24T17:31:24.49163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-07-24T17:31:24.491714Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-24T17:31:24.492368Z","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-07-24T17:31:24.492421Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-24T17:31:24.49244Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-24T17:31:24.492786Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-24T17:31:24.492845Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-24T17:31:25.258093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-07-24T17:31:25.258161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-07-24T17:31:25.258184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-07-24T17:31:25.258206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-07-24T17:31:25.258218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-24T17:31:25.258235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-07-24T17:31:25.258255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-24T17:31:25.259224Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:31:25.259383Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T17:31:25.25939Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-07-24T17:31:25.259579Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-24T17:31:25.259768Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-24T17:31:25.259847Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-24T17:31:25.260668Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:31:25.260823Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:31:25.260877Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-24T17:31:25.261541Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-07-24T17:31:25.263129Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-24T17:31:27.097187Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103924144122231,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T17:31:27.239213Z","caller":"traceutil/trace.go:171","msg":"trace[1863217892] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"642.77046ms","start":"2026-07-24T17:31:26.596417Z","end":"2026-07-24T17:31:27.239187Z","steps":["trace[1863217892] 'process raft request' (duration: 642.535314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:27.239812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.596384Z","time spent":"642.916604ms","remote":"127.0.0.1:38040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:31:28.436683Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.07658838s","expected-duration":"1s"} {"level":"info","ts":"2026-07-24T17:31:28.437877Z","caller":"traceutil/trace.go:171","msg":"trace[149427594] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"1.84092402s","start":"2026-07-24T17:31:26.596906Z","end":"2026-07-24T17:31:28.43783Z","steps":["trace[149427594] 'read index received' (duration: 642.092733ms)","trace[149427594] 'applied index is now lower than readState.Index' (duration: 1.198830397s)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:28.437949Z","caller":"traceutil/trace.go:171","msg":"trace[671925121] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.799153995s","start":"2026-07-24T17:31:26.638766Z","end":"2026-07-24T17:31:28.43792Z","steps":["trace[671925121] 'process raft request' (duration: 1.798751015s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.438048Z","caller":"traceutil/trace.go:171","msg":"trace[261194841] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.798759414s","start":"2026-07-24T17:31:26.639277Z","end":"2026-07-24T17:31:28.438037Z","steps":["trace[261194841] 'process raft request' (duration: 1.798281382s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.438082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.638742Z","time spent":"1.799285379s","remote":"127.0.0.1:38402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:28.438167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.639266Z","time spent":"1.798815586s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:28.438461Z","caller":"traceutil/trace.go:171","msg":"trace[93904419] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.839473212s","start":"2026-07-24T17:31:26.598968Z","end":"2026-07-24T17:31:28.438441Z","steps":["trace[93904419] 'process raft request' (duration: 1.837963633s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.438502Z","caller":"traceutil/trace.go:171","msg":"trace[89764674] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.759132636s","start":"2026-07-24T17:31:26.679351Z","end":"2026-07-24T17:31:28.438484Z","steps":["trace[89764674] 'process raft request' (duration: 1.758447838s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.438536Z","caller":"traceutil/trace.go:171","msg":"trace[995492195] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.798867177s","start":"2026-07-24T17:31:26.639655Z","end":"2026-07-24T17:31:28.438522Z","steps":["trace[995492195] 'process raft request' (duration: 1.797957494s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.438536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.598945Z","time spent":"1.839547935s","remote":"127.0.0.1:38038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:31:28.43859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.679323Z","time spent":"1.759210927s","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:28.438619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.639636Z","time spent":"1.798934658s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:28.438729Z","caller":"traceutil/trace.go:171","msg":"trace[1528312866] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.799020501s","start":"2026-07-24T17:31:26.6397Z","end":"2026-07-24T17:31:28.43872Z","steps":["trace[1528312866] 'process raft request' (duration: 1.797939443s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.438766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.63967Z","time spent":"1.799077023s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:28.438875Z","caller":"traceutil/trace.go:171","msg":"trace[2060914425] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.799040443s","start":"2026-07-24T17:31:26.639825Z","end":"2026-07-24T17:31:28.438866Z","steps":["trace[2060914425] 'process raft request' (duration: 1.797859831s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.438922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.639816Z","time spent":"1.799086344s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:28.438921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.840155271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-24T17:31:28.43888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.841964268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-24T17:31:28.439021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.163993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439048Z","caller":"traceutil/trace.go:171","msg":"trace[1496583952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11; }","duration":"860.223605ms","start":"2026-07-24T17:31:27.578817Z","end":"2026-07-24T17:31:28.43904Z","steps":["trace[1496583952] 'agreement among raft nodes before linearized reading' (duration: 860.188334ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.43906Z","caller":"traceutil/trace.go:171","msg":"trace[653195371] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.760188953s","start":"2026-07-24T17:31:26.678865Z","end":"2026-07-24T17:31:28.439054Z","steps":["trace[653195371] 'process raft request' (duration: 1.758874079s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.438976Z","caller":"traceutil/trace.go:171","msg":"trace[1631048986] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.79894247s","start":"2026-07-24T17:31:26.640027Z","end":"2026-07-24T17:31:28.438969Z","steps":["trace[1631048986] 'process raft request' (duration: 1.797682007s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:27.578779Z","time spent":"860.291907ms","remote":"127.0.0.1:37960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.678789Z","time spent":"1.760289605s","remote":"127.0.0.1:38138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:28.43905Z","caller":"traceutil/trace.go:171","msg":"trace[635678878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"1.842120172s","start":"2026-07-24T17:31:26.596876Z","end":"2026-07-24T17:31:28.438996Z","steps":["trace[635678878] 'agreement among raft nodes before linearized reading' (duration: 1.841882155s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.596849Z","time spent":"1.842351059s","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.639951Z","time spent":"1.799140505s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:28.439293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800174362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-24T17:31:28.439323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.800272624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439353Z","caller":"traceutil/trace.go:171","msg":"trace[694047517] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.800259223s","start":"2026-07-24T17:31:26.639076Z","end":"2026-07-24T17:31:28.439335Z","steps":["trace[694047517] 'agreement among raft nodes before linearized reading' (duration: 1.800151171s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:28.439372Z","caller":"traceutil/trace.go:171","msg":"trace[1622368685] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.800350116s","start":"2026-07-24T17:31:26.639008Z","end":"2026-07-24T17:31:28.439358Z","steps":["trace[1622368685] 'agreement among raft nodes before linearized reading' (duration: 1.800237783s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.639065Z","time spent":"1.800315725s","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.638997Z","time spent":"1.800406707s","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.829624494s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439477Z","caller":"traceutil/trace.go:171","msg":"trace[585779496] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"1.829687016s","start":"2026-07-24T17:31:26.609783Z","end":"2026-07-24T17:31:28.43947Z","steps":["trace[585779496] 'agreement among raft nodes before linearized reading' (duration: 1.829646955s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.609768Z","time spent":"1.829723736s","remote":"127.0.0.1:38358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.918036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439553Z","caller":"traceutil/trace.go:171","msg":"trace[1351759884] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11; }","duration":"902.993788ms","start":"2026-07-24T17:31:27.536553Z","end":"2026-07-24T17:31:28.439547Z","steps":["trace[1351759884] 'agreement among raft nodes before linearized reading' (duration: 902.946045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:27.536523Z","time spent":"903.053599ms","remote":"127.0.0.1:38306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.801551768s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439605Z","caller":"traceutil/trace.go:171","msg":"trace[1200039562] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:0; response_revision:11; }","duration":"1.8015971s","start":"2026-07-24T17:31:26.638002Z","end":"2026-07-24T17:31:28.439599Z","steps":["trace[1200039562] 'agreement among raft nodes before linearized reading' (duration: 1.801565799s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.637893Z","time spent":"1.801725513s","remote":"127.0.0.1:38020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.129\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.411529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439721Z","caller":"traceutil/trace.go:171","msg":"trace[1643917308] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:11; }","duration":"903.478061ms","start":"2026-07-24T17:31:27.536235Z","end":"2026-07-24T17:31:28.439713Z","steps":["trace[1643917308] 'agreement among raft nodes before linearized reading' (duration: 903.430359ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:27.536212Z","time spent":"903.526971ms","remote":"127.0.0.1:38322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":26,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-07-24T17:31:28.438972Z","caller":"traceutil/trace.go:171","msg":"trace[107603388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"1.840226913s","start":"2026-07-24T17:31:26.598731Z","end":"2026-07-24T17:31:28.438957Z","steps":["trace[107603388] 'agreement among raft nodes before linearized reading' (duration: 1.840141471s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.439852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.598694Z","time spent":"1.841149967s","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T17:31:28.439911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.749347599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.439938Z","caller":"traceutil/trace.go:171","msg":"trace[1710285413] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"1.749413251s","start":"2026-07-24T17:31:26.690519Z","end":"2026-07-24T17:31:28.439932Z","steps":["trace[1710285413] 'agreement among raft nodes before linearized reading' (duration: 1.7493751s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.43996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.690503Z","time spent":"1.749448072s","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-24T17:31:28.44054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.799769051s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:28.44089Z","caller":"traceutil/trace.go:171","msg":"trace[390102276] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"1.800319215s","start":"2026-07-24T17:31:26.640539Z","end":"2026-07-24T17:31:28.440858Z","steps":["trace[390102276] 'agreement among raft nodes before linearized reading' (duration: 1.799273888s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:28.441063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:26.64049Z","time spent":"1.800546301s","remote":"127.0.0.1:38068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-07-24T17:31:29.002747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.847092ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-24T17:31:29.002926Z","caller":"traceutil/trace.go:171","msg":"trace[1963142654] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"558.003848ms","start":"2026-07-24T17:31:28.444887Z","end":"2026-07-24T17:31:29.002891Z","steps":["trace[1963142654] 'read index received' (duration: 288.814607ms)","trace[1963142654] 'applied index is now lower than readState.Index' (duration: 269.186761ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:29.003072Z","caller":"traceutil/trace.go:171","msg":"trace[445963150] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"550.604653ms","start":"2026-07-24T17:31:28.452451Z","end":"2026-07-24T17:31:29.003056Z","steps":["trace[445963150] 'process raft request' (duration: 550.560262ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.003086Z","caller":"traceutil/trace.go:171","msg":"trace[2083127482] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"558.226693ms","start":"2026-07-24T17:31:28.444846Z","end":"2026-07-24T17:31:29.003073Z","steps":["trace[2083127482] 'process raft request' (duration: 288.854808ms)","trace[2083127482] 'compare' (duration: 268.73807ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:31:29.003145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.452429Z","time spent":"550.681806ms","remote":"127.0.0.1:38138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:31:29.003179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.444828Z","time spent":"558.287386ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:29.003384Z","caller":"traceutil/trace.go:171","msg":"trace[58392908] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"556.943221ms","start":"2026-07-24T17:31:28.446432Z","end":"2026-07-24T17:31:29.003376Z","steps":["trace[58392908] 'process raft request' (duration: 556.493749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.42525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-24T17:31:29.003431Z","caller":"traceutil/trace.go:171","msg":"trace[156518345] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"499.510624ms","start":"2026-07-24T17:31:28.503906Z","end":"2026-07-24T17:31:29.003417Z","steps":["trace[156518345] 'agreement among raft nodes before linearized reading' (duration: 499.313719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.503892Z","time spent":"499.576875ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-07-24T17:31:29.003491Z","caller":"traceutil/trace.go:171","msg":"trace[232651401] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"556.256491ms","start":"2026-07-24T17:31:28.447218Z","end":"2026-07-24T17:31:29.003474Z","steps":["trace[232651401] 'process raft request' (duration: 555.774708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.577443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-24T17:31:29.003515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.366969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-24T17:31:29.003544Z","caller":"traceutil/trace.go:171","msg":"trace[531943665] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:20; }","duration":"558.680326ms","start":"2026-07-24T17:31:28.444849Z","end":"2026-07-24T17:31:29.003529Z","steps":["trace[531943665] 'agreement among raft nodes before linearized reading' (duration: 558.573523ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.003591Z","caller":"traceutil/trace.go:171","msg":"trace[1783890350] transaction","detail":"{read_only:false; number_of_response:0; response_revision:17; }","duration":"557.073804ms","start":"2026-07-24T17:31:28.446509Z","end":"2026-07-24T17:31:29.003583Z","steps":["trace[1783890350] 'process raft request' (duration: 556.432457ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.0036Z","caller":"traceutil/trace.go:171","msg":"trace[93799789] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"356.488131ms","start":"2026-07-24T17:31:28.647093Z","end":"2026-07-24T17:31:29.003581Z","steps":["trace[93799789] 'agreement among raft nodes before linearized reading' (duration: 356.376668ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.003604Z","caller":"traceutil/trace.go:171","msg":"trace[162407117] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"558.179652ms","start":"2026-07-24T17:31:28.44537Z","end":"2026-07-24T17:31:29.003549Z","steps":["trace[162407117] 'process raft request' (duration: 557.485534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.444829Z","time spent":"558.808108ms","remote":"127.0.0.1:38320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":26,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-07-24T17:31:29.003673Z","caller":"traceutil/trace.go:171","msg":"trace[105968057] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"556.685003ms","start":"2026-07-24T17:31:28.446982Z","end":"2026-07-24T17:31:29.003667Z","steps":["trace[105968057] 'process raft request' (duration: 555.973894ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446413Z","time spent":"556.995222ms","remote":"127.0.0.1:38322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.003728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446966Z","time spent":"556.742155ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.003747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.44536Z","time spent":"558.332926ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.003666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.647073Z","time spent":"356.579564ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"warn","ts":"2026-07-24T17:31:29.0038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.19512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-24T17:31:29.003712Z","caller":"traceutil/trace.go:171","msg":"trace[1427045591] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"557.260519ms","start":"2026-07-24T17:31:28.446309Z","end":"2026-07-24T17:31:29.003569Z","steps":["trace[1427045591] 'process raft request' (duration: 556.56434ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.00339Z","caller":"traceutil/trace.go:171","msg":"trace[1138846807] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"556.988542ms","start":"2026-07-24T17:31:28.446375Z","end":"2026-07-24T17:31:29.003363Z","steps":["trace[1138846807] 'process raft request' (duration: 556.525209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.22361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-24T17:31:29.00393Z","caller":"traceutil/trace.go:171","msg":"trace[1828095611] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"506.27763ms","start":"2026-07-24T17:31:28.497645Z","end":"2026-07-24T17:31:29.003923Z","steps":["trace[1828095611] 'agreement among raft nodes before linearized reading' (duration: 506.230179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.003947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.92469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-07-24T17:31:29.003985Z","caller":"traceutil/trace.go:171","msg":"trace[1354784313] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20; }","duration":"556.991702ms","start":"2026-07-24T17:31:28.446984Z","end":"2026-07-24T17:31:29.003976Z","steps":["trace[1354784313] 'agreement among raft nodes before linearized reading' (duration: 556.92527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.004027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446975Z","time spent":"557.044013ms","remote":"127.0.0.1:38138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3513,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-24T17:31:29.004041Z","caller":"traceutil/trace.go:171","msg":"trace[1659153284] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"558.730747ms","start":"2026-07-24T17:31:28.445301Z","end":"2026-07-24T17:31:29.004032Z","steps":["trace[1659153284] 'process raft request' (duration: 557.521245ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.004054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.772822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-tlkv9\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-07-24T17:31:29.004087Z","caller":"traceutil/trace.go:171","msg":"trace[1605263176] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-tlkv9; range_end:; response_count:1; response_revision:20; }","duration":"557.830763ms","start":"2026-07-24T17:31:28.446248Z","end":"2026-07-24T17:31:29.004079Z","steps":["trace[1605263176] 'agreement among raft nodes before linearized reading' (duration: 557.773352ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:29.003856Z","caller":"traceutil/trace.go:171","msg":"trace[1112481322] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"506.297162ms","start":"2026-07-24T17:31:28.497546Z","end":"2026-07-24T17:31:29.003843Z","steps":["trace[1112481322] 'agreement among raft nodes before linearized reading' (duration: 506.203479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.004119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.445281Z","time spent":"558.791458ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.004165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.497522Z","time spent":"506.6283ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-24T17:31:29.003642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446477Z","time spent":"557.144106ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":26,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.003992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.497633Z","time spent":"506.332602ms","remote":"127.0.0.1:38084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":372,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-24T17:31:29.003553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.447131Z","time spent":"556.394356ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.004123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446238Z","time spent":"557.876765ms","remote":"127.0.0.1:38216","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":883,"request content":"key:\"/registry/certificatesigningrequests/csr-tlkv9\" "} {"level":"warn","ts":"2026-07-24T17:31:29.003977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446354Z","time spent":"557.573348ms","remote":"127.0.0.1:38402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:31:29.004475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.339933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-24T17:31:29.00456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.446298Z","time spent":"557.624538ms","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:31:29.004592Z","caller":"traceutil/trace.go:171","msg":"trace[1517558860] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"559.554599ms","start":"2026-07-24T17:31:28.445008Z","end":"2026-07-24T17:31:29.004562Z","steps":["trace[1517558860] 'agreement among raft nodes before linearized reading' (duration: 558.280646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:29.005395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:28.445002Z","time spent":"560.37118ms","remote":"127.0.0.1:37972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-24T17:31:35.941505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.770626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:31:35.941791Z","caller":"traceutil/trace.go:171","msg":"trace[552954818] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:355; }","duration":"238.080665ms","start":"2026-07-24T17:31:35.703533Z","end":"2026-07-24T17:31:35.941614Z","steps":["trace[552954818] 'read index received' (duration: 83.033932ms)","trace[552954818] 'applied index is now lower than readState.Index' (duration: 155.045553ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:35.941709Z","caller":"traceutil/trace.go:171","msg":"trace[1924197958] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"267.284761ms","start":"2026-07-24T17:31:35.674373Z","end":"2026-07-24T17:31:35.941658Z","steps":["trace[1924197958] 'process raft request' (duration: 112.29181ms)","trace[1924197958] 'compare' (duration: 154.659393ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:31:35.941984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.075408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-24T17:31:35.942078Z","caller":"traceutil/trace.go:171","msg":"trace[2107262245] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:348; }","duration":"189.19866ms","start":"2026-07-24T17:31:35.752867Z","end":"2026-07-24T17:31:35.942065Z","steps":["trace[2107262245] 'agreement among raft nodes before linearized reading' (duration: 189.039646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:35.942059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.512857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-24T17:31:35.942212Z","caller":"traceutil/trace.go:171","msg":"trace[1688772067] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:348; }","duration":"238.696921ms","start":"2026-07-24T17:31:35.70349Z","end":"2026-07-24T17:31:35.942187Z","steps":["trace[1688772067] 'agreement among raft nodes before linearized reading' (duration: 238.405054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:35.942415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.754265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-24T17:31:35.942502Z","caller":"traceutil/trace.go:171","msg":"trace[176484900] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:348; }","duration":"138.89772ms","start":"2026-07-24T17:31:35.803583Z","end":"2026-07-24T17:31:35.942481Z","steps":["trace[176484900] 'agreement among raft nodes before linearized reading' (duration: 138.680263ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.085913Z","caller":"traceutil/trace.go:171","msg":"trace[311406424] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"137.334418ms","start":"2026-07-24T17:31:35.948551Z","end":"2026-07-24T17:31:36.085886Z","steps":["trace[311406424] 'process raft request' (duration: 93.471576ms)","trace[311406424] 'compare' (duration: 43.729459ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:36.143088Z","caller":"traceutil/trace.go:171","msg":"trace[1424619330] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:356; }","duration":"190.474675ms","start":"2026-07-24T17:31:35.95258Z","end":"2026-07-24T17:31:36.143055Z","steps":["trace[1424619330] 'read index received' (duration: 89.44073ms)","trace[1424619330] 'applied index is now lower than readState.Index' (duration: 101.032725ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:36.143226Z","caller":"traceutil/trace.go:171","msg":"trace[1506956671] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"192.145308ms","start":"2026-07-24T17:31:35.951067Z","end":"2026-07-24T17:31:36.143213Z","steps":["trace[1506956671] 'process raft request' (duration: 191.923992ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.143138Z","caller":"traceutil/trace.go:171","msg":"trace[382307496] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"193.434182ms","start":"2026-07-24T17:31:35.949665Z","end":"2026-07-24T17:31:36.143099Z","steps":["trace[382307496] 'process raft request' (duration: 193.203196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:36.143385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.783393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-24T17:31:36.143425Z","caller":"traceutil/trace.go:171","msg":"trace[762602950] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:351; }","duration":"190.866015ms","start":"2026-07-24T17:31:35.952549Z","end":"2026-07-24T17:31:36.143415Z","steps":["trace[762602950] 'agreement among raft nodes before linearized reading' (duration: 190.72713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:36.165662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.440467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-07-24T17:31:36.165735Z","caller":"traceutil/trace.go:171","msg":"trace[204975291] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:352; }","duration":"162.55671ms","start":"2026-07-24T17:31:36.003158Z","end":"2026-07-24T17:31:36.165714Z","steps":["trace[204975291] 'agreement among raft nodes before linearized reading' (duration: 162.419387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:36.165709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.56874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-24T17:31:36.165817Z","caller":"traceutil/trace.go:171","msg":"trace[1926493678] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"111.719065ms","start":"2026-07-24T17:31:36.054076Z","end":"2026-07-24T17:31:36.165795Z","steps":["trace[1926493678] 'agreement among raft nodes before linearized reading' (duration: 111.492079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:36.474701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.151759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:31:36.475068Z","caller":"traceutil/trace.go:171","msg":"trace[672460836] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"174.850834ms","start":"2026-07-24T17:31:36.300108Z","end":"2026-07-24T17:31:36.474959Z","steps":["trace[672460836] 'process raft request' (duration: 44.314925ms)","trace[672460836] 'compare' (duration: 129.977784ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:36.475149Z","caller":"traceutil/trace.go:171","msg":"trace[420103261] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:376; }","duration":"171.883546ms","start":"2026-07-24T17:31:36.303253Z","end":"2026-07-24T17:31:36.475137Z","steps":["trace[420103261] 'read index received' (duration: 41.115641ms)","trace[420103261] 'applied index is now lower than readState.Index' (duration: 130.766765ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:36.475132Z","caller":"traceutil/trace.go:171","msg":"trace[261855163] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"173.046006ms","start":"2026-07-24T17:31:36.302054Z","end":"2026-07-24T17:31:36.4751Z","steps":["trace[261855163] 'process raft request' (duration: 172.914692ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.475373Z","caller":"traceutil/trace.go:171","msg":"trace[1397603575] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"172.874292ms","start":"2026-07-24T17:31:36.302484Z","end":"2026-07-24T17:31:36.475358Z","steps":["trace[1397603575] 'process raft request' (duration: 172.577414ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.47561Z","caller":"traceutil/trace.go:171","msg":"trace[1651692869] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"173.369835ms","start":"2026-07-24T17:31:36.302228Z","end":"2026-07-24T17:31:36.475598Z","steps":["trace[1651692869] 'process raft request' (duration: 172.78747ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:36.475607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.311387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-07-24T17:31:36.475676Z","caller":"traceutil/trace.go:171","msg":"trace[514406246] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:374; }","duration":"172.430739ms","start":"2026-07-24T17:31:36.303224Z","end":"2026-07-24T17:31:36.475655Z","steps":["trace[514406246] 'agreement among raft nodes before linearized reading' (duration: 172.254365ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.475695Z","caller":"traceutil/trace.go:171","msg":"trace[2071404487] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"173.125428ms","start":"2026-07-24T17:31:36.302561Z","end":"2026-07-24T17:31:36.475687Z","steps":["trace[2071404487] 'process raft request' (duration: 172.530612ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.475274Z","caller":"traceutil/trace.go:171","msg":"trace[136866427] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"173.228532ms","start":"2026-07-24T17:31:36.302034Z","end":"2026-07-24T17:31:36.475263Z","steps":["trace[136866427] 'process raft request' (duration: 172.852931ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.699848Z","caller":"traceutil/trace.go:171","msg":"trace[783391229] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"216.483717ms","start":"2026-07-24T17:31:36.483347Z","end":"2026-07-24T17:31:36.69983Z","steps":["trace[783391229] 'process raft request' (duration: 163.833275ms)","trace[783391229] 'compare' (duration: 52.16116ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:36.699876Z","caller":"traceutil/trace.go:171","msg":"trace[925593783] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"213.297123ms","start":"2026-07-24T17:31:36.486557Z","end":"2026-07-24T17:31:36.699855Z","steps":["trace[925593783] 'process raft request' (duration: 212.987615ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.699907Z","caller":"traceutil/trace.go:171","msg":"trace[1051121330] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"214.193667ms","start":"2026-07-24T17:31:36.485696Z","end":"2026-07-24T17:31:36.699889Z","steps":["trace[1051121330] 'process raft request' (duration: 213.811957ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.700094Z","caller":"traceutil/trace.go:171","msg":"trace[1573495018] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"203.013373ms","start":"2026-07-24T17:31:36.497Z","end":"2026-07-24T17:31:36.700013Z","steps":["trace[1573495018] 'process raft request' (duration: 202.590662ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.700188Z","caller":"traceutil/trace.go:171","msg":"trace[1618905646] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"191.125681ms","start":"2026-07-24T17:31:36.509055Z","end":"2026-07-24T17:31:36.700181Z","steps":["trace[1618905646] 'process raft request' (duration: 190.562096ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.700296Z","caller":"traceutil/trace.go:171","msg":"trace[735828889] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"183.391738ms","start":"2026-07-24T17:31:36.516898Z","end":"2026-07-24T17:31:36.70029Z","steps":["trace[735828889] 'process raft request' (duration: 182.750641ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:36.959406Z","caller":"traceutil/trace.go:171","msg":"trace[2138742039] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"170.640613ms","start":"2026-07-24T17:31:36.78873Z","end":"2026-07-24T17:31:36.95937Z","steps":["trace[2138742039] 'process raft request' (duration: 157.651293ms)","trace[2138742039] 'compare' (duration: 12.768565ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:31:38.221054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.277599ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:31:38.221153Z","caller":"traceutil/trace.go:171","msg":"trace[1385292215] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"1.255471562s","start":"2026-07-24T17:31:36.965666Z","end":"2026-07-24T17:31:38.221137Z","steps":["trace[1385292215] 'process raft request' (duration: 341.024949ms)","trace[1385292215] 'compare' (duration: 914.119515ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:31:38.221194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:36.965642Z","time spent":"1.255535014s","remote":"127.0.0.1:38412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4041,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:31:38.413847Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.107160968s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-24T17:31:38.999034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.802413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:31:38.999171Z","caller":"traceutil/trace.go:171","msg":"trace[1898351638] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"2.027689881s","start":"2026-07-24T17:31:36.971452Z","end":"2026-07-24T17:31:38.999142Z","steps":["trace[1898351638] 'process raft request' (duration: 1.442712342s)","trace[1898351638] 'compare' (duration: 584.602288ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:38.999127Z","caller":"traceutil/trace.go:171","msg":"trace[1757381760] linearizableReadLoop","detail":"{readStateIndex:397; appliedIndex:395; }","duration":"1.944779583s","start":"2026-07-24T17:31:37.054332Z","end":"2026-07-24T17:31:38.999112Z","steps":["trace[1757381760] 'read index received' (duration: 252.37325ms)","trace[1757381760] 'applied index is now lower than readState.Index' (duration: 1.692405603s)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:31:38.999268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.944936016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-24T17:31:38.999303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:36.971439Z","time spent":"2.027795954s","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:31:38.999307Z","caller":"traceutil/trace.go:171","msg":"trace[1064941504] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:389; }","duration":"1.945008158s","start":"2026-07-24T17:31:37.054288Z","end":"2026-07-24T17:31:38.999296Z","steps":["trace[1064941504] 'agreement among raft nodes before linearized reading' (duration: 1.944925736s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:38.99934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:37.054269Z","time spent":"1.945065369s","remote":"127.0.0.1:38230","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":"warn","ts":"2026-07-24T17:31:38.999434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.911554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:31:38.999457Z","caller":"traceutil/trace.go:171","msg":"trace[1854440888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"649.964685ms","start":"2026-07-24T17:31:38.349486Z","end":"2026-07-24T17:31:38.99945Z","steps":["trace[1854440888] 'agreement among raft nodes before linearized reading' (duration: 649.917484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:38.999472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:38.349469Z","time spent":"650.000306ms","remote":"127.0.0.1:37960","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-07-24T17:31:38.999437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.936514025s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-24T17:31:38.999519Z","caller":"traceutil/trace.go:171","msg":"trace[1796448659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:389; }","duration":"1.936646158s","start":"2026-07-24T17:31:37.062854Z","end":"2026-07-24T17:31:38.9995Z","steps":["trace[1796448659] 'agreement among raft nodes before linearized reading' (duration: 1.936465794s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:38.99956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.768609724s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-24T17:31:38.999563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:37.062828Z","time spent":"1.93672657s","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-24T17:31:38.999592Z","caller":"traceutil/trace.go:171","msg":"trace[2061878116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:389; }","duration":"1.768675766s","start":"2026-07-24T17:31:37.230907Z","end":"2026-07-24T17:31:38.999583Z","steps":["trace[2061878116] 'agreement among raft nodes before linearized reading' (duration: 1.768618784s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:38.999543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.354819053s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:31:38.999619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:37.230887Z","time spent":"1.768723676s","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-24T17:31:38.999666Z","caller":"traceutil/trace.go:171","msg":"trace[1553604955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"1.355040698s","start":"2026-07-24T17:31:37.644591Z","end":"2026-07-24T17:31:38.999632Z","steps":["trace[1553604955] 'agreement among raft nodes before linearized reading' (duration: 1.354856743s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:38.999723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:31:37.644568Z","time spent":"1.355144251s","remote":"127.0.0.1:37972","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-07-24T17:31:39.180419Z","caller":"traceutil/trace.go:171","msg":"trace[1265891151] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"177.38577ms","start":"2026-07-24T17:31:39.003009Z","end":"2026-07-24T17:31:39.180395Z","steps":["trace[1265891151] 'process raft request' (duration: 168.603029ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:39.180656Z","caller":"traceutil/trace.go:171","msg":"trace[1484633549] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"177.146944ms","start":"2026-07-24T17:31:39.003492Z","end":"2026-07-24T17:31:39.180639Z","steps":["trace[1484633549] 'process raft request' (duration: 176.852215ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:39.180814Z","caller":"traceutil/trace.go:171","msg":"trace[818883673] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"175.242603ms","start":"2026-07-24T17:31:39.005548Z","end":"2026-07-24T17:31:39.18079Z","steps":["trace[818883673] 'process raft request' (duration: 175.09847ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:39.180854Z","caller":"traceutil/trace.go:171","msg":"trace[1668280900] linearizableReadLoop","detail":"{readStateIndex:399; appliedIndex:397; }","duration":"176.145447ms","start":"2026-07-24T17:31:39.004684Z","end":"2026-07-24T17:31:39.180829Z","steps":["trace[1668280900] 'read index received' (duration: 166.943886ms)","trace[1668280900] 'applied index is now lower than readState.Index' (duration: 9.200761ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:31:39.181043Z","caller":"traceutil/trace.go:171","msg":"trace[413827914] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"173.533828ms","start":"2026-07-24T17:31:39.007492Z","end":"2026-07-24T17:31:39.181026Z","steps":["trace[413827914] 'process raft request' (duration: 173.259561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:31:39.181176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:31:39.181191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.452976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-07-24T17:31:39.181225Z","caller":"traceutil/trace.go:171","msg":"trace[160564880] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:393; }","duration":"176.558959ms","start":"2026-07-24T17:31:39.004657Z","end":"2026-07-24T17:31:39.181216Z","steps":["trace[160564880] 'agreement among raft nodes before linearized reading' (duration: 176.441486ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:31:39.181219Z","caller":"traceutil/trace.go:171","msg":"trace[1069285339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:393; }","duration":"174.435723ms","start":"2026-07-24T17:31:39.006772Z","end":"2026-07-24T17:31:39.181207Z","steps":["trace[1069285339] 'agreement among raft nodes before linearized reading' (duration: 174.253617ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:05.263891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.790881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329956"} {"level":"info","ts":"2026-07-24T17:32:05.263991Z","caller":"traceutil/trace.go:171","msg":"trace[2128182876] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:526; }","duration":"134.929535ms","start":"2026-07-24T17:32:05.12904Z","end":"2026-07-24T17:32:05.26397Z","steps":["trace[2128182876] 'range keys from in-memory index tree' (duration: 134.451222ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:07.337326Z","caller":"traceutil/trace.go:171","msg":"trace[336964730] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"620.313856ms","start":"2026-07-24T17:32:06.716988Z","end":"2026-07-24T17:32:07.337302Z","steps":["trace[336964730] 'process raft request' (duration: 620.142232ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.337939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.716963Z","time spent":"620.599655ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:32:07.429185Z","caller":"traceutil/trace.go:171","msg":"trace[1164419177] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"705.636977ms","start":"2026-07-24T17:32:06.723495Z","end":"2026-07-24T17:32:07.429131Z","steps":["trace[1164419177] 'process raft request' (duration: 689.69896ms)","trace[1164419177] 'compare' (duration: 15.576508ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:07.429223Z","caller":"traceutil/trace.go:171","msg":"trace[1828596004] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"705.638149ms","start":"2026-07-24T17:32:06.723542Z","end":"2026-07-24T17:32:07.42918Z","steps":["trace[1828596004] 'process raft request' (duration: 705.447953ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.429388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.723537Z","time spent":"705.777912ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:07.429388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.723478Z","time spent":"705.817313ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.429256Z","caller":"traceutil/trace.go:171","msg":"trace[325902061] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"699.515547ms","start":"2026-07-24T17:32:06.729696Z","end":"2026-07-24T17:32:07.429212Z","steps":["trace[325902061] 'process raft request' (duration: 699.352892ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:07.429619Z","caller":"traceutil/trace.go:171","msg":"trace[793989532] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"698.220983ms","start":"2026-07-24T17:32:06.731374Z","end":"2026-07-24T17:32:07.429595Z","steps":["trace[793989532] 'process raft request' (duration: 697.72143ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.429696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.731367Z","time spent":"698.291765ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.429701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.729685Z","time spent":"699.868927ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.430069Z","caller":"traceutil/trace.go:171","msg":"trace[1111772373] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"698.637824ms","start":"2026-07-24T17:32:06.731413Z","end":"2026-07-24T17:32:07.430051Z","steps":["trace[1111772373] 'process raft request' (duration: 697.72958ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:07.43014Z","caller":"traceutil/trace.go:171","msg":"trace[706258558] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"696.094877ms","start":"2026-07-24T17:32:06.734019Z","end":"2026-07-24T17:32:07.430114Z","steps":["trace[706258558] 'process raft request' (duration: 695.964694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.43025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.734004Z","time spent":"696.19406ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:07.430276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.731409Z","time spent":"698.709626ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.430384Z","caller":"traceutil/trace.go:171","msg":"trace[918180347] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"547.718059ms","start":"2026-07-24T17:32:06.882655Z","end":"2026-07-24T17:32:07.430373Z","steps":["trace[918180347] 'process raft request' (duration: 547.673338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.430439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.882632Z","time spent":"547.78339ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:32:07.430503Z","caller":"traceutil/trace.go:171","msg":"trace[259541881] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"695.933143ms","start":"2026-07-24T17:32:06.734564Z","end":"2026-07-24T17:32:07.430497Z","steps":["trace[259541881] 'process raft request' (duration: 695.477952ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.430538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.734551Z","time spent":"695.973604ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.4306Z","caller":"traceutil/trace.go:171","msg":"trace[1199699943] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"689.67709ms","start":"2026-07-24T17:32:06.740915Z","end":"2026-07-24T17:32:07.430592Z","steps":["trace[1199699943] 'process raft request' (duration: 689.178066ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:07.430572Z","caller":"traceutil/trace.go:171","msg":"trace[1320712100] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"677.404506ms","start":"2026-07-24T17:32:06.753138Z","end":"2026-07-24T17:32:07.430543Z","steps":["trace[1320712100] 'process raft request' (duration: 677.009636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.430647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.740899Z","time spent":"689.728561ms","remote":"127.0.0.1:38032","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-07-24T17:32:07.430618Z","caller":"traceutil/trace.go:171","msg":"trace[1783214063] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"654.907546ms","start":"2026-07-24T17:32:06.775685Z","end":"2026-07-24T17:32:07.430592Z","steps":["trace[1783214063] 'process raft request' (duration: 654.576297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:07.430714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.753121Z","time spent":"677.52468ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:07.430844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:06.775667Z","time spent":"655.134222ms","remote":"127.0.0.1:38032","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-07-24T17:32:08.459899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.464684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:32:08.460161Z","caller":"traceutil/trace.go:171","msg":"trace[558514996] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"1.117114698s","start":"2026-07-24T17:32:07.343012Z","end":"2026-07-24T17:32:08.460127Z","steps":["trace[558514996] 'process raft request' (duration: 191.344978ms)","trace[558514996] 'compare' (duration: 925.300538ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:08.460269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.34299Z","time spent":"1.117224232s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:32:08.4616Z","caller":"traceutil/trace.go:171","msg":"trace[305404018] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"1.11606851s","start":"2026-07-24T17:32:07.345503Z","end":"2026-07-24T17:32:08.461572Z","steps":["trace[305404018] 'process raft request' (duration: 1.114489169s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.461692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.345493Z","time spent":"1.116143852s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:08.461965Z","caller":"traceutil/trace.go:171","msg":"trace[1274865549] transaction","detail":"{read_only:false; number_of_response:1; response_revision:546; }","duration":"1.116332138s","start":"2026-07-24T17:32:07.345614Z","end":"2026-07-24T17:32:08.461946Z","steps":["trace[1274865549] 'process raft request' (duration: 1.114923041s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.462079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.345573Z","time spent":"1.11644577s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:08.462402Z","caller":"traceutil/trace.go:171","msg":"trace[314068410] linearizableReadLoop","detail":"{readStateIndex:560; appliedIndex:548; }","duration":"1.118812943s","start":"2026-07-24T17:32:07.34355Z","end":"2026-07-24T17:32:08.462363Z","steps":["trace[314068410] 'read index received' (duration: 69.658791ms)","trace[314068410] 'applied index is now lower than readState.Index' (duration: 1.048956707s)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:08.462868Z","caller":"traceutil/trace.go:171","msg":"trace[1893021447] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"1.018389995s","start":"2026-07-24T17:32:07.444458Z","end":"2026-07-24T17:32:08.462848Z","steps":["trace[1893021447] 'process raft request' (duration: 1.017484922s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:08.462944Z","caller":"traceutil/trace.go:171","msg":"trace[1180818552] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.018286471s","start":"2026-07-24T17:32:07.444642Z","end":"2026-07-24T17:32:08.462929Z","steps":["trace[1180818552] 'process raft request' (duration: 1.017695115s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.463062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.444633Z","time spent":"1.018397774s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:32:08.463574Z","caller":"traceutil/trace.go:171","msg":"trace[1817248085] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.018880677s","start":"2026-07-24T17:32:07.444682Z","end":"2026-07-24T17:32:08.463563Z","steps":["trace[1817248085] 'process raft request' (duration: 1.017728086s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.463628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.444678Z","time spent":"1.018930728s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:08.464198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12058054s","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-07-24T17:32:08.464549Z","caller":"traceutil/trace.go:171","msg":"trace[225421348] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.015417416s","start":"2026-07-24T17:32:07.449114Z","end":"2026-07-24T17:32:08.464531Z","steps":["trace[225421348] 'process raft request' (duration: 1.013875295s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:08.464307Z","caller":"traceutil/trace.go:171","msg":"trace[467991927] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:549; }","duration":"1.120764424s","start":"2026-07-24T17:32:07.34352Z","end":"2026-07-24T17:32:08.464284Z","steps":["trace[467991927] 'agreement among raft nodes before linearized reading' (duration: 1.118792802s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.464662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.343511Z","time spent":"1.121135055s","remote":"127.0.0.1:38230","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-07-24T17:32:08.464663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.449095Z","time spent":"1.015501098s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:32:08.465473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.444431Z","time spent":"1.021009383s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-24T17:32:08.466117Z","caller":"traceutil/trace.go:171","msg":"trace[1064240914] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.016935387s","start":"2026-07-24T17:32:07.449164Z","end":"2026-07-24T17:32:08.466099Z","steps":["trace[1064240914] 'process raft request' (duration: 1.015115738s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:08.471339Z","caller":"traceutil/trace.go:171","msg":"trace[1551814477] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.014127743s","start":"2026-07-24T17:32:07.452052Z","end":"2026-07-24T17:32:08.46618Z","steps":["trace[1551814477] 'process raft request' (duration: 1.013985999s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.471411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.45204Z","time spent":"1.019337449s","remote":"127.0.0.1:38480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:08.471455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.449142Z","time spent":"1.017026888s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:08.471609Z","caller":"traceutil/trace.go:171","msg":"trace[1783297659] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.015855178s","start":"2026-07-24T17:32:07.455747Z","end":"2026-07-24T17:32:08.471603Z","steps":["trace[1783297659] 'process raft request' (duration: 1.010343924s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.471643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.455734Z","time spent":"1.01589091s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:32:08.472016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126599446s","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-07-24T17:32:08.472063Z","caller":"traceutil/trace.go:171","msg":"trace[1872096007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"1.126668289s","start":"2026-07-24T17:32:07.345383Z","end":"2026-07-24T17:32:08.472052Z","steps":["trace[1872096007] 'agreement among raft nodes before linearized reading' (duration: 1.126576326s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.472094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.345222Z","time spent":"1.126864364s","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-24T17:32:08.472176Z","caller":"traceutil/trace.go:171","msg":"trace[840876011] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.013279919s","start":"2026-07-24T17:32:07.458887Z","end":"2026-07-24T17:32:08.472167Z","steps":["trace[840876011] 'process raft request' (duration: 1.012733116s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.472232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.458865Z","time spent":"1.013336581s","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:08.472312Z","caller":"traceutil/trace.go:171","msg":"trace[404254906] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"976.573815ms","start":"2026-07-24T17:32:07.495727Z","end":"2026-07-24T17:32:08.472301Z","steps":["trace[404254906] 'process raft request' (duration: 976.189285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.472362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.4957Z","time spent":"976.639988ms","remote":"127.0.0.1:38032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:08.47247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.166703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:32:08.4725Z","caller":"traceutil/trace.go:171","msg":"trace[1605162561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:555; }","duration":"124.230475ms","start":"2026-07-24T17:32:08.348262Z","end":"2026-07-24T17:32:08.472493Z","steps":["trace[1605162561] 'agreement among raft nodes before linearized reading' (duration: 124.161463ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.472689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.123058304s","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-07-24T17:32:08.472722Z","caller":"traceutil/trace.go:171","msg":"trace[1613791507] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"1.123109825s","start":"2026-07-24T17:32:07.349604Z","end":"2026-07-24T17:32:08.472714Z","steps":["trace[1613791507] 'agreement among raft nodes before linearized reading' (duration: 1.123048254s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.472746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.349593Z","time spent":"1.123146676s","remote":"127.0.0.1:38230","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-07-24T17:32:08.475856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126173996s","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-07-24T17:32:08.475963Z","caller":"traceutil/trace.go:171","msg":"trace[209443102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:555; }","duration":"1.126280779s","start":"2026-07-24T17:32:07.349627Z","end":"2026-07-24T17:32:08.475908Z","steps":["trace[209443102] 'agreement among raft nodes before linearized reading' (duration: 1.122923261s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:08.475997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:07.349617Z","time spent":"1.126373851s","remote":"127.0.0.1:38230","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":"info","ts":"2026-07-24T17:32:10.252042Z","caller":"traceutil/trace.go:171","msg":"trace[788399225] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"199.113771ms","start":"2026-07-24T17:32:10.052893Z","end":"2026-07-24T17:32:10.252007Z","steps":["trace[788399225] 'process raft request' (duration: 198.839994ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:10.750691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.269447ms","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-07-24T17:32:10.750747Z","caller":"traceutil/trace.go:171","msg":"trace[1755447410] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"271.368409ms","start":"2026-07-24T17:32:10.479367Z","end":"2026-07-24T17:32:10.750736Z","steps":["trace[1755447410] 'range keys from in-memory index tree' (duration: 271.157145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:10.750958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.909028ms","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-07-24T17:32:10.750972Z","caller":"traceutil/trace.go:171","msg":"trace[1275124372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"259.958649ms","start":"2026-07-24T17:32:10.491008Z","end":"2026-07-24T17:32:10.750967Z","steps":["trace[1275124372] 'range keys from in-memory index tree' (duration: 259.784765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:10.751054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.780517ms","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-07-24T17:32:10.751065Z","caller":"traceutil/trace.go:171","msg":"trace[274864215] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"245.817718ms","start":"2026-07-24T17:32:10.505244Z","end":"2026-07-24T17:32:10.751062Z","steps":["trace[274864215] 'range keys from in-memory index tree' (duration: 245.678845ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:10.751141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.516595ms","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-07-24T17:32:10.751154Z","caller":"traceutil/trace.go:171","msg":"trace[1193224312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"233.559077ms","start":"2026-07-24T17:32:10.51759Z","end":"2026-07-24T17:32:10.75115Z","steps":["trace[1193224312] 'range keys from in-memory index tree' (duration: 233.379761ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:12.758037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.544715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:32:12.758213Z","caller":"traceutil/trace.go:171","msg":"trace[1694967569] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"144.741902ms","start":"2026-07-24T17:32:12.613455Z","end":"2026-07-24T17:32:12.758197Z","steps":["trace[1694967569] 'process raft request' (duration: 144.685881ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:12.758296Z","caller":"traceutil/trace.go:171","msg":"trace[1489205922] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"289.223208ms","start":"2026-07-24T17:32:12.469032Z","end":"2026-07-24T17:32:12.758255Z","steps":["trace[1489205922] 'process raft request' (duration: 181.387996ms)","trace[1489205922] 'compare' (duration: 107.411072ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:15.199334Z","caller":"traceutil/trace.go:171","msg":"trace[120284984] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"398.371136ms","start":"2026-07-24T17:32:14.800934Z","end":"2026-07-24T17:32:15.199305Z","steps":["trace[120284984] 'read index received' (duration: 397.629317ms)","trace[120284984] 'applied index is now lower than readState.Index' (duration: 740.459µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:15.199478Z","caller":"traceutil/trace.go:171","msg":"trace[1923928972] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"422.577551ms","start":"2026-07-24T17:32:14.776887Z","end":"2026-07-24T17:32:15.199465Z","steps":["trace[1923928972] 'process raft request' (duration: 421.837152ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:15.199617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:14.776863Z","time spent":"422.644593ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:32:15.200114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.169977ms","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-07-24T17:32:15.200156Z","caller":"traceutil/trace.go:171","msg":"trace[1951898783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"399.239719ms","start":"2026-07-24T17:32:14.800904Z","end":"2026-07-24T17:32:15.200144Z","steps":["trace[1951898783] 'agreement among raft nodes before linearized reading' (duration: 398.953932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:15.200189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:14.800887Z","time spent":"399.29531ms","remote":"127.0.0.1:38230","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-07-24T17:32:15.381197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.14747ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-07-24T17:32:15.381356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.19698ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:32:15.381574Z","caller":"traceutil/trace.go:171","msg":"trace[635665500] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:635; }","duration":"165.385885ms","start":"2026-07-24T17:32:15.216142Z","end":"2026-07-24T17:32:15.381528Z","steps":["trace[635665500] 'range keys from in-memory index tree' (duration: 165.1864ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:15.381673Z","caller":"traceutil/trace.go:171","msg":"trace[144718715] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"182.235328ms","start":"2026-07-24T17:32:15.199421Z","end":"2026-07-24T17:32:15.381656Z","steps":["trace[144718715] 'read index received' (duration: 11.555524ms)","trace[144718715] 'applied index is now lower than readState.Index' (duration: 170.678354ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:15.381826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.102937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-24T17:32:15.381914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.376843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-24T17:32:15.381972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.719002ms","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-07-24T17:32:15.381954Z","caller":"traceutil/trace.go:171","msg":"trace[2113908823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:635; }","duration":"573.23129ms","start":"2026-07-24T17:32:14.808712Z","end":"2026-07-24T17:32:15.381943Z","steps":["trace[2113908823] 'agreement among raft nodes before linearized reading' (duration: 573.011515ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:15.382043Z","caller":"traceutil/trace.go:171","msg":"trace[702966643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"557.812444ms","start":"2026-07-24T17:32:14.824211Z","end":"2026-07-24T17:32:15.382023Z","steps":["trace[702966643] 'agreement among raft nodes before linearized reading' (duration: 557.500317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:15.382085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:14.824204Z","time spent":"557.874357ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-24T17:32:15.382011Z","caller":"traceutil/trace.go:171","msg":"trace[692056510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:635; }","duration":"557.516566ms","start":"2026-07-24T17:32:14.824467Z","end":"2026-07-24T17:32:15.381984Z","steps":["trace[692056510] 'agreement among raft nodes before linearized reading' (duration: 557.224259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:15.382098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:14.808645Z","time spent":"573.415654ms","remote":"127.0.0.1:38230","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-07-24T17:32:15.382169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:14.82445Z","time spent":"557.708251ms","remote":"127.0.0.1:38230","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":"info","ts":"2026-07-24T17:32:15.382314Z","caller":"traceutil/trace.go:171","msg":"trace[645325084] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"176.98897ms","start":"2026-07-24T17:32:15.205313Z","end":"2026-07-24T17:32:15.382302Z","steps":["trace[645325084] 'process raft request' (duration: 176.141577ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:15.382317Z","caller":"traceutil/trace.go:171","msg":"trace[491521313] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"110.115813ms","start":"2026-07-24T17:32:15.272185Z","end":"2026-07-24T17:32:15.382301Z","steps":["trace[491521313] 'process raft request' (duration: 110.049551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:17.01199Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.183097922s","expected-duration":"1s"} {"level":"info","ts":"2026-07-24T17:32:17.012525Z","caller":"traceutil/trace.go:171","msg":"trace[2003513395] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.183720409s","start":"2026-07-24T17:32:15.828785Z","end":"2026-07-24T17:32:17.012506Z","steps":["trace[2003513395] 'process raft request' (duration: 1.183467172s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:17.012707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:15.828765Z","time spent":"1.183833021s","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:17.186806Z","caller":"traceutil/trace.go:171","msg":"trace[79873236] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.330417782s","start":"2026-07-24T17:32:15.856341Z","end":"2026-07-24T17:32:17.186759Z","steps":["trace[79873236] 'process raft request' (duration: 1.32844122s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:17.187466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:15.856319Z","time spent":"1.331067219s","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:17.186733Z","caller":"traceutil/trace.go:171","msg":"trace[1700201248] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"541.201669ms","start":"2026-07-24T17:32:16.645432Z","end":"2026-07-24T17:32:17.186634Z","steps":["trace[1700201248] 'read index received' (duration: 366.775786ms)","trace[1700201248] 'applied index is now lower than readState.Index' (duration: 174.423833ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:17.188059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.388183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:32:17.188175Z","caller":"traceutil/trace.go:171","msg":"trace[710129524] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"542.757439ms","start":"2026-07-24T17:32:16.645382Z","end":"2026-07-24T17:32:17.18814Z","steps":["trace[710129524] 'agreement among raft nodes before linearized reading' (duration: 541.301361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:17.188239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:16.645361Z","time spent":"542.857471ms","remote":"127.0.0.1:37960","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-07-24T17:32:17.892883Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103924144123437,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-24T17:32:18.811909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.592616ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:32:18.812007Z","caller":"traceutil/trace.go:171","msg":"trace[1637990542] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"1.42552683s","start":"2026-07-24T17:32:17.386464Z","end":"2026-07-24T17:32:18.811991Z","steps":["trace[1637990542] 'read index received' (duration: 778.714709ms)","trace[1637990542] 'applied index is now lower than readState.Index' (duration: 646.811011ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:18.812335Z","caller":"traceutil/trace.go:171","msg":"trace[1951528444] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.570426207s","start":"2026-07-24T17:32:17.241891Z","end":"2026-07-24T17:32:18.812317Z","steps":["trace[1951528444] 'process raft request' (duration: 923.335068ms)","trace[1951528444] 'compare' (duration: 646.384581ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:18.812419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:17.241871Z","time spent":"1.570508679s","remote":"127.0.0.1:38464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-24T17:32:18.812444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.643142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:32:18.812518Z","caller":"traceutil/trace.go:171","msg":"trace[1239359265] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"460.765165ms","start":"2026-07-24T17:32:18.351732Z","end":"2026-07-24T17:32:18.812497Z","steps":["trace[1239359265] 'agreement among raft nodes before linearized reading' (duration: 460.593151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:18.812549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388158779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-24T17:32:18.81256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:18.35171Z","time spent":"460.842686ms","remote":"127.0.0.1:37960","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-07-24T17:32:18.812547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.396863827s","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-07-24T17:32:18.812629Z","caller":"traceutil/trace.go:171","msg":"trace[1014535189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"1.388241971s","start":"2026-07-24T17:32:17.42434Z","end":"2026-07-24T17:32:18.812582Z","steps":["trace[1014535189] 'agreement among raft nodes before linearized reading' (duration: 1.388071827s)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:18.812655Z","caller":"traceutil/trace.go:171","msg":"trace[35275127] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"1.397016991s","start":"2026-07-24T17:32:17.415616Z","end":"2026-07-24T17:32:18.812633Z","steps":["trace[35275127] 'agreement among raft nodes before linearized reading' (duration: 1.396703874s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:18.812669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:17.424325Z","time spent":"1.388335773s","remote":"127.0.0.1:38230","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-07-24T17:32:18.812703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:17.415593Z","time spent":"1.397099583s","remote":"127.0.0.1:38230","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-07-24T17:32:18.812702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.994774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:32:18.812827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426358543s","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-07-24T17:32:18.812845Z","caller":"traceutil/trace.go:171","msg":"trace[951672389] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"168.215181ms","start":"2026-07-24T17:32:18.644586Z","end":"2026-07-24T17:32:18.812801Z","steps":["trace[951672389] 'agreement among raft nodes before linearized reading' (duration: 167.925622ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:18.812875Z","caller":"traceutil/trace.go:171","msg":"trace[2121520702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"1.426445415s","start":"2026-07-24T17:32:17.386411Z","end":"2026-07-24T17:32:18.812857Z","steps":["trace[2121520702] 'agreement among raft nodes before linearized reading' (duration: 1.426013453s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:18.81292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:17.386391Z","time spent":"1.426519357s","remote":"127.0.0.1:38230","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-07-24T17:32:18.813066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388113908s","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-07-24T17:32:18.813115Z","caller":"traceutil/trace.go:171","msg":"trace[1299310776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"1.38817911s","start":"2026-07-24T17:32:17.424917Z","end":"2026-07-24T17:32:18.813096Z","steps":["trace[1299310776] 'agreement among raft nodes before linearized reading' (duration: 1.387461411s)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:18.813155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:17.424906Z","time spent":"1.388238301s","remote":"127.0.0.1:38230","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-07-24T17:32:19.967421Z","caller":"traceutil/trace.go:171","msg":"trace[917695342] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"133.365905ms","start":"2026-07-24T17:32:19.834037Z","end":"2026-07-24T17:32:19.967403Z","steps":["trace[917695342] 'process raft request' (duration: 133.211371ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:19.970817Z","caller":"traceutil/trace.go:171","msg":"trace[611655883] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"115.344161ms","start":"2026-07-24T17:32:19.855448Z","end":"2026-07-24T17:32:19.970792Z","steps":["trace[611655883] 'process raft request' (duration: 115.281659ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:19.970857Z","caller":"traceutil/trace.go:171","msg":"trace[630087814] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"130.208361ms","start":"2026-07-24T17:32:19.84062Z","end":"2026-07-24T17:32:19.970829Z","steps":["trace[630087814] 'process raft request' (duration: 129.959644ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:21.97079Z","caller":"traceutil/trace.go:171","msg":"trace[1830728240] linearizableReadLoop","detail":"{readStateIndex:717; appliedIndex:716; }","duration":"125.726923ms","start":"2026-07-24T17:32:21.845041Z","end":"2026-07-24T17:32:21.970768Z","steps":["trace[1830728240] 'read index received' (duration: 125.679261ms)","trace[1830728240] 'applied index is now lower than readState.Index' (duration: 46.572µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:21.970891Z","caller":"traceutil/trace.go:171","msg":"trace[1939726416] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"135.83925ms","start":"2026-07-24T17:32:21.835016Z","end":"2026-07-24T17:32:21.970855Z","steps":["trace[1939726416] 'process raft request' (duration: 135.632394ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:21.970997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.932439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4tb29\" ","response":"range_response_count:1 size:17524"} {"level":"info","ts":"2026-07-24T17:32:21.971082Z","caller":"traceutil/trace.go:171","msg":"trace[589331978] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4tb29; range_end:; response_count:1; response_revision:698; }","duration":"126.037191ms","start":"2026-07-24T17:32:21.845003Z","end":"2026-07-24T17:32:21.97104Z","steps":["trace[589331978] 'agreement among raft nodes before linearized reading' (duration: 125.852897ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:23.071208Z","caller":"traceutil/trace.go:171","msg":"trace[2026888392] linearizableReadLoop","detail":"{readStateIndex:735; appliedIndex:734; }","duration":"178.589412ms","start":"2026-07-24T17:32:22.892585Z","end":"2026-07-24T17:32:23.071174Z","steps":["trace[2026888392] 'read index received' (duration: 129.971875ms)","trace[2026888392] 'applied index is now lower than readState.Index' (duration: 48.615957ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:23.071667Z","caller":"traceutil/trace.go:171","msg":"trace[980165727] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"188.250555ms","start":"2026-07-24T17:32:22.883378Z","end":"2026-07-24T17:32:23.071629Z","steps":["trace[980165727] 'process raft request' (duration: 139.169746ms)","trace[980165727] 'compare' (duration: 48.447123ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:23.071735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.122716ms","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-07-24T17:32:23.071857Z","caller":"traceutil/trace.go:171","msg":"trace[1400319934] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:716; }","duration":"179.27065ms","start":"2026-07-24T17:32:22.892544Z","end":"2026-07-24T17:32:23.071815Z","steps":["trace[1400319934] 'agreement among raft nodes before linearized reading' (duration: 178.903971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:23.072895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.544529ms","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-07-24T17:32:23.072953Z","caller":"traceutil/trace.go:171","msg":"trace[1944157284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:717; }","duration":"173.652202ms","start":"2026-07-24T17:32:22.899288Z","end":"2026-07-24T17:32:23.07294Z","steps":["trace[1944157284] 'agreement among raft nodes before linearized reading' (duration: 173.470876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:23.073145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.593705ms","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-07-24T17:32:23.073207Z","caller":"traceutil/trace.go:171","msg":"trace[847042164] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"179.568947ms","start":"2026-07-24T17:32:22.893605Z","end":"2026-07-24T17:32:23.073174Z","steps":["trace[847042164] 'process raft request' (duration: 179.030942ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:23.073304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.720074ms","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-07-24T17:32:23.07344Z","caller":"traceutil/trace.go:171","msg":"trace[271569147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:717; }","duration":"173.830026ms","start":"2026-07-24T17:32:22.899533Z","end":"2026-07-24T17:32:23.073363Z","steps":["trace[271569147] 'agreement among raft nodes before linearized reading' (duration: 173.663572ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:23.073222Z","caller":"traceutil/trace.go:171","msg":"trace[692696797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:717; }","duration":"169.690337ms","start":"2026-07-24T17:32:22.903516Z","end":"2026-07-24T17:32:23.073206Z","steps":["trace[692696797] 'agreement among raft nodes before linearized reading' (duration: 169.512013ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:31.292732Z","caller":"traceutil/trace.go:171","msg":"trace[560236175] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"353.257821ms","start":"2026-07-24T17:32:30.939446Z","end":"2026-07-24T17:32:31.292704Z","steps":["trace[560236175] 'process raft request' (duration: 352.675936ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:31.292849Z","caller":"traceutil/trace.go:171","msg":"trace[1056121130] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:809; }","duration":"327.604387ms","start":"2026-07-24T17:32:30.965209Z","end":"2026-07-24T17:32:31.292813Z","steps":["trace[1056121130] 'read index received' (duration: 326.836377ms)","trace[1056121130] 'applied index is now lower than readState.Index' (duration: 763.91µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:31.292894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:30.939433Z","time spent":"353.379785ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4854,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:32:31.293041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.836174ms","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-07-24T17:32:31.293073Z","caller":"traceutil/trace.go:171","msg":"trace[1814291028] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"327.898394ms","start":"2026-07-24T17:32:30.965166Z","end":"2026-07-24T17:32:31.293065Z","steps":["trace[1814291028] 'agreement among raft nodes before linearized reading' (duration: 327.768131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:31.293093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:30.965153Z","time spent":"327.936166ms","remote":"127.0.0.1:38230","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-07-24T17:32:31.293276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.867222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-24T17:32:31.293339Z","caller":"traceutil/trace.go:171","msg":"trace[157966410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:787; }","duration":"180.979786ms","start":"2026-07-24T17:32:31.112343Z","end":"2026-07-24T17:32:31.293322Z","steps":["trace[157966410] 'agreement among raft nodes before linearized reading' (duration: 180.77773ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:31.293543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.697069ms","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-07-24T17:32:31.293568Z","caller":"traceutil/trace.go:171","msg":"trace[528725524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:787; }","duration":"177.72139ms","start":"2026-07-24T17:32:31.11584Z","end":"2026-07-24T17:32:31.293561Z","steps":["trace[528725524] 'agreement among raft nodes before linearized reading' (duration: 177.655808ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:31.293678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.631538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-24T17:32:31.293751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.579099ms","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-07-24T17:32:31.293807Z","caller":"traceutil/trace.go:171","msg":"trace[1768234501] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:787; }","duration":"176.668521ms","start":"2026-07-24T17:32:31.117123Z","end":"2026-07-24T17:32:31.293791Z","steps":["trace[1768234501] 'agreement among raft nodes before linearized reading' (duration: 176.522758ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:31.293806Z","caller":"traceutil/trace.go:171","msg":"trace[1392434934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:787; }","duration":"174.807033ms","start":"2026-07-24T17:32:31.118968Z","end":"2026-07-24T17:32:31.293775Z","steps":["trace[1392434934] 'agreement among raft nodes before linearized reading' (duration: 174.470405ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:33.882822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.477252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:32:33.882977Z","caller":"traceutil/trace.go:171","msg":"trace[1168494642] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:811; }","duration":"239.683658ms","start":"2026-07-24T17:32:33.64327Z","end":"2026-07-24T17:32:33.882954Z","steps":["trace[1168494642] 'range keys from in-memory index tree' (duration: 239.389999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:34.733641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103924144123757,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T17:32:34.818918Z","caller":"traceutil/trace.go:171","msg":"trace[785254393] linearizableReadLoop","detail":"{readStateIndex:835; appliedIndex:834; }","duration":"585.623595ms","start":"2026-07-24T17:32:34.233216Z","end":"2026-07-24T17:32:34.818839Z","steps":["trace[785254393] 'read index received' (duration: 585.359189ms)","trace[785254393] 'applied index is now lower than readState.Index' (duration: 263.596µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:34.819068Z","caller":"traceutil/trace.go:171","msg":"trace[106368497] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"884.431597ms","start":"2026-07-24T17:32:33.934602Z","end":"2026-07-24T17:32:34.819034Z","steps":["trace[106368497] 'process raft request' (duration: 884.060807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:34.819153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.626578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:32:34.819165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.903433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:32:34.819197Z","caller":"traceutil/trace.go:171","msg":"trace[980860871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:812; }","duration":"174.725551ms","start":"2026-07-24T17:32:34.644458Z","end":"2026-07-24T17:32:34.819184Z","steps":["trace[980860871] 'agreement among raft nodes before linearized reading' (duration: 174.625398ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:34.819228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:33.934581Z","time spent":"884.57311ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:32:34.819248Z","caller":"traceutil/trace.go:171","msg":"trace[770285115] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:812; }","duration":"586.043507ms","start":"2026-07-24T17:32:34.233181Z","end":"2026-07-24T17:32:34.819224Z","steps":["trace[770285115] 'agreement among raft nodes before linearized reading' (duration: 585.888053ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:34.819294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:32:34.233161Z","time spent":"586.121519ms","remote":"127.0.0.1:38412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":29,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-07-24T17:32:43.150186Z","caller":"traceutil/trace.go:171","msg":"trace[466171025] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"172.576106ms","start":"2026-07-24T17:32:42.977592Z","end":"2026-07-24T17:32:43.150168Z","steps":["trace[466171025] 'process raft request' (duration: 172.454682ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.400447Z","caller":"traceutil/trace.go:171","msg":"trace[589559384] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"167.997575ms","start":"2026-07-24T17:32:43.232425Z","end":"2026-07-24T17:32:43.400422Z","steps":["trace[589559384] 'process raft request' (duration: 167.927243ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.400487Z","caller":"traceutil/trace.go:171","msg":"trace[1008758404] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"171.755103ms","start":"2026-07-24T17:32:43.228684Z","end":"2026-07-24T17:32:43.400439Z","steps":["trace[1008758404] 'process raft request' (duration: 145.858822ms)","trace[1008758404] 'compare' (duration: 25.620194ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:43.411595Z","caller":"traceutil/trace.go:171","msg":"trace[1651859249] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"149.288304ms","start":"2026-07-24T17:32:43.262275Z","end":"2026-07-24T17:32:43.411564Z","steps":["trace[1651859249] 'process raft request' (duration: 149.162931ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.583322Z","caller":"traceutil/trace.go:171","msg":"trace[122067306] linearizableReadLoop","detail":"{readStateIndex:939; appliedIndex:938; }","duration":"171.753563ms","start":"2026-07-24T17:32:43.411543Z","end":"2026-07-24T17:32:43.583297Z","steps":["trace[122067306] 'read index received' (duration: 102.651178ms)","trace[122067306] 'applied index is now lower than readState.Index' (duration: 69.101455ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:32:43.583348Z","caller":"traceutil/trace.go:171","msg":"trace[1817605129] transaction","detail":"{read_only:false; response_revision:914; number_of_response:1; }","duration":"173.358914ms","start":"2026-07-24T17:32:43.409957Z","end":"2026-07-24T17:32:43.583316Z","steps":["trace[1817605129] 'process raft request' (duration: 104.139895ms)","trace[1817605129] 'compare' (duration: 69.096006ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:32:43.583541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.509269ms","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-07-24T17:32:43.583519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.912305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-24T17:32:43.583541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.315596ms","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-07-24T17:32:43.583527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.721474ms","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-07-24T17:32:43.583588Z","caller":"traceutil/trace.go:171","msg":"trace[907313976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:914; }","duration":"224.377397ms","start":"2026-07-24T17:32:43.359199Z","end":"2026-07-24T17:32:43.583576Z","steps":["trace[907313976] 'agreement among raft nodes before linearized reading' (duration: 224.219542ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.583592Z","caller":"traceutil/trace.go:171","msg":"trace[1575397999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:914; }","duration":"224.033308ms","start":"2026-07-24T17:32:43.359539Z","end":"2026-07-24T17:32:43.583572Z","steps":["trace[1575397999] 'agreement among raft nodes before linearized reading' (duration: 223.814701ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.583614Z","caller":"traceutil/trace.go:171","msg":"trace[1523501951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:914; }","duration":"219.838297ms","start":"2026-07-24T17:32:43.363754Z","end":"2026-07-24T17:32:43.583592Z","steps":["trace[1523501951] 'agreement among raft nodes before linearized reading' (duration: 219.59439ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.583569Z","caller":"traceutil/trace.go:171","msg":"trace[107561518] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:914; }","duration":"219.559561ms","start":"2026-07-24T17:32:43.364002Z","end":"2026-07-24T17:32:43.583562Z","steps":["trace[107561518] 'agreement among raft nodes before linearized reading' (duration: 219.465748ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.583927Z","caller":"traceutil/trace.go:171","msg":"trace[1936585612] transaction","detail":"{read_only:false; response_revision:915; number_of_response:1; }","duration":"167.787509ms","start":"2026-07-24T17:32:43.416121Z","end":"2026-07-24T17:32:43.583908Z","steps":["trace[1936585612] 'process raft request' (duration: 167.632265ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.584032Z","caller":"traceutil/trace.go:171","msg":"trace[773302241] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"167.84849ms","start":"2026-07-24T17:32:43.416172Z","end":"2026-07-24T17:32:43.58402Z","steps":["trace[773302241] 'process raft request' (duration: 167.690546ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.584215Z","caller":"traceutil/trace.go:171","msg":"trace[2109854762] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"167.622506ms","start":"2026-07-24T17:32:43.416582Z","end":"2026-07-24T17:32:43.584204Z","steps":["trace[2109854762] 'process raft request' (duration: 167.391719ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.584257Z","caller":"traceutil/trace.go:171","msg":"trace[383802000] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"166.538846ms","start":"2026-07-24T17:32:43.417705Z","end":"2026-07-24T17:32:43.584244Z","steps":["trace[383802000] 'process raft request' (duration: 166.424753ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.584301Z","caller":"traceutil/trace.go:171","msg":"trace[1492791928] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"166.340222ms","start":"2026-07-24T17:32:43.417948Z","end":"2026-07-24T17:32:43.584288Z","steps":["trace[1492791928] 'process raft request' (duration: 166.225229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:32:43.584458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.250701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-fv5fs\" ","response":"range_response_count:1 size:4881"} {"level":"info","ts":"2026-07-24T17:32:43.584501Z","caller":"traceutil/trace.go:171","msg":"trace[1804573919] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-fv5fs; range_end:; response_count:1; response_revision:921; }","duration":"168.350424ms","start":"2026-07-24T17:32:43.416138Z","end":"2026-07-24T17:32:43.584488Z","steps":["trace[1804573919] 'agreement among raft nodes before linearized reading' (duration: 168.174079ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:32:43.584529Z","caller":"traceutil/trace.go:171","msg":"trace[120249486] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"165.149369ms","start":"2026-07-24T17:32:43.419367Z","end":"2026-07-24T17:32:43.584516Z","steps":["trace[120249486] 'process raft request' (duration: 164.851912ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:03.776559Z","caller":"traceutil/trace.go:171","msg":"trace[2132722001] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1029; }","duration":"100.261924ms","start":"2026-07-24T17:33:03.676276Z","end":"2026-07-24T17:33:03.776538Z","steps":["trace[2132722001] 'read index received' (duration: 100.07659ms)","trace[2132722001] 'applied index is now lower than readState.Index' (duration: 184.594µs)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:33:03.776966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.668634ms","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-07-24T17:33:03.777051Z","caller":"traceutil/trace.go:171","msg":"trace[1463755670] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1000; }","duration":"100.774388ms","start":"2026-07-24T17:33:03.676249Z","end":"2026-07-24T17:33:03.777023Z","steps":["trace[1463755670] 'agreement among raft nodes before linearized reading' (duration: 100.49185ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:03.777206Z","caller":"traceutil/trace.go:171","msg":"trace[2129150871] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"102.119583ms","start":"2026-07-24T17:33:03.675065Z","end":"2026-07-24T17:33:03.777184Z","steps":["trace[2129150871] 'process raft request' (duration: 101.344033ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:09.975818Z","caller":"traceutil/trace.go:171","msg":"trace[1443709710] linearizableReadLoop","detail":"{readStateIndex:1053; appliedIndex:1052; }","duration":"175.817339ms","start":"2026-07-24T17:33:09.799983Z","end":"2026-07-24T17:33:09.9758Z","steps":["trace[1443709710] 'read index received' (duration: 175.635364ms)","trace[1443709710] 'applied index is now lower than readState.Index' (duration: 181.125µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:33:09.975872Z","caller":"traceutil/trace.go:171","msg":"trace[1027255250] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"687.735062ms","start":"2026-07-24T17:33:09.288102Z","end":"2026-07-24T17:33:09.975837Z","steps":["trace[1027255250] 'process raft request' (duration: 687.580999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:09.976011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:09.28808Z","time spent":"687.858786ms","remote":"127.0.0.1:38230","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-07-24T17:33:09.976046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.947206ms","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-07-24T17:33:09.976048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.121776ms","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-07-24T17:33:09.976085Z","caller":"traceutil/trace.go:171","msg":"trace[687959716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1022; }","duration":"170.021638ms","start":"2026-07-24T17:33:09.806052Z","end":"2026-07-24T17:33:09.976074Z","steps":["trace[687959716] 'agreement among raft nodes before linearized reading' (duration: 169.862334ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:09.976101Z","caller":"traceutil/trace.go:171","msg":"trace[1353533679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1022; }","duration":"163.190199ms","start":"2026-07-24T17:33:09.812894Z","end":"2026-07-24T17:33:09.976084Z","steps":["trace[1353533679] 'agreement among raft nodes before linearized reading' (duration: 163.039375ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:09.97613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.089665ms","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-07-24T17:33:09.976176Z","caller":"traceutil/trace.go:171","msg":"trace[1164934962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1022; }","duration":"163.146997ms","start":"2026-07-24T17:33:09.813009Z","end":"2026-07-24T17:33:09.976156Z","steps":["trace[1164934962] 'agreement among raft nodes before linearized reading' (duration: 162.952442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:09.976177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.231288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-24T17:33:09.976211Z","caller":"traceutil/trace.go:171","msg":"trace[1142075848] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1022; }","duration":"158.278579ms","start":"2026-07-24T17:33:09.817925Z","end":"2026-07-24T17:33:09.976203Z","steps":["trace[1142075848] 'agreement among raft nodes before linearized reading' (duration: 158.004153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:09.976229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.430814ms","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-07-24T17:33:09.976329Z","caller":"traceutil/trace.go:171","msg":"trace[541535378] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"163.567078ms","start":"2026-07-24T17:33:09.812736Z","end":"2026-07-24T17:33:09.976303Z","steps":["trace[541535378] 'agreement among raft nodes before linearized reading' (duration: 163.219479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:09.976342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.353295ms","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-07-24T17:33:09.976413Z","caller":"traceutil/trace.go:171","msg":"trace[1005866904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"176.436356ms","start":"2026-07-24T17:33:09.799944Z","end":"2026-07-24T17:33:09.97638Z","steps":["trace[1005866904] 'agreement among raft nodes before linearized reading' (duration: 175.947003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.623495Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15276103924144124464,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-24T17:33:34.707497Z","caller":"traceutil/trace.go:171","msg":"trace[545346754] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"584.774796ms","start":"2026-07-24T17:33:34.122698Z","end":"2026-07-24T17:33:34.707473Z","steps":["trace[545346754] 'read index received' (duration: 584.579491ms)","trace[545346754] 'applied index is now lower than readState.Index' (duration: 194.295µs)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:33:34.707537Z","caller":"traceutil/trace.go:171","msg":"trace[2128859789] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"654.513119ms","start":"2026-07-24T17:33:34.052993Z","end":"2026-07-24T17:33:34.707506Z","steps":["trace[2128859789] 'process raft request' (duration: 654.345655ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.707712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.895607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-24T17:33:34.707814Z","caller":"traceutil/trace.go:171","msg":"trace[793206928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1102; }","duration":"532.069451ms","start":"2026-07-24T17:33:34.175734Z","end":"2026-07-24T17:33:34.707803Z","steps":["trace[793206928] 'agreement among raft nodes before linearized reading' (duration: 531.876537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.707941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.175704Z","time spent":"532.201366ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T17:33:34.707948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.270242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-24T17:33:34.707716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.011369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:33:34.707995Z","caller":"traceutil/trace.go:171","msg":"trace[1708248070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"520.335394ms","start":"2026-07-24T17:33:34.187649Z","end":"2026-07-24T17:33:34.707984Z","steps":["trace[1708248070] 'agreement among raft nodes before linearized reading' (duration: 520.253562ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:34.708013Z","caller":"traceutil/trace.go:171","msg":"trace[1862407935] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1102; }","duration":"419.463552ms","start":"2026-07-24T17:33:34.288534Z","end":"2026-07-24T17:33:34.707998Z","steps":["trace[1862407935] 'agreement among raft nodes before linearized reading' (duration: 419.080552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.707766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.351426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-24T17:33:34.708072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.288505Z","time spent":"419.550386ms","remote":"127.0.0.1:38294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":16,"response size":29,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-07-24T17:33:34.708098Z","caller":"traceutil/trace.go:171","msg":"trace[1726377575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"519.712777ms","start":"2026-07-24T17:33:34.188375Z","end":"2026-07-24T17:33:34.708088Z","steps":["trace[1726377575] 'agreement among raft nodes before linearized reading' (duration: 519.263095ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.70785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.69692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-24T17:33:34.708128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.188367Z","time spent":"519.751508ms","remote":"127.0.0.1:38230","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-07-24T17:33:34.708151Z","caller":"traceutil/trace.go:171","msg":"trace[2467559] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1102; }","duration":"516.010489ms","start":"2026-07-24T17:33:34.192131Z","end":"2026-07-24T17:33:34.708141Z","steps":["trace[2467559] 'agreement among raft nodes before linearized reading' (duration: 515.663849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.708028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.187637Z","time spent":"520.381965ms","remote":"127.0.0.1:38230","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":"warn","ts":"2026-07-24T17:33:34.708182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.192123Z","time spent":"516.051731ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-24T17:33:34.707713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.010282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-24T17:33:34.708235Z","caller":"traceutil/trace.go:171","msg":"trace[456089795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1102; }","duration":"585.608938ms","start":"2026-07-24T17:33:34.122619Z","end":"2026-07-24T17:33:34.708228Z","steps":["trace[456089795] 'agreement among raft nodes before linearized reading' (duration: 584.963521ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:34.708263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.122587Z","time spent":"585.669259ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-24T17:33:34.708399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:34.05297Z","time spent":"654.637682ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:33:34.911641Z","caller":"traceutil/trace.go:171","msg":"trace[621878664] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"199.430111ms","start":"2026-07-24T17:33:34.712182Z","end":"2026-07-24T17:33:34.911612Z","steps":["trace[621878664] 'process raft request' (duration: 193.34037ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:34.939564Z","caller":"traceutil/trace.go:171","msg":"trace[1104264795] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"226.580573ms","start":"2026-07-24T17:33:34.712957Z","end":"2026-07-24T17:33:34.939538Z","steps":["trace[1104264795] 'process raft request' (duration: 226.386778ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:34.93989Z","caller":"traceutil/trace.go:171","msg":"trace[2139462777] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"226.847171ms","start":"2026-07-24T17:33:34.713015Z","end":"2026-07-24T17:33:34.939862Z","steps":["trace[2139462777] 'process raft request' (duration: 226.47061ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:34.940221Z","caller":"traceutil/trace.go:171","msg":"trace[531300822] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"226.915582ms","start":"2026-07-24T17:33:34.71329Z","end":"2026-07-24T17:33:34.940206Z","steps":["trace[531300822] 'process raft request' (duration: 226.866011ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:33:34.940383Z","caller":"traceutil/trace.go:171","msg":"trace[1792317311] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"227.160229ms","start":"2026-07-24T17:33:34.713208Z","end":"2026-07-24T17:33:34.940368Z","steps":["trace[1792317311] 'process raft request' (duration: 226.560753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.413902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.504329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:33:51.413971Z","caller":"traceutil/trace.go:171","msg":"trace[1904567068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1206; }","duration":"594.611141ms","start":"2026-07-24T17:33:50.819347Z","end":"2026-07-24T17:33:51.413958Z","steps":["trace[1904567068] 'range keys from in-memory index tree' (duration: 594.446537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:50.81933Z","time spent":"594.662593ms","remote":"127.0.0.1:37960","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-07-24T17:33:51.414203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.362914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:33:51.414228Z","caller":"traceutil/trace.go:171","msg":"trace[953734798] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1206; }","duration":"535.423466ms","start":"2026-07-24T17:33:50.878795Z","end":"2026-07-24T17:33:51.414219Z","steps":["trace[953734798] 'count revisions from in-memory index tree' (duration: 535.273452ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.414248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:50.878775Z","time spent":"535.467488ms","remote":"127.0.0.1:35850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-24T17:33:51.414413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.697358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-24T17:33:51.41445Z","caller":"traceutil/trace.go:171","msg":"trace[1607954878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1206; }","duration":"381.746189ms","start":"2026-07-24T17:33:51.032682Z","end":"2026-07-24T17:33:51.414428Z","steps":["trace[1607954878] 'range keys from in-memory index tree' (duration: 381.565455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.41447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:51.032664Z","time spent":"381.802012ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-24T17:33:51.41448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.084974ms","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-07-24T17:33:51.415205Z","caller":"traceutil/trace.go:171","msg":"trace[2090965796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1206; }","duration":"386.225598ms","start":"2026-07-24T17:33:51.028319Z","end":"2026-07-24T17:33:51.414544Z","steps":["trace[2090965796] 'range keys from in-memory index tree' (duration: 385.893209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.415261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:51.028298Z","time spent":"386.949887ms","remote":"127.0.0.1:38230","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":"warn","ts":"2026-07-24T17:33:51.415689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.540554ms","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-07-24T17:33:51.415715Z","caller":"traceutil/trace.go:171","msg":"trace[1525320900] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1206; }","duration":"435.607646ms","start":"2026-07-24T17:33:50.980101Z","end":"2026-07-24T17:33:51.415708Z","steps":["trace[1525320900] 'range keys from in-memory index tree' (duration: 435.43038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.415741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:50.980076Z","time spent":"435.660067ms","remote":"127.0.0.1:38230","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-07-24T17:33:51.415755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.807388ms","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-07-24T17:33:51.415798Z","caller":"traceutil/trace.go:171","msg":"trace[1155002341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1206; }","duration":"406.88051ms","start":"2026-07-24T17:33:51.008907Z","end":"2026-07-24T17:33:51.415787Z","steps":["trace[1155002341] 'range keys from in-memory index tree' (duration: 406.627534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.415833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:51.008886Z","time spent":"406.936501ms","remote":"127.0.0.1:38230","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-07-24T17:33:51.416017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.898294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-24T17:33:51.416046Z","caller":"traceutil/trace.go:171","msg":"trace[263992262] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1206; }","duration":"402.957266ms","start":"2026-07-24T17:33:51.01308Z","end":"2026-07-24T17:33:51.416037Z","steps":["trace[263992262] 'range keys from in-memory index tree' (duration: 402.797652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:33:51.416075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:33:51.013039Z","time spent":"403.028989ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-24T17:33:59.961345Z","caller":"traceutil/trace.go:171","msg":"trace[339912290] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"109.559658ms","start":"2026-07-24T17:33:59.851763Z","end":"2026-07-24T17:33:59.961323Z","steps":["trace[339912290] 'process raft request' (duration: 103.825168ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:01.939691Z","caller":"traceutil/trace.go:171","msg":"trace[1945276965] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"368.896962ms","start":"2026-07-24T17:34:01.570768Z","end":"2026-07-24T17:34:01.939665Z","steps":["trace[1945276965] 'process raft request' (duration: 284.327339ms)","trace[1945276965] 'compare' (duration: 84.44984ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:01.939811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:01.570754Z","time spent":"369.000005ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:01.939893Z","caller":"traceutil/trace.go:171","msg":"trace[1915035411] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"368.478311ms","start":"2026-07-24T17:34:01.571394Z","end":"2026-07-24T17:34:01.939872Z","steps":["trace[1915035411] 'process raft request' (duration: 368.239115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:01.940003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:01.571386Z","time spent":"368.555582ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:01.940249Z","caller":"traceutil/trace.go:171","msg":"trace[1328496005] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"366.19481ms","start":"2026-07-24T17:34:01.574027Z","end":"2026-07-24T17:34:01.940222Z","steps":["trace[1328496005] 'process raft request' (duration: 365.787379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:01.940375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:01.574014Z","time spent":"366.298194ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:02.942872Z","caller":"traceutil/trace.go:171","msg":"trace[1437551550] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"134.900685ms","start":"2026-07-24T17:34:02.807939Z","end":"2026-07-24T17:34:02.94284Z","steps":["trace[1437551550] 'process raft request' (duration: 134.758001ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:08.097265Z","caller":"traceutil/trace.go:171","msg":"trace[1162006590] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"115.172325ms","start":"2026-07-24T17:34:07.982067Z","end":"2026-07-24T17:34:08.09724Z","steps":["trace[1162006590] 'process raft request' (duration: 115.011241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:08.797539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.701433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:34:08.7977Z","caller":"traceutil/trace.go:171","msg":"trace[1490556746] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"813.931635ms","start":"2026-07-24T17:34:07.983751Z","end":"2026-07-24T17:34:08.797682Z","steps":["trace[1490556746] 'process raft request' (duration: 813.872223ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:08.797781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:07.983741Z","time spent":"814.009537ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:08.797953Z","caller":"traceutil/trace.go:171","msg":"trace[326028578] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"815.425813ms","start":"2026-07-24T17:34:07.982511Z","end":"2026-07-24T17:34:08.797937Z","steps":["trace[326028578] 'process raft request' (duration: 394.240537ms)","trace[326028578] 'compare' (duration: 420.55951ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:08.798006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:07.982498Z","time spent":"815.478465ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:09.508569Z","caller":"traceutil/trace.go:171","msg":"trace[211779821] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"251.95228ms","start":"2026-07-24T17:34:09.256586Z","end":"2026-07-24T17:34:09.508538Z","steps":["trace[211779821] 'process raft request' (duration: 251.798956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.08304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.537695ms","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-07-24T17:34:10.083116Z","caller":"traceutil/trace.go:171","msg":"trace[1549708704] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1286; }","duration":"480.663688ms","start":"2026-07-24T17:34:09.602435Z","end":"2026-07-24T17:34:10.083099Z","steps":["trace[1549708704] 'range keys from in-memory index tree' (duration: 480.304138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.08317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:09.602412Z","time spent":"480.738001ms","remote":"127.0.0.1:38230","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-07-24T17:34:10.083394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.063036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:34:10.083458Z","caller":"traceutil/trace.go:171","msg":"trace[370766491] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1286; }","duration":"149.173099ms","start":"2026-07-24T17:34:09.934267Z","end":"2026-07-24T17:34:10.08344Z","steps":["trace[370766491] 'count revisions from in-memory index tree' (duration: 148.923633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.083468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.227436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-24T17:34:10.083486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.119316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:34:10.083525Z","caller":"traceutil/trace.go:171","msg":"trace[56464886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1286; }","duration":"475.331979ms","start":"2026-07-24T17:34:09.608179Z","end":"2026-07-24T17:34:10.083511Z","steps":["trace[56464886] 'range keys from in-memory index tree' (duration: 475.05628ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:10.083544Z","caller":"traceutil/trace.go:171","msg":"trace[1937251043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"439.225439ms","start":"2026-07-24T17:34:09.644304Z","end":"2026-07-24T17:34:10.083529Z","steps":["trace[1937251043] 'range keys from in-memory index tree' (duration: 439.032334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.083556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:09.608131Z","time spent":"475.418591ms","remote":"127.0.0.1:38230","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-07-24T17:34:10.083573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:09.644283Z","time spent":"439.284621ms","remote":"127.0.0.1:37960","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-07-24T17:34:10.083587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.757016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-24T17:34:10.083624Z","caller":"traceutil/trace.go:171","msg":"trace[439405487] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:1286; }","duration":"261.826269ms","start":"2026-07-24T17:34:09.821786Z","end":"2026-07-24T17:34:10.083612Z","steps":["trace[439405487] 'range keys from in-memory index tree' (duration: 261.618063ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.406275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:10.084549Z","time spent":"321.722662ms","remote":"127.0.0.1:38020","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-24T17:34:10.866957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.417241ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:34:10.867538Z","caller":"traceutil/trace.go:171","msg":"trace[2042795398] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"780.401603ms","start":"2026-07-24T17:34:10.087067Z","end":"2026-07-24T17:34:10.867468Z","steps":["trace[2042795398] 'process raft request' (duration: 527.381266ms)","trace[2042795398] 'compare' (duration: 252.162745ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:34:10.867642Z","caller":"traceutil/trace.go:171","msg":"trace[1949453262] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"450.402282ms","start":"2026-07-24T17:34:10.417222Z","end":"2026-07-24T17:34:10.867624Z","steps":["trace[1949453262] 'process raft request' (duration: 450.342091ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:10.867707Z","caller":"traceutil/trace.go:171","msg":"trace[1727690906] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"779.806138ms","start":"2026-07-24T17:34:10.087843Z","end":"2026-07-24T17:34:10.867649Z","steps":["trace[1727690906] 'process raft request' (duration: 779.206083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.867744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:10.087041Z","time spent":"780.601759ms","remote":"127.0.0.1:38230","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-07-24T17:34:10.867796Z","caller":"traceutil/trace.go:171","msg":"trace[286668836] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1332; }","duration":"765.195523ms","start":"2026-07-24T17:34:10.102589Z","end":"2026-07-24T17:34:10.867784Z","steps":["trace[286668836] 'read index received' (duration: 303.694958ms)","trace[286668836] 'applied index is now lower than readState.Index' (duration: 461.499355ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:10.867928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:10.087833Z","time spent":"779.971353ms","remote":"127.0.0.1:38230","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-07-24T17:34:10.86801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.42748ms","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-07-24T17:34:10.86805Z","caller":"traceutil/trace.go:171","msg":"trace[1757859191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1289; }","duration":"765.505543ms","start":"2026-07-24T17:34:10.102535Z","end":"2026-07-24T17:34:10.86804Z","steps":["trace[1757859191] 'agreement among raft nodes before linearized reading' (duration: 765.336208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:10.868085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:10.102513Z","time spent":"765.564754ms","remote":"127.0.0.1:38230","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-07-24T17:34:10.867747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:10.417201Z","time spent":"450.495305ms","remote":"127.0.0.1:38020","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-07-24T17:34:11.189905Z","caller":"traceutil/trace.go:171","msg":"trace[259092993] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"202.680246ms","start":"2026-07-24T17:34:10.987203Z","end":"2026-07-24T17:34:11.189883Z","steps":["trace[259092993] 'process raft request' (duration: 202.544911ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:11.657944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.899484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:34:11.658041Z","caller":"traceutil/trace.go:171","msg":"trace[1513477638] linearizableReadLoop","detail":"{readStateIndex:1340; appliedIndex:1339; }","duration":"320.541261ms","start":"2026-07-24T17:34:11.33748Z","end":"2026-07-24T17:34:11.658021Z","steps":["trace[1513477638] 'read index received' (duration: 169.525664ms)","trace[1513477638] 'applied index is now lower than readState.Index' (duration: 151.013327ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:34:11.658126Z","caller":"traceutil/trace.go:171","msg":"trace[1937451651] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"410.053302ms","start":"2026-07-24T17:34:11.248062Z","end":"2026-07-24T17:34:11.658115Z","steps":["trace[1937451651] 'process raft request' (duration: 258.944003ms)","trace[1937451651] 'compare' (duration: 150.606127ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:11.658169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:11.248024Z","time spent":"410.124074ms","remote":"127.0.0.1:38054","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-07-24T17:34:11.658379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.893442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:34:11.658421Z","caller":"traceutil/trace.go:171","msg":"trace[1375775748] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1294; }","duration":"320.965313ms","start":"2026-07-24T17:34:11.337448Z","end":"2026-07-24T17:34:11.658413Z","steps":["trace[1375775748] 'agreement among raft nodes before linearized reading' (duration: 320.877811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:11.658444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:11.337433Z","time spent":"321.004964ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-24T17:34:11.658496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.600562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-24T17:34:11.658543Z","caller":"traceutil/trace.go:171","msg":"trace[1959720297] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1294; }","duration":"288.689455ms","start":"2026-07-24T17:34:11.369845Z","end":"2026-07-24T17:34:11.658534Z","steps":["trace[1959720297] 'agreement among raft nodes before linearized reading' (duration: 288.617153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:11.909819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.726487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:34:11.909882Z","caller":"traceutil/trace.go:171","msg":"trace[716204433] linearizableReadLoop","detail":"{readStateIndex:1342; appliedIndex:1341; }","duration":"227.98768ms","start":"2026-07-24T17:34:11.681885Z","end":"2026-07-24T17:34:11.909873Z","steps":["trace[716204433] 'read index received' (duration: 87.175881ms)","trace[716204433] 'applied index is now lower than readState.Index' (duration: 140.811099ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:11.909976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.102553ms","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-07-24T17:34:11.90999Z","caller":"traceutil/trace.go:171","msg":"trace[1523588515] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1296; }","duration":"228.155015ms","start":"2026-07-24T17:34:11.681829Z","end":"2026-07-24T17:34:11.909984Z","steps":["trace[1523588515] 'agreement among raft nodes before linearized reading' (duration: 228.067603ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:11.910102Z","caller":"traceutil/trace.go:171","msg":"trace[1378081816] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"246.736662ms","start":"2026-07-24T17:34:11.663359Z","end":"2026-07-24T17:34:11.910096Z","steps":["trace[1378081816] 'process raft request' (duration: 105.689656ms)","trace[1378081816] 'compare' (duration: 140.645136ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:34:11.913099Z","caller":"traceutil/trace.go:171","msg":"trace[1218867307] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"227.841957ms","start":"2026-07-24T17:34:11.685234Z","end":"2026-07-24T17:34:11.913076Z","steps":["trace[1218867307] 'process raft request' (duration: 227.730083ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:22.141728Z","caller":"traceutil/trace.go:171","msg":"trace[708111795] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"207.205504ms","start":"2026-07-24T17:34:21.934496Z","end":"2026-07-24T17:34:22.141702Z","steps":["trace[708111795] 'process raft request' (duration: 207.018949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.048363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.642522ms","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-07-24T17:34:23.04847Z","caller":"traceutil/trace.go:171","msg":"trace[844677803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1372; }","duration":"122.778556ms","start":"2026-07-24T17:34:22.925665Z","end":"2026-07-24T17:34:23.048443Z","steps":["trace[844677803] 'range keys from in-memory index tree' (duration: 122.492788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.049023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.899779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-24T17:34:23.049483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.300972ms","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-07-24T17:34:23.049576Z","caller":"traceutil/trace.go:171","msg":"trace[1734858827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1372; }","duration":"128.415594ms","start":"2026-07-24T17:34:22.921142Z","end":"2026-07-24T17:34:23.049558Z","steps":["trace[1734858827] 'range keys from in-memory index tree' (duration: 128.128646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.049843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.291594ms","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-07-24T17:34:23.050627Z","caller":"traceutil/trace.go:171","msg":"trace[142556791] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1372; }","duration":"485.082944ms","start":"2026-07-24T17:34:22.565503Z","end":"2026-07-24T17:34:23.050586Z","steps":["trace[142556791] 'range keys from in-memory index tree' (duration: 484.164ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.049895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.231997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-24T17:34:23.051316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:22.565482Z","time spent":"485.397073ms","remote":"127.0.0.1:38230","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":"info","ts":"2026-07-24T17:34:23.051384Z","caller":"traceutil/trace.go:171","msg":"trace[894880829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1372; }","duration":"406.754377ms","start":"2026-07-24T17:34:22.644597Z","end":"2026-07-24T17:34:23.051352Z","steps":["trace[894880829] 'range keys from in-memory index tree' (duration: 405.159374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.051441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:22.644557Z","time spent":"406.8691ms","remote":"127.0.0.1:37960","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-07-24T17:34:23.049111Z","caller":"traceutil/trace.go:171","msg":"trace[720999479] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1372; }","duration":"732.041153ms","start":"2026-07-24T17:34:22.317051Z","end":"2026-07-24T17:34:23.049092Z","steps":["trace[720999479] 'count revisions from in-memory index tree' (duration: 731.767615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.051612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:22.317027Z","time spent":"734.57145ms","remote":"127.0.0.1:57874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"info","ts":"2026-07-24T17:34:23.378667Z","caller":"traceutil/trace.go:171","msg":"trace[298218905] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"324.389553ms","start":"2026-07-24T17:34:23.054257Z","end":"2026-07-24T17:34:23.378646Z","steps":["trace[298218905] 'process raft request' (duration: 324.25597ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.378857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.054238Z","time spent":"324.553757ms","remote":"127.0.0.1:38230","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-07-24T17:34:23.53352Z","caller":"traceutil/trace.go:171","msg":"trace[946600318] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"464.862684ms","start":"2026-07-24T17:34:23.068629Z","end":"2026-07-24T17:34:23.533492Z","steps":["trace[946600318] 'process raft request' (duration: 438.918382ms)","trace[946600318] 'compare' (duration: 25.791838ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:23.533666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.068589Z","time spent":"465.002147ms","remote":"127.0.0.1:38230","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-07-24T17:34:23.533952Z","caller":"traceutil/trace.go:171","msg":"trace[310318186] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"450.351963ms","start":"2026-07-24T17:34:23.083582Z","end":"2026-07-24T17:34:23.533934Z","steps":["trace[310318186] 'process raft request' (duration: 450.316272ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:23.534037Z","caller":"traceutil/trace.go:171","msg":"trace[1112727481] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1420; }","duration":"391.582709ms","start":"2026-07-24T17:34:23.142443Z","end":"2026-07-24T17:34:23.534026Z","steps":["trace[1112727481] 'read index received' (duration: 236.056223ms)","trace[1112727481] 'applied index is now lower than readState.Index' (duration: 155.525396ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:34:23.534067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.083578Z","time spent":"450.430374ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:23.534156Z","caller":"traceutil/trace.go:171","msg":"trace[1625995215] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"465.366437ms","start":"2026-07-24T17:34:23.068784Z","end":"2026-07-24T17:34:23.534151Z","steps":["trace[1625995215] 'process raft request' (duration: 465.008117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.534179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.728632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-24T17:34:23.534207Z","caller":"traceutil/trace.go:171","msg":"trace[825475131] transaction","detail":"{read_only:false; response_revision:1377; number_of_response:1; }","duration":"450.65374ms","start":"2026-07-24T17:34:23.083548Z","end":"2026-07-24T17:34:23.534201Z","steps":["trace[825475131] 'process raft request' (duration: 450.327282ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:23.534228Z","caller":"traceutil/trace.go:171","msg":"trace[1020549616] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1380; }","duration":"391.818584ms","start":"2026-07-24T17:34:23.142393Z","end":"2026-07-24T17:34:23.534211Z","steps":["trace[1020549616] 'agreement among raft nodes before linearized reading' (duration: 391.681651ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.534247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.08354Z","time spent":"450.691881ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:34:23.534269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.14238Z","time spent":"391.880196ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-24T17:34:23.5343Z","caller":"traceutil/trace.go:171","msg":"trace[1879556690] transaction","detail":"{read_only:false; response_revision:1379; number_of_response:1; }","duration":"450.180328ms","start":"2026-07-24T17:34:23.084114Z","end":"2026-07-24T17:34:23.534295Z","steps":["trace[1879556690] 'process raft request' (duration: 449.798608ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.534327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.084109Z","time spent":"450.205488ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:34:23.53436Z","caller":"traceutil/trace.go:171","msg":"trace[1944781210] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"304.608683ms","start":"2026-07-24T17:34:23.229741Z","end":"2026-07-24T17:34:23.53435Z","steps":["trace[1944781210] 'process raft request' (duration: 304.232854ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:34:23.534381Z","caller":"traceutil/trace.go:171","msg":"trace[2024193833] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"465.666305ms","start":"2026-07-24T17:34:23.068709Z","end":"2026-07-24T17:34:23.534375Z","steps":["trace[2024193833] 'process raft request' (duration: 464.7366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:34:23.534407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.068702Z","time spent":"465.690625ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-24T17:34:23.534188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.068774Z","time spent":"465.396917ms","remote":"127.0.0.1:38230","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-07-24T17:34:23.534423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-24T17:34:23.229718Z","time spent":"304.670114ms","remote":"127.0.0.1:38230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-24T17:35:09.893594Z","caller":"traceutil/trace.go:171","msg":"trace[397268635] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"102.319521ms","start":"2026-07-24T17:35:09.791232Z","end":"2026-07-24T17:35:09.893551Z","steps":["trace[397268635] 'process raft request' (duration: 68.284126ms)","trace[397268635] 'compare' (duration: 33.767757ms)"],"step_count":2} {"level":"info","ts":"2026-07-24T17:35:37.427601Z","caller":"traceutil/trace.go:171","msg":"trace[789493803] transaction","detail":"{read_only:false; response_revision:1714; number_of_response:1; }","duration":"134.555451ms","start":"2026-07-24T17:35:37.293019Z","end":"2026-07-24T17:35:37.427574Z","steps":["trace[789493803] 'process raft request' (duration: 134.378895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-24T17:36:10.288547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.20827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-24T17:36:10.288883Z","caller":"traceutil/trace.go:171","msg":"trace[750251349] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"182.85193ms","start":"2026-07-24T17:36:10.106019Z","end":"2026-07-24T17:36:10.288871Z","steps":["trace[750251349] 'process raft request' (duration: 68.254399ms)","trace[750251349] 'compare' (duration: 113.884372ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:36:10.289099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.127474ms","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-07-24T17:36:10.289166Z","caller":"traceutil/trace.go:171","msg":"trace[120430007] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1867; }","duration":"173.193555ms","start":"2026-07-24T17:36:10.115962Z","end":"2026-07-24T17:36:10.289155Z","steps":["trace[120430007] 'agreement among raft nodes before linearized reading' (duration: 173.054652ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:36:10.289151Z","caller":"traceutil/trace.go:171","msg":"trace[790174944] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"181.551546ms","start":"2026-07-24T17:36:10.107544Z","end":"2026-07-24T17:36:10.289096Z","steps":["trace[790174944] 'process raft request' (duration: 181.249618ms)"],"step_count":1} {"level":"info","ts":"2026-07-24T17:36:10.288843Z","caller":"traceutil/trace.go:171","msg":"trace[241720536] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1935; }","duration":"172.859587ms","start":"2026-07-24T17:36:10.115971Z","end":"2026-07-24T17:36:10.28883Z","steps":["trace[241720536] 'read index received' (duration: 58.310687ms)","trace[241720536] 'applied index is now lower than readState.Index' (duration: 114.5482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-24T17:36:10.289561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.086181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-24T17:36:10.289588Z","caller":"traceutil/trace.go:171","msg":"trace[1595609695] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1867; }","duration":"143.138283ms","start":"2026-07-24T17:36:10.146443Z","end":"2026-07-24T17:36:10.289582Z","steps":["trace[1595609695] 'agreement among raft nodes before linearized reading' (duration: 142.942068ms)"],"step_count":1}